builder: mozilla-beta_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-007 starttime: 1479485655.26 results: success (0) buildid: 20161118040828 builduid: 1aa1d4ab7c794f94a737edcf8e37d62f revision: 11b5acda902f5ecb13ab2d451d36c7a9063f2b26 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-11-18 08:14:15.264720) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-11-18 08:14:15.265182) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-18 08:14:15.265466) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-18 08:14:15.279815) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-18 08:14:15.280084) ========= 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=923d835db2ba3686ebe126b700000192-1479485655.430349-1384074954 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-11-18 08:14:16-- 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% 46.4M=0s 2016-11-18 08:14:16 (46.4 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.098936 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-18 08:14:15.393111) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-18 08:14:15.393432) ========= 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=923d835db2ba3686ebe126b700000192-1479485655.430349-1384074954 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017983 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-18 08:14:15.442836) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-18 08:14:15.443198) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 11b5acda902f5ecb13ab2d451d36c7a9063f2b26 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 11b5acda902f5ecb13ab2d451d36c7a9063f2b26 --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=923d835db2ba3686ebe126b700000192-1479485655.430349-1384074954 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-11-18 08:14:16,472 truncating revision to first 12 chars 2016-11-18 08:14:16,473 Setting DEBUG logging. 2016-11-18 08:14:16,473 attempt 1/10 2016-11-18 08:14:16,473 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/11b5acda902f?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-11-18 08:14:16,771 unpacking tar archive at: mozilla-beta-11b5acda902f/testing/mozharness/ program finished with exit code 0 elapsedTime=0.594380 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-18 08:14:16.053191) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-18 08:14:16.053735) ========= script_repo_revision: 11b5acda902f5ecb13ab2d451d36c7a9063f2b26 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-18 08:14:16.054410) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-18 08:14:16.054872) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-18 08:14:16.066264) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 28 secs) (at 2016-11-18 08:14:16.066723) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Beta', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Beta'] 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=923d835db2ba3686ebe126b700000192-1479485655.430349-1384074954 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 08:14:17 INFO - MultiFileLogger online at 20161118 08:14:17 in /builds/slave/test 08:14:17 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 08:14:17 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:14:17 INFO - {'append_to_log': False, 08:14:17 INFO - 'base_work_dir': '/builds/slave/test', 08:14:17 INFO - 'blob_upload_branch': 'Mozilla-Beta', 08:14:17 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:14:17 INFO - 'branch': 'Mozilla-Beta', 08:14:17 INFO - 'buildbot_json_path': 'buildprops.json', 08:14:17 INFO - 'config_files': ('talos/linux_config.py',), 08:14:17 INFO - 'default_actions': ('clobber', 08:14:17 INFO - 'read-buildbot-config', 08:14:17 INFO - 'download-and-extract', 08:14:17 INFO - 'populate-webroot', 08:14:17 INFO - 'create-virtualenv', 08:14:17 INFO - 'install', 08:14:17 INFO - 'run-tests'), 08:14:17 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:14:17 INFO - 'download_minidump_stackwalk': True, 08:14:17 INFO - 'download_symbols': 'ondemand', 08:14:17 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:14:17 INFO - 'tooltool.py': '/tools/tooltool.py', 08:14:17 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:14:17 INFO - '/tools/misc-python/virtualenv.py')}, 08:14:17 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:14:17 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:14:17 INFO - 'installer_path': 'installer.exe', 08:14:17 INFO - 'log_level': 'info', 08:14:17 INFO - 'log_name': 'talos', 08:14:17 INFO - 'log_to_console': True, 08:14:17 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 08:14:17 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 08:14:17 INFO - 'opt_config_files': (), 08:14:17 INFO - 'pip_index': False, 08:14:17 INFO - 'sps_profile': False, 08:14:17 INFO - 'sps_profile_interval': 0, 08:14:17 INFO - 'suite': 'dromaeojs', 08:14:17 INFO - 'system_bits': '32', 08:14:17 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:14:17 INFO - 'title': 'talos-linux64-ix-007', 08:14:17 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:14:17 INFO - 'use_talos_json': True, 08:14:17 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:14:17 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:14:17 INFO - 'work_dir': 'build'} 08:14:17 INFO - [mozharness: 2016-11-18 16:14:17.194744Z] Running clobber step. 08:14:17 INFO - Running pre-action listener: _resource_record_pre_action 08:14:17 INFO - Running main action method: clobber 08:14:17 INFO - rmtree: /builds/slave/test/build 08:14:17 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:14:18 INFO - Running post-action listener: _resource_record_post_action 08:14:18 INFO - [mozharness: 2016-11-18 16:14:18.174828Z] Finished clobber step (success) 08:14:18 INFO - [mozharness: 2016-11-18 16:14:18.174926Z] Running read-buildbot-config step. 08:14:18 INFO - Running pre-action listener: _resource_record_pre_action 08:14:18 INFO - Running main action method: read_buildbot_config 08:14:18 INFO - Using buildbot properties: 08:14:18 INFO - { 08:14:18 INFO - "project": "", 08:14:18 INFO - "product": "firefox", 08:14:18 INFO - "script_repo_revision": "production", 08:14:18 INFO - "builddir": "mozilla-beta_ubuntu64_hw_test-dromaeojs", 08:14:18 INFO - "repository": "", 08:14:18 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-beta pgo talos dromaeojs", 08:14:18 INFO - "buildid": "20161118040828", 08:14:18 INFO - "pgo_build": "True", 08:14:18 INFO - "basedir": "/builds/slave/test", 08:14:18 INFO - "buildnumber": 19, 08:14:18 INFO - "slavename": "talos-linux64-ix-007", 08:14:18 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 08:14:18 INFO - "platform": "ubuntu64_hw", 08:14:18 INFO - "scheduler": "tests-mozilla-beta-linux64-pgo-talos", 08:14:18 INFO - "branch": "mozilla-beta", 08:14:18 INFO - "repo_path": "releases/mozilla-beta", 08:14:18 INFO - "revision": "11b5acda902f5ecb13ab2d451d36c7a9063f2b26", 08:14:18 INFO - "stage_platform": "linux64-pgo", 08:14:18 INFO - "builduid": "1aa1d4ab7c794f94a737edcf8e37d62f", 08:14:18 INFO - "slavebuilddir": "test" 08:14:18 INFO - } 08:14:18 INFO - Found installer url https://queue.taskcluster.net/v1/task/Ng8QIMzcR6-37ec5joANQQ/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.tar.bz2. 08:14:18 INFO - Running post-action listener: _resource_record_post_action 08:14:18 INFO - [mozharness: 2016-11-18 16:14:18.177374Z] Finished read-buildbot-config step (success) 08:14:18 INFO - [mozharness: 2016-11-18 16:14:18.177463Z] Running download-and-extract step. 08:14:18 INFO - Running pre-action listener: _resource_record_pre_action 08:14:18 INFO - Running main action method: download_and_extract 08:14:18 INFO - mkdir: /builds/slave/test/build/tests 08:14:18 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')]} 08:14:18 INFO - trying https://queue.taskcluster.net/v1/task/Ng8QIMzcR6-37ec5joANQQ/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.test_packages.json 08:14:18 INFO - Downloading https://queue.taskcluster.net/v1/task/Ng8QIMzcR6-37ec5joANQQ/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-51.0.en-US.linux-x86_64.test_packages.json 08:14:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Ng8QIMzcR6-37ec5joANQQ/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-51.0.en-US.linux-x86_64.test_packages.json'}, attempt #1 08:14:18 INFO - Downloaded 1327 bytes. 08:14:18 INFO - Reading from file /builds/slave/test/build/firefox-51.0.en-US.linux-x86_64.test_packages.json 08:14:18 INFO - Using the following test package requirements: 08:14:18 INFO - {u'common': [u'firefox-51.0.en-US.linux-x86_64.common.tests.zip'], 08:14:18 INFO - u'cppunittest': [u'firefox-51.0.en-US.linux-x86_64.common.tests.zip', 08:14:18 INFO - u'firefox-51.0.en-US.linux-x86_64.cppunittest.tests.zip'], 08:14:18 INFO - u'gtest': [u'firefox-51.0.en-US.linux-x86_64.common.tests.zip', 08:14:18 INFO - u'firefox-51.0.en-US.linux-x86_64.gtest.tests.zip'], 08:14:18 INFO - u'jittest': [u'firefox-51.0.en-US.linux-x86_64.common.tests.zip', 08:14:18 INFO - u'jsshell-linux-x86_64.zip'], 08:14:18 INFO - u'mochitest': [u'firefox-51.0.en-US.linux-x86_64.common.tests.zip', 08:14:18 INFO - u'firefox-51.0.en-US.linux-x86_64.mochitest.tests.zip'], 08:14:18 INFO - u'mozbase': [u'firefox-51.0.en-US.linux-x86_64.common.tests.zip'], 08:14:18 INFO - u'reftest': [u'firefox-51.0.en-US.linux-x86_64.common.tests.zip', 08:14:18 INFO - u'firefox-51.0.en-US.linux-x86_64.reftest.tests.zip'], 08:14:18 INFO - u'talos': [u'firefox-51.0.en-US.linux-x86_64.common.tests.zip', 08:14:18 INFO - u'firefox-51.0.en-US.linux-x86_64.talos.tests.zip'], 08:14:18 INFO - u'web-platform': [u'firefox-51.0.en-US.linux-x86_64.common.tests.zip', 08:14:18 INFO - u'firefox-51.0.en-US.linux-x86_64.web-platform.tests.zip'], 08:14:18 INFO - u'xpcshell': [u'firefox-51.0.en-US.linux-x86_64.common.tests.zip', 08:14:18 INFO - u'firefox-51.0.en-US.linux-x86_64.xpcshell.tests.zip']} 08:14:18 INFO - Downloading packages: [u'firefox-51.0.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 08:14:18 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Ng8QIMzcR6-37ec5joANQQ/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.common.tests.zip 08:14:18 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Ng8QIMzcR6-37ec5joANQQ/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 08:14:18 INFO - Fetch https://queue.taskcluster.net/v1/task/Ng8QIMzcR6-37ec5joANQQ/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.common.tests.zip into memory 08:14:19 INFO - Expected file size: 21961641 08:14:23 INFO - Downloading packages: [u'firefox-51.0.en-US.linux-x86_64.common.tests.zip', u'firefox-51.0.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 08:14:23 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Ng8QIMzcR6-37ec5joANQQ/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.common.tests.zip 08:14:23 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Ng8QIMzcR6-37ec5joANQQ/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 08:14:23 INFO - Fetch https://queue.taskcluster.net/v1/task/Ng8QIMzcR6-37ec5joANQQ/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.common.tests.zip into memory 08:14:24 INFO - Expected file size: 21961641 08:14:29 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Ng8QIMzcR6-37ec5joANQQ/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.talos.tests.zip 08:14:29 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Ng8QIMzcR6-37ec5joANQQ/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 08:14:29 INFO - Fetch https://queue.taskcluster.net/v1/task/Ng8QIMzcR6-37ec5joANQQ/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.talos.tests.zip into memory 08:14:29 INFO - Expected file size: 14414089 08:14:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:14:30 INFO - trying https://queue.taskcluster.net/v1/task/Ng8QIMzcR6-37ec5joANQQ/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.tar.bz2 08:14:30 INFO - Downloading https://queue.taskcluster.net/v1/task/Ng8QIMzcR6-37ec5joANQQ/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-51.0.en-US.linux-x86_64.tar.bz2 08:14:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Ng8QIMzcR6-37ec5joANQQ/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-51.0.en-US.linux-x86_64.tar.bz2'}, attempt #1 08:14:31 INFO - Downloaded 56961197 bytes. 08:14:31 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Ng8QIMzcR6-37ec5joANQQ/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.tar.bz2 08:14:31 INFO - mkdir: /builds/slave/test/properties 08:14:31 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:14:31 INFO - Writing to file /builds/slave/test/properties/build_url 08:14:31 INFO - Contents: 08:14:31 INFO - build_url:https://queue.taskcluster.net/v1/task/Ng8QIMzcR6-37ec5joANQQ/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.tar.bz2 08:14:31 INFO - Running post-action listener: _resource_record_post_action 08:14:31 INFO - Running post-action listener: set_extra_try_arguments 08:14:31 INFO - [mozharness: 2016-11-18 16:14:31.829129Z] Finished download-and-extract step (success) 08:14:31 INFO - [mozharness: 2016-11-18 16:14:31.829357Z] Running populate-webroot step. 08:14:31 INFO - Running pre-action listener: _resource_record_pre_action 08:14:31 INFO - Running main action method: populate_webroot 08:14:31 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:14:31 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:14:31 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:14:31 INFO - '--tppagecycles', 08:14:31 INFO - '7'], 08:14:31 INFO - 'tests': ['tsvgm']}}, 08:14:31 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 08:14:31 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:14:31 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 08:14:31 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 08:14:31 INFO - 'tests': ['dromaeo_css', 'kraken']}, 08:14:31 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 08:14:31 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:14:31 INFO - 'talos_options': ['--disable-e10s'], 08:14:31 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:14:31 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:14:31 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:14:31 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:14:31 INFO - 'talos_options': ['--disable-e10s'], 08:14:31 INFO - 'tests': ['damp', 'tps']}, 08:14:31 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:14:31 INFO - 'tests': ['damp', 'tps']}, 08:14:31 INFO - 'g3': {'talos_options': ['--disable-e10s'], 08:14:31 INFO - 'tests': ['dromaeo_dom']}, 08:14:31 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:14:31 INFO - 'g4': {'talos_options': ['--disable-e10s'], 08:14:31 INFO - 'tests': ['basic_compositor_video']}, 08:14:31 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 08:14:31 INFO - 'other': {'talos_options': ['--disable-e10s'], 08:14:31 INFO - 'tests': ['a11yr', 08:14:31 INFO - 'ts_paint', 08:14:31 INFO - 'tpaint', 08:14:31 INFO - 'sessionrestore', 08:14:31 INFO - 'sessionrestore_no_auto_restore', 08:14:31 INFO - 'tabpaint']}, 08:14:31 INFO - 'other-e10s': {'tests': ['a11yr', 08:14:31 INFO - 'ts_paint', 08:14:31 INFO - 'tpaint', 08:14:31 INFO - 'sessionrestore', 08:14:31 INFO - 'sessionrestore_no_auto_restore', 08:14:31 INFO - 'tabpaint']}, 08:14:31 INFO - 'other-e10s_l64': {'tests': ['a11yr', 08:14:31 INFO - 'ts_paint', 08:14:31 INFO - 'tpaint', 08:14:31 INFO - 'sessionrestore', 08:14:31 INFO - 'sessionrestore_no_auto_restore', 08:14:31 INFO - 'tabpaint']}, 08:14:31 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 08:14:31 INFO - 'ts_paint', 08:14:31 INFO - 'tpaint', 08:14:31 INFO - 'sessionrestore', 08:14:31 INFO - 'sessionrestore_no_auto_restore', 08:14:31 INFO - 'tabpaint']}, 08:14:31 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 08:14:31 INFO - 'tests': ['a11yr', 08:14:31 INFO - 'ts_paint', 08:14:31 INFO - 'tpaint', 08:14:31 INFO - 'sessionrestore', 08:14:31 INFO - 'sessionrestore_no_auto_restore', 08:14:31 INFO - 'tabpaint']}, 08:14:31 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 08:14:31 INFO - 'tests': ['a11yr', 08:14:31 INFO - 'ts_paint', 08:14:31 INFO - 'tpaint', 08:14:31 INFO - 'sessionrestore', 08:14:31 INFO - 'sessionrestore_no_auto_restore', 08:14:31 INFO - 'tabpaint']}, 08:14:31 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 08:14:31 INFO - 'tests': ['tsvgx', 08:14:31 INFO - 'tsvgr_opacity', 08:14:31 INFO - 'tart', 08:14:31 INFO - 'tscrollx', 08:14:31 INFO - 'cart']}, 08:14:31 INFO - 'svgr-e10s': {'tests': ['tsvgx', 08:14:31 INFO - 'tsvgr_opacity', 08:14:31 INFO - 'tart', 08:14:31 INFO - 'tscrollx', 08:14:31 INFO - 'cart']}, 08:14:31 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:14:31 INFO - 'talos_options': ['--disable-e10s'], 08:14:31 INFO - 'tests': ['tp5o']}, 08:14:31 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:14:31 INFO - 'tests': ['tp5o']}, 08:14:31 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:14:31 INFO - 'talos_options': ['--disable-e10s', 08:14:31 INFO - '--xperf_path', 08:14:31 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:14:31 INFO - 'tests': ['tp5n']}, 08:14:31 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:14:31 INFO - 'talos_options': ['--xperf_path', 08:14:31 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:14:31 INFO - 'tests': ['tp5n']}}, 08:14:31 INFO - 'talos.zip': {'path': '', 08:14:31 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:14:31 INFO - Running post-action listener: _resource_record_post_action 08:14:31 INFO - [mozharness: 2016-11-18 16:14:31.852003Z] Finished populate-webroot step (success) 08:14:31 INFO - [mozharness: 2016-11-18 16:14:31.852114Z] Running create-virtualenv step. 08:14:31 INFO - Running pre-action listener: _resource_record_pre_action 08:14:31 INFO - Running main action method: create_virtualenv 08:14:31 INFO - Creating virtualenv /builds/slave/test/build/venv 08:14:31 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 08:14:31 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:14:31 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:14:31 INFO - Using real prefix '/usr' 08:14:31 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:14:32 INFO - Installing distribute.............................................................................................................................................................................................done. 08:14:34 INFO - Installing pip.................done. 08:14:34 INFO - Return code: 0 08:14:34 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:14:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:14:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:14:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:14:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:14:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:14:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:14:34 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 0x7f9ad8ef6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b048a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bd1ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bcef60>, '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 0x2bcfd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bd01d0>, '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': '923d835db2ba3686ebe126b700000192-1479485655.430349-1384074954', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:14:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 08:14:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 08:14:34 INFO - Using env: {'DISPLAY': ':0', 08:14:34 INFO - 'HOME': '/home/cltbld', 08:14:34 INFO - 'LANG': 'en_US.UTF-8', 08:14:34 INFO - 'LANGUAGE': 'en_US:en', 08:14:34 INFO - 'LOGNAME': 'cltbld', 08:14:34 INFO - 'MAIL': '/var/mail/cltbld', 08:14:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:14:34 INFO - 'MOZ_NO_REMOTE': '1', 08:14:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:14:34 INFO - 'NO_EM_RESTART': '1', 08:14:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:14:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:14:34 INFO - 'PWD': '/builds/slave/test', 08:14:34 INFO - 'SHELL': '/bin/bash', 08:14:34 INFO - 'SHLVL': '1', 08:14:34 INFO - 'TERM': 'linux', 08:14:34 INFO - 'TMOUT': '86400', 08:14:34 INFO - 'USER': 'cltbld', 08:14:34 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1479485655.430349-1384074954', 08:14:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:14:34 INFO - '_': '/tools/buildbot/bin/python'} 08:14:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:14:34 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 08:14:34 INFO - Cleaning up... 08:14:34 INFO - Return code: 0 08:14:34 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 08:14:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:14:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:14:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:14:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:14:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:14:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:14:34 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 0x7f9ad8ef6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b048a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bd1ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bcef60>, '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 0x2bcfd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bd01d0>, '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': '923d835db2ba3686ebe126b700000192-1479485655.430349-1384074954', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:14:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 08:14:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 08:14:34 INFO - Using env: {'DISPLAY': ':0', 08:14:34 INFO - 'HOME': '/home/cltbld', 08:14:34 INFO - 'LANG': 'en_US.UTF-8', 08:14:34 INFO - 'LANGUAGE': 'en_US:en', 08:14:34 INFO - 'LOGNAME': 'cltbld', 08:14:34 INFO - 'MAIL': '/var/mail/cltbld', 08:14:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:14:34 INFO - 'MOZ_NO_REMOTE': '1', 08:14:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:14:34 INFO - 'NO_EM_RESTART': '1', 08:14:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:14:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:14:34 INFO - 'PWD': '/builds/slave/test', 08:14:34 INFO - 'SHELL': '/bin/bash', 08:14:34 INFO - 'SHLVL': '1', 08:14:34 INFO - 'TERM': 'linux', 08:14:34 INFO - 'TMOUT': '86400', 08:14:34 INFO - 'USER': 'cltbld', 08:14:34 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1479485655.430349-1384074954', 08:14:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:14:34 INFO - '_': '/tools/buildbot/bin/python'} 08:14:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:14:34 INFO - Downloading/unpacking psutil>=3.1.1 08:14:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:14:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:14:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:14:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:14:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:14:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:14:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:14:36 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:14:36 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:14:36 INFO - Installing collected packages: psutil 08:14:36 INFO - Running setup.py install for psutil 08:14:36 INFO - building 'psutil._psutil_linux' extension 08:14:36 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 08:14:37 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 08:14:37 INFO - building 'psutil._psutil_posix' extension 08:14:37 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 08:14:37 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 08:14:37 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:14:37 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:14:37 INFO - Successfully installed psutil 08:14:37 INFO - Cleaning up... 08:14:37 INFO - Return code: 0 08:14:37 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 08:14:37 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')]} 08:14:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:14:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:14:37 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')]} 08:14:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:14:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:14:37 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 0x7f9ad8ef6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b048a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bd1ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bcef60>, '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 0x2bcfd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bd01d0>, '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': '923d835db2ba3686ebe126b700000192-1479485655.430349-1384074954', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:14:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 08:14:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 08:14:37 INFO - Using env: {'DISPLAY': ':0', 08:14:37 INFO - 'HOME': '/home/cltbld', 08:14:37 INFO - 'LANG': 'en_US.UTF-8', 08:14:37 INFO - 'LANGUAGE': 'en_US:en', 08:14:37 INFO - 'LOGNAME': 'cltbld', 08:14:37 INFO - 'MAIL': '/var/mail/cltbld', 08:14:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:14:37 INFO - 'MOZ_NO_REMOTE': '1', 08:14:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:14:37 INFO - 'NO_EM_RESTART': '1', 08:14:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:14:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:14:37 INFO - 'PWD': '/builds/slave/test', 08:14:37 INFO - 'SHELL': '/bin/bash', 08:14:37 INFO - 'SHLVL': '1', 08:14:37 INFO - 'TERM': 'linux', 08:14:37 INFO - 'TMOUT': '86400', 08:14:37 INFO - 'USER': 'cltbld', 08:14:37 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1479485655.430349-1384074954', 08:14:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:14:37 INFO - '_': '/tools/buildbot/bin/python'} 08:14:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:14:37 INFO - Downloading/unpacking mozsystemmonitor==0.3 08:14:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:14:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:14:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:14:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:14:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:14:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:14:39 INFO - Downloading mozsystemmonitor-0.3.tar.gz 08:14:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:14:39 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 08:14:39 INFO - Installing collected packages: mozsystemmonitor 08:14:39 INFO - Running setup.py install for mozsystemmonitor 08:14:39 INFO - Successfully installed mozsystemmonitor 08:14:39 INFO - Cleaning up... 08:14:39 INFO - Return code: 0 08:14:39 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 08:14:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:14:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:14:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:14:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:14:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:14:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:14:39 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9ad8ef6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b048a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bd1ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bcef60>, '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 0x2bcfd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bd01d0>, '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': '923d835db2ba3686ebe126b700000192-1479485655.430349-1384074954', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:14:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 08:14:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 08:14:39 INFO - Using env: {'DISPLAY': ':0', 08:14:39 INFO - 'HOME': '/home/cltbld', 08:14:39 INFO - 'LANG': 'en_US.UTF-8', 08:14:39 INFO - 'LANGUAGE': 'en_US:en', 08:14:39 INFO - 'LOGNAME': 'cltbld', 08:14:39 INFO - 'MAIL': '/var/mail/cltbld', 08:14:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:14:39 INFO - 'MOZ_NO_REMOTE': '1', 08:14:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:14:39 INFO - 'NO_EM_RESTART': '1', 08:14:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:14:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:14:39 INFO - 'PWD': '/builds/slave/test', 08:14:39 INFO - 'SHELL': '/bin/bash', 08:14:39 INFO - 'SHLVL': '1', 08:14:39 INFO - 'TERM': 'linux', 08:14:39 INFO - 'TMOUT': '86400', 08:14:39 INFO - 'USER': 'cltbld', 08:14:39 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1479485655.430349-1384074954', 08:14:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:14:39 INFO - '_': '/tools/buildbot/bin/python'} 08:14:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:14:40 INFO - Downloading/unpacking jsonschema==2.5.1 08:14: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 08:14: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 08:14: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 08:14: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 08:14: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 08:14: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 08:14:41 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:14:41 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 08:14:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:14:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:14:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:14:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:14:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:14:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:14:42 INFO - Downloading functools32-3.2.3-2.tar.gz 08:14:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 08:14:42 INFO - warning: no files found matching '*.txt' 08:14:42 INFO - no previously-included directories found matching 'build' 08:14:42 INFO - no previously-included directories found matching 'dist' 08:14:42 INFO - no previously-included directories found matching '.git*' 08:14:42 INFO - Installing collected packages: jsonschema, functools32 08:14:42 INFO - Running setup.py install for functools32 08:14:42 INFO - warning: no files found matching '*.txt' 08:14:42 INFO - no previously-included directories found matching 'build' 08:14:42 INFO - no previously-included directories found matching 'dist' 08:14:42 INFO - no previously-included directories found matching '.git*' 08:14:42 INFO - Successfully installed jsonschema functools32 08:14:42 INFO - Cleaning up... 08:14:42 INFO - Return code: 0 08:14:42 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 08:14:42 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')]} 08:14:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:14:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:14:42 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')]} 08:14:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:14:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:14:42 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 0x7f9ad8ef6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b048a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bd1ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bcef60>, '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 0x2bcfd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bd01d0>, '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': '923d835db2ba3686ebe126b700000192-1479485655.430349-1384074954', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:14:42 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 08:14:42 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 08:14:42 INFO - Using env: {'DISPLAY': ':0', 08:14:42 INFO - 'HOME': '/home/cltbld', 08:14:42 INFO - 'LANG': 'en_US.UTF-8', 08:14:42 INFO - 'LANGUAGE': 'en_US:en', 08:14:42 INFO - 'LOGNAME': 'cltbld', 08:14:42 INFO - 'MAIL': '/var/mail/cltbld', 08:14:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:14:42 INFO - 'MOZ_NO_REMOTE': '1', 08:14:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:14:42 INFO - 'NO_EM_RESTART': '1', 08:14:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:14:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:14:42 INFO - 'PWD': '/builds/slave/test', 08:14:42 INFO - 'SHELL': '/bin/bash', 08:14:42 INFO - 'SHLVL': '1', 08:14:42 INFO - 'TERM': 'linux', 08:14:42 INFO - 'TMOUT': '86400', 08:14:42 INFO - 'USER': 'cltbld', 08:14:42 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1479485655.430349-1384074954', 08:14:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:14:42 INFO - '_': '/tools/buildbot/bin/python'} 08:14:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:14:42 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 08:14:42 INFO - Cleaning up... 08:14:42 INFO - Return code: 0 08:14:42 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:14:42 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')]} 08:14:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:14:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:14:42 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')]} 08:14:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:14:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:14:42 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 0x7f9ad8ef6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b048a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bd1ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bcef60>, '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 0x2bcfd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bd01d0>, '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': '923d835db2ba3686ebe126b700000192-1479485655.430349-1384074954', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:14:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 08:14:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 08:14:42 INFO - Using env: {'DISPLAY': ':0', 08:14:42 INFO - 'HOME': '/home/cltbld', 08:14:42 INFO - 'LANG': 'en_US.UTF-8', 08:14:42 INFO - 'LANGUAGE': 'en_US:en', 08:14:42 INFO - 'LOGNAME': 'cltbld', 08:14:42 INFO - 'MAIL': '/var/mail/cltbld', 08:14:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:14:42 INFO - 'MOZ_NO_REMOTE': '1', 08:14:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:14:42 INFO - 'NO_EM_RESTART': '1', 08:14:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:14:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:14:42 INFO - 'PWD': '/builds/slave/test', 08:14:42 INFO - 'SHELL': '/bin/bash', 08:14:42 INFO - 'SHLVL': '1', 08:14:42 INFO - 'TERM': 'linux', 08:14:42 INFO - 'TMOUT': '86400', 08:14:42 INFO - 'USER': 'cltbld', 08:14:42 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1479485655.430349-1384074954', 08:14:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:14:42 INFO - '_': '/tools/buildbot/bin/python'} 08:14:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:14:42 INFO - Downloading/unpacking blobuploader==1.2.4 08:14:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:14:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:14:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:14:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:14:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:14:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:14:44 INFO - Downloading blobuploader-1.2.4.tar.gz 08:14:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:14:44 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:14:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:14:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:14:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:14:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:14:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:14:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:14:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:14:45 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:14: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 08:14: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 08:14: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 08:14: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 08:14: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 08:14: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 08:14:45 INFO - Downloading docopt-0.6.1.tar.gz 08:14:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:14:45 INFO - Installing collected packages: blobuploader, requests, docopt 08:14:45 INFO - Running setup.py install for blobuploader 08:14:45 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:14:45 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:14:45 INFO - Running setup.py install for requests 08:14:46 INFO - Running setup.py install for docopt 08:14:46 INFO - Successfully installed blobuploader requests docopt 08:14:46 INFO - Cleaning up... 08:14:46 INFO - Return code: 0 08:14:46 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:14:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:14:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:14:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:14:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:14:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:14:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:14:46 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 0x7f9ad8ef6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b048a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bd1ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bcef60>, '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 0x2bcfd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bd01d0>, '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': '923d835db2ba3686ebe126b700000192-1479485655.430349-1384074954', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:14:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 08:14:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 08:14:46 INFO - Using env: {'DISPLAY': ':0', 08:14:46 INFO - 'HOME': '/home/cltbld', 08:14:46 INFO - 'LANG': 'en_US.UTF-8', 08:14:46 INFO - 'LANGUAGE': 'en_US:en', 08:14:46 INFO - 'LOGNAME': 'cltbld', 08:14:46 INFO - 'MAIL': '/var/mail/cltbld', 08:14:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:14:46 INFO - 'MOZ_NO_REMOTE': '1', 08:14:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:14:46 INFO - 'NO_EM_RESTART': '1', 08:14:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:14:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:14:46 INFO - 'PWD': '/builds/slave/test', 08:14:46 INFO - 'SHELL': '/bin/bash', 08:14:46 INFO - 'SHLVL': '1', 08:14:46 INFO - 'TERM': 'linux', 08:14:46 INFO - 'TMOUT': '86400', 08:14:46 INFO - 'USER': 'cltbld', 08:14:46 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1479485655.430349-1384074954', 08:14:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:14:46 INFO - '_': '/tools/buildbot/bin/python'} 08:14:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:14:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:14:46 INFO - Running setup.py (path:/tmp/pip-Vrwv8D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:14:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:14:46 INFO - Running setup.py (path:/tmp/pip-ccNSGN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:14:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:14:46 INFO - Running setup.py (path:/tmp/pip-Ddni26-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:14:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:14:46 INFO - Running setup.py (path:/tmp/pip-fhN8CB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:14:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:14:46 INFO - Running setup.py (path:/tmp/pip-CSrvXp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:14:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:14:46 INFO - Running setup.py (path:/tmp/pip-tvdc2a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:14:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:14:46 INFO - Running setup.py (path:/tmp/pip-yLeDcC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:14:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:14:46 INFO - Running setup.py (path:/tmp/pip-6UWat_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:14:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:14:47 INFO - Running setup.py (path:/tmp/pip-r6dJJg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:14:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:14:47 INFO - Running setup.py (path:/tmp/pip-m3T5DB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:14:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:14:47 INFO - Running setup.py (path:/tmp/pip-2zoyl_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:14:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:14:47 INFO - Running setup.py (path:/tmp/pip-Hr6Kfl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:14:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:14:47 INFO - Running setup.py (path:/tmp/pip-pBn9n1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:14:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:14:47 INFO - Running setup.py (path:/tmp/pip-VUIdOw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:14:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:14:47 INFO - Running setup.py (path:/tmp/pip-m1Mccx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:14:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:14:47 INFO - Running setup.py (path:/tmp/pip-Eab3KQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:14:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:14:47 INFO - Running setup.py (path:/tmp/pip-w24qsv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:14:47 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:14:47 INFO - Running setup.py install for manifestparser 08:14:47 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:14:47 INFO - Running setup.py install for mozcrash 08:14:47 INFO - Running setup.py install for mozdebug 08:14:47 INFO - Running setup.py install for mozdevice 08:14:48 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 08:14:48 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:14:48 INFO - Running setup.py install for mozfile 08:14:48 INFO - Running setup.py install for mozhttpd 08:14:48 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:14:48 INFO - Running setup.py install for mozinfo 08:14:48 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:14:48 INFO - Running setup.py install for mozInstall 08:14:48 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:14:48 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:14:48 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:14:48 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:14:48 INFO - Running setup.py install for mozleak 08:14:48 INFO - Running setup.py install for mozlog 08:14:48 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:14:48 INFO - Running setup.py install for moznetwork 08:14:48 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:14:48 INFO - Running setup.py install for mozprocess 08:14:48 INFO - Running setup.py install for mozprofile 08:14:49 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:14:49 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:14:49 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:14:49 INFO - Running setup.py install for mozrunner 08:14:49 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:14:49 INFO - Running setup.py install for mozscreenshot 08:14:49 INFO - Running setup.py install for moztest 08:14:49 INFO - Running setup.py install for mozversion 08:14:49 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:14:49 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:14:49 INFO - Cleaning up... 08:14:49 INFO - Return code: 0 08:14:49 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:14:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:14:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:14:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:14:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:14:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:14:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:14:49 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 0x7f9ad8ef6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b048a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bd1ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bcef60>, '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 0x2bcfd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bd01d0>, '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': '923d835db2ba3686ebe126b700000192-1479485655.430349-1384074954', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:14:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 08:14:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 08:14:49 INFO - Using env: {'DISPLAY': ':0', 08:14:49 INFO - 'HOME': '/home/cltbld', 08:14:49 INFO - 'LANG': 'en_US.UTF-8', 08:14:49 INFO - 'LANGUAGE': 'en_US:en', 08:14:49 INFO - 'LOGNAME': 'cltbld', 08:14:49 INFO - 'MAIL': '/var/mail/cltbld', 08:14:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:14:49 INFO - 'MOZ_NO_REMOTE': '1', 08:14:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:14:49 INFO - 'NO_EM_RESTART': '1', 08:14:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:14:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:14:49 INFO - 'PWD': '/builds/slave/test', 08:14:49 INFO - 'SHELL': '/bin/bash', 08:14:49 INFO - 'SHLVL': '1', 08:14:49 INFO - 'TERM': 'linux', 08:14:49 INFO - 'TMOUT': '86400', 08:14:49 INFO - 'USER': 'cltbld', 08:14:49 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1479485655.430349-1384074954', 08:14:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:14:49 INFO - '_': '/tools/buildbot/bin/python'} 08:14:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:14:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:14:49 INFO - Running setup.py (path:/tmp/pip-6Pm6EO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:14:49 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 08:14:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:14:49 INFO - Running setup.py (path:/tmp/pip-i1Qiml-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:14:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:14:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:14:49 INFO - Running setup.py (path:/tmp/pip-2_208i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:14:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 08:14:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:14:49 INFO - Running setup.py (path:/tmp/pip-esge4v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:14:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:14:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:14:50 INFO - Running setup.py (path:/tmp/pip-cwR_GD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:14:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 08:14:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:14:50 INFO - Running setup.py (path:/tmp/pip-rQ6JI0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:14:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 08:14:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:14:50 INFO - Running setup.py (path:/tmp/pip-LfYeBN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:14:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 08:14:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:14:50 INFO - Running setup.py (path:/tmp/pip-qGpDwH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:14:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 08:14:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:14:50 INFO - Running setup.py (path:/tmp/pip-zBdC0k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:14:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 08:14:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:14:50 INFO - Running setup.py (path:/tmp/pip-SoZMgs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:14:50 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)) 08:14:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:14:50 INFO - Running setup.py (path:/tmp/pip-mDOvaS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:14:50 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 08:14:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:14:50 INFO - Running setup.py (path:/tmp/pip-usFlJh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:14:50 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)) 08:14:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:14:50 INFO - Running setup.py (path:/tmp/pip-spAgqN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:14:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 08:14:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:14:50 INFO - Running setup.py (path:/tmp/pip-sm5QTw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:14:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 08:14:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:14:50 INFO - Running setup.py (path:/tmp/pip-S4doPm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:14:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 08:14:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:14:50 INFO - Running setup.py (path:/tmp/pip-Mx7b9C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:14:50 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 08:14:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:14:50 INFO - Running setup.py (path:/tmp/pip-TFDXZr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:14:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 08:14:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:14:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:14:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 08:14:50 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:14:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:14:50 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:14: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 08:14: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 08:14: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 08:14: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 08:14: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 08:14: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 08:14:52 INFO - Downloading blessings-1.6.tar.gz 08:14:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:14:53 INFO - Installing collected packages: blessings 08:14:53 INFO - Running setup.py install for blessings 08:14:53 INFO - Successfully installed blessings 08:14:53 INFO - Cleaning up... 08:14:53 INFO - Return code: 0 08:14:53 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:14:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:14:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:14:53 INFO - Reading from file tmpfile_stdout 08:14:53 INFO - Current package versions: 08:14:53 INFO - argparse == 1.2.1 08:14:53 INFO - blessings == 1.6 08:14:53 INFO - blobuploader == 1.2.4 08:14:53 INFO - docopt == 0.6.1 08:14:53 INFO - functools32 == 3.2.3-2 08:14:53 INFO - jsonschema == 2.5.1 08:14:53 INFO - manifestparser == 1.1 08:14:53 INFO - mozInstall == 1.12 08:14:53 INFO - mozcrash == 0.17 08:14:53 INFO - mozdebug == 0.1 08:14:53 INFO - mozdevice == 0.48 08:14:53 INFO - mozfile == 1.2 08:14:53 INFO - mozhttpd == 0.7 08:14:53 INFO - mozinfo == 0.9 08:14:53 INFO - mozleak == 0.1 08:14:53 INFO - mozlog == 3.4 08:14:53 INFO - moznetwork == 0.27 08:14:53 INFO - mozprocess == 0.23 08:14:53 INFO - mozprofile == 0.28 08:14:53 INFO - mozrunner == 6.12 08:14:53 INFO - mozscreenshot == 0.1 08:14:53 INFO - mozsystemmonitor == 0.3 08:14:53 INFO - moztest == 0.7 08:14:53 INFO - mozversion == 1.4 08:14:53 INFO - psutil == 3.1.1 08:14:53 INFO - requests == 1.2.3 08:14:53 INFO - wsgiref == 0.1.2 08:14:53 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:14:53 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')]} 08:14:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:14:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:14:53 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')]} 08:14:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:14:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:14:53 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 0x7f9ad8ef6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b048a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bd1ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bcef60>, '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 0x2bcfd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bd01d0>, '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': '923d835db2ba3686ebe126b700000192-1479485655.430349-1384074954', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:14:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 08:14:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 08:14:53 INFO - Using env: {'DISPLAY': ':0', 08:14:53 INFO - 'HOME': '/home/cltbld', 08:14:53 INFO - 'LANG': 'en_US.UTF-8', 08:14:53 INFO - 'LANGUAGE': 'en_US:en', 08:14:53 INFO - 'LOGNAME': 'cltbld', 08:14:53 INFO - 'MAIL': '/var/mail/cltbld', 08:14:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:14:53 INFO - 'MOZ_NO_REMOTE': '1', 08:14:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:14:53 INFO - 'NO_EM_RESTART': '1', 08:14:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:14:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:14:53 INFO - 'PWD': '/builds/slave/test', 08:14:53 INFO - 'SHELL': '/bin/bash', 08:14:53 INFO - 'SHLVL': '1', 08:14:53 INFO - 'TERM': 'linux', 08:14:53 INFO - 'TMOUT': '86400', 08:14:53 INFO - 'USER': 'cltbld', 08:14:53 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1479485655.430349-1384074954', 08:14:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:14:53 INFO - '_': '/tools/buildbot/bin/python'} 08:14:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:14:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 08:14:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 08:14:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 08:14:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 08:14:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 08:14:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 08:14:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 08:14:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 08:14:53 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 08:14:53 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 08:14:53 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 08:14:53 INFO - Cleaning up... 08:14:53 INFO - Return code: 0 08:14:53 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 08:14:53 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')]} 08:14:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:14:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:14:53 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')]} 08:14:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:14:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:14:53 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 0x7f9ad8ef6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b048a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bd1ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bcef60>, '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 0x2bcfd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bd01d0>, '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': '923d835db2ba3686ebe126b700000192-1479485655.430349-1384074954', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:14:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 08:14:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 08:14:53 INFO - Using env: {'DISPLAY': ':0', 08:14:53 INFO - 'HOME': '/home/cltbld', 08:14:53 INFO - 'LANG': 'en_US.UTF-8', 08:14:53 INFO - 'LANGUAGE': 'en_US:en', 08:14:53 INFO - 'LOGNAME': 'cltbld', 08:14:53 INFO - 'MAIL': '/var/mail/cltbld', 08:14:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:14:53 INFO - 'MOZ_NO_REMOTE': '1', 08:14:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:14:53 INFO - 'NO_EM_RESTART': '1', 08:14:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:14:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:14:53 INFO - 'PWD': '/builds/slave/test', 08:14:53 INFO - 'SHELL': '/bin/bash', 08:14:53 INFO - 'SHLVL': '1', 08:14:53 INFO - 'TERM': 'linux', 08:14:53 INFO - 'TMOUT': '86400', 08:14:53 INFO - 'USER': 'cltbld', 08:14:53 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1479485655.430349-1384074954', 08:14:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:14:53 INFO - '_': '/tools/buildbot/bin/python'} 08:14:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:14:53 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 08:14:53 INFO - Cleaning up... 08:14:53 INFO - Return code: 0 08:14:53 INFO - Running post-action listener: _resource_record_post_action 08:14:53 INFO - Running post-action listener: _start_resource_monitoring 08:14:53 INFO - Starting resource monitoring. 08:14:53 INFO - [mozharness: 2016-11-18 16:14:53.869529Z] Finished create-virtualenv step (success) 08:14:53 INFO - [mozharness: 2016-11-18 16:14:53.870077Z] Running install step. 08:14:53 INFO - Running pre-action listener: _resource_record_pre_action 08:14:53 INFO - Running main action method: install 08:14:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:14:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:14:54 INFO - Reading from file tmpfile_stdout 08:14:54 INFO - Detecting whether we're running mozinstall >=1.0... 08:14:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:14:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:14:54 INFO - Reading from file tmpfile_stdout 08:14:54 INFO - Output received: 08:14:54 INFO - Usage: mozinstall [options] installer 08:14:54 INFO - Options: 08:14:54 INFO - -h, --help show this help message and exit 08:14:54 INFO - -d DEST, --destination=DEST 08:14:54 INFO - Directory to install application into. [default: 08:14:54 INFO - "/builds/slave/test"] 08:14:54 INFO - --app=APP Application being installed. [default: firefox] 08:14:54 INFO - mkdir: /builds/slave/test/build/application 08:14:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-51.0.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 08:14:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-51.0.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 08:15:07 INFO - Reading from file tmpfile_stdout 08:15:07 INFO - Output received: 08:15:07 INFO - /builds/slave/test/build/application/firefox/firefox 08:15:07 INFO - Running post-action listener: _resource_record_post_action 08:15:07 INFO - [mozharness: 2016-11-18 16:15:07.655295Z] Finished install step (success) 08:15:07 INFO - [mozharness: 2016-11-18 16:15:07.655541Z] Running run-tests step. 08:15:07 INFO - Running pre-action listener: _resource_record_pre_action 08:15:07 INFO - Running main action method: run_tests 08:15:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:15:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:15:07 INFO - Python 2.7.3 08:15:07 INFO - Return code: 0 08:15:07 INFO - grabbing minidump binary from tooltool 08:15:07 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')]} 08:15:07 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 0x2bcef60>, '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 0x2bcfd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bd01d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:15:07 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 08:15:07 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 08:15:07 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 08:15:07 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:15:07 INFO - Return code: 0 08:15:07 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 08:15:07 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:15:07 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:15:07 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 08:15:07 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:15:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Ng8QIMzcR6-37ec5joANQQ/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-007', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 08:15:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Beta --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Ng8QIMzcR6-37ec5joANQQ/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-007 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 08:15:07 INFO - Using env: {'DISPLAY': ':0', 08:15:07 INFO - 'HOME': '/home/cltbld', 08:15:07 INFO - 'LANG': 'en_US.UTF-8', 08:15:07 INFO - 'LANGUAGE': 'en_US:en', 08:15:07 INFO - 'LOGNAME': 'cltbld', 08:15:07 INFO - 'MAIL': '/var/mail/cltbld', 08:15:07 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:15:07 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 08:15:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:15:07 INFO - 'MOZ_NO_REMOTE': '1', 08:15:07 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:15:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:15:07 INFO - 'NO_EM_RESTART': '1', 08:15:07 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:15:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:15:07 INFO - 'PWD': '/builds/slave/test', 08:15:07 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:15:07 INFO - 'SHELL': '/bin/bash', 08:15:07 INFO - 'SHLVL': '1', 08:15:07 INFO - 'TERM': 'linux', 08:15:07 INFO - 'TMOUT': '86400', 08:15:07 INFO - 'USER': 'cltbld', 08:15:07 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1479485655.430349-1384074954', 08:15:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:15:07 INFO - '_': '/tools/buildbot/bin/python'} 08:15:07 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Ng8QIMzcR6-37ec5joANQQ/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-007', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 08:15:07 INFO - mozversion application_buildid: 20161118040828 08:15:07 INFO - mozversion application_changeset: 11b5acda902f5ecb13ab2d451d36c7a9063f2b26 08:15:07 INFO - mozversion application_display_name: Firefox 08:15:07 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:15:07 INFO - mozversion application_name: Firefox 08:15:07 INFO - mozversion application_remotingname: firefox 08:15:07 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 08:15:07 INFO - mozversion application_vendor: Mozilla 08:15:07 INFO - mozversion application_version: 51.0 08:15:07 INFO - mozversion platform_buildid: 20161118040828 08:15:07 INFO - mozversion platform_changeset: 11b5acda902f5ecb13ab2d451d36c7a9063f2b26 08:15:07 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 08:15:07 INFO - mozversion platform_version: 51.0 08:15:07 INFO - using testdate: 1479485707 08:15:07 INFO - actual date: 1479485707 08:15:07 INFO - starting webserver on 'localhost:41336' 08:15:07 INFO - SUITE-START | Running 2 tests 08:15:07 INFO - TEST-START | dromaeo_css 08:15:07 INFO - operating with platform_type : linux_ 08:15:07 INFO - Initialising browser for dromaeo_css test... 08:15:07 INFO - TEST-INFO | started process 18782 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpnaYIWA/profile http://localhost:41336/getInfo.html) 08:15:11 INFO - PROCESS | 18782 | __metrics Screen width/height:1600/1200 08:15:11 INFO - PROCESS | 18782 | colorDepth:24 08:15:11 INFO - PROCESS | 18782 | Browser inner width/height: 1024/697 08:15:11 INFO - PROCESS | 18782 | __metrics 08:15:11 INFO - PROCESS | 18782 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 08:15:11 INFO - PROCESS | 18782 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:15:12 INFO - PROCESS | 18782 | console.error: PushService: 08:15:12 INFO - PROCESS | 18782 | stateChangeProcessEnqueue: Error transitioning state 08:15:12 INFO - PROCESS | 18782 | UnknownError 08:15:12 INFO - TEST-INFO | 18782: exit 0 08:15:12 INFO - Browser initialized. 08:15:12 INFO - Running cycle 1/1 for dromaeo_css test... 08:15:12 INFO - TEST-INFO | started process 18877 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpnaYIWA/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:15:24 INFO - PROCESS | 18877 | RSS: Main: 142299136 08:15:24 INFO - PROCESS | 18877 | 08:16:15 INFO - PROCESS | 18877 | 1479485775445 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 08:18:24 INFO - PROCESS | 18877 | Cycle 1(1): loaded http://localhost:41336/tests/dromaeo/cssquery-dojo.html (next: http://localhost:41336/tests/dromaeo/cssquery-ext.html) 08:18:25 INFO - PROCESS | 18877 | RSS: Main: 246214656 08:18:25 INFO - PROCESS | 18877 | 08:21:27 INFO - PROCESS | 18877 | Cycle 1(1): loaded http://localhost:41336/tests/dromaeo/cssquery-ext.html (next: http://localhost:41336/tests/dromaeo/cssquery-jquery.html) 08:21:28 INFO - PROCESS | 18877 | RSS: Main: 236601344 08:21:28 INFO - PROCESS | 18877 | 08:24:30 INFO - PROCESS | 18877 | Cycle 1(1): loaded http://localhost:41336/tests/dromaeo/cssquery-jquery.html (next: http://localhost:41336/tests/dromaeo/cssquery-mootools.html) 08:24:30 INFO - PROCESS | 18877 | RSS: Main: 233799680 08:24:30 INFO - PROCESS | 18877 | 08:27:32 INFO - PROCESS | 18877 | Cycle 1(1): loaded http://localhost:41336/tests/dromaeo/cssquery-mootools.html (next: http://localhost:41336/tests/dromaeo/cssquery-prototype.html) 08:27:33 INFO - PROCESS | 18877 | RSS: Main: 175263744 08:27:33 INFO - PROCESS | 18877 | 08:30:36 INFO - PROCESS | 18877 | Cycle 1(1): loaded http://localhost:41336/tests/dromaeo/cssquery-prototype.html (next: http://localhost:41336/tests/dromaeo/cssquery-yui.html) 08:30:36 INFO - PROCESS | 18877 | RSS: Main: 173989888 08:30:36 INFO - PROCESS | 18877 | 08:33:39 INFO - PROCESS | 18877 | Cycle 1(1): loaded http://localhost:41336/tests/dromaeo/cssquery-yui.html (next: http://localhost:41336/tests/dromaeo/cssquery-dojo.html) 08:33:39 INFO - PROCESS | 18877 | RSS: Main: 262750208 08:33:39 INFO - PROCESS | 18877 | 08:33:39 INFO - PROCESS | 18877 | __start_tp_report 08:33:39 INFO - PROCESS | 18877 | _x_x_mozilla_page_load 08:33:39 INFO - PROCESS | 18877 | _x_x_mozilla_page_load_details 08:33:39 INFO - PROCESS | 18877 | |i|pagename|runs| 08:33:39 INFO - PROCESS | 18877 | |0;dojo.html;3102.053873568562;3138.9843050784743;3148.9212769680753;3156.9210769730767;3180.9363812723745;5518.4205658405845;5535.944640553594;5551.528120109785;5560.721963901804;5566.638168519048;5553.944460555394;5560.7219639018085;5572.5263352614975;5582.302212223472;5593.412691667378;5084.593232541406;5091.032703786269;5118.513741194581;5135.05001574708;5168.638195326329;4978.2532620107095;4980.501949805027;5118.6416950813455;5177.792888284483;5213.3743950725775;4951.628627852925;4977.776000080005;5038.168702164138;5043.5965122790085;5045.495450454961;5128.974355128238;5218.921716174261;5226.503482169188;5231.476852314776;5256.526912577848;4901.1177987962155;4904.092742842586;5109.565686916617;5120.3855537335385;5164.767585458626;5429.348478182644;5516;5536.75084621193;5540.279763630702;5547.25112109864;5948.31594366649;5990.311114221877;5992.041273396279;5996.370381110008;5997.850053748648;5705.800296989627;5797.159411885295;6027.397260273981;6039.54703397247;6042.758289668452;5305.018571564273;5501.092319767234;5506.339239291271;5552.08390615548;5574.832755017356;6096.3903609639565;6098.878022439615;6103.877922441527;6104.3590423005835;6107.603005804608;5631.915521267184;5860.912086318709;5864.413558644102;5873.295204575478;5875.29496460419;5675.0636145035605;5899.67551784656;5931.9703401483575;5934.43622855828;5999.460048595647;5925.644461332334;5975;5975.850603734942;5993.3706960768495;5993.820185394445;5948.048312270016;5950.196723442366;5996.16053752475;6010.579259451796;6046.516278697693;4449.532799056117;4465.687401881837;4481.641468682497;4514.503404625489;4514.68397212192;4042.4542686737504;4044.737092089005;4048.1296521248073;4071.6131967463043;4073.06319546506;5616.185653080281;5617.550595952396;5619;5621.353544342372;5655;5745.080787074048;5843.678597677169;5877.823665290048;5882.764689412461;5912.201852749824;5772.134179873053;5781.103928891029;5786.132080188006;5792.88414231713;5810.88378232433;5080.720560369141;5082.796688132507;5084.847454576368;5085.567726743194;5138.948610513922;5924.11138329254;6056.06131049688;6097.847553811012;6234.532410069263;6259.2488901332135;5891.734871930687;5996.340402555803;5998.370171131968;6002.519798416203;6013.488853447506;6157.230346206724;6208.379162083756;6209.720562574786;6218.22272215973;6221.657808820558;5620.437956204347;5639.548836093185;5897.174395584536;5900.616459930091;5902.675352855634;5963.194968679346;5989.670568118795;6002.639841609517;6059.21230240066;6096.390360963868;5897.764089436546;5907.438793314628;5916.940830591639;5927.170196172453;5936.465718085393;5585.469380408855;5907.143464197753;5911.142884281841;5915.615484993462;5918.970405147947;5686.402927692533;5699;5721.628094173865;5753.3958934311295;5842.036064049555;5812.709364531672;5824.737886795189;5855.970720146543;5856.560757943086;5862.765489380377;5551.694656793915;5608.10270356741;5722.856928576819;5730.484256416942;5734.2258795062135 08:33:39 INFO - PROCESS | 18877 | |1;ext.html;584.2025635008213;609.2567068176824;642.2838535033437;647.4852492268649;650.39513252675;34535.65464345359;46441.30338044932;47769;47848.52151478489;51682.48317516833;47263.527364726346;47796.52203477973;47879.76060119695;47879.760601197035;47881.76059119708;8524;9401.576929038176;9580.0898914603;9599.904000960007;9603.4718090505;8381.916180838205;10891.67324980248;11167.16246281528;11180.664580062612;11549.711257218594;11521.2511186773;11582.362970036645;11587.884121158808;11595;11595.478203480863;11357.829632555518;11412.258203216765;11431.828522572127;11443.542258309657;11445.771084578304;11232.550697972072;11233.66299011031;11244.437778111143;11272.380019098946;11283;44772.328415073796;44940.3258951116;45099;45219.54780452186;45240;3851.1527463957887;3875.3218186817476;4460.977695111536;4534.13851368239;4563.178627846986;33959.66040339614;34067.31865362704;34315.48526772101;34373;35828;4285.700000999931;4329.891752706176;4381.07997320563;4414.139242847646;4463;340160;340546;341244;341409;341462;35003.4749478758;65266;65521;65523.672381637785;65688.34311656823;41921.580784192374;41994.37008444876;42218;42232.366514502304;42235.7888210557;18095;18142.09289535518;18280.90859545694;18290.542736431697;18294.817051829312;12477.064220183522;12707.936460317824;14045.227512486912;15444;15529.22353882324;9575.473348965874;9651.613935442503;9735.41587504752;9756.609735610638;9789.755256118511;3596.2088340565033;3653.47024681425;3678.301122786662;3682.9263414731554;3706.610805865399;1081.5241293830848;1100.3892839474008;1122.6744244169263;1136.017344996572;1154.463174623804;33783.66216337854;34166.14584635404;34242;34535.654643453745;34609.48085778715;1088.646189988257;1135.5684839761004;1143.7026373142876;1194.964151075469;1207.4325067218392;18366.62321251066;18716.812831871506;18914.621707566046;19942.20231190765;20037;578806;587755;589508;600742;875233;65025.34974650193;65755.34244657587;65781;65943.34056659372;65998.34001659922;1347.7035052288677;1392.7562676531566;1406.21252098825;1451.2235953764684;1469.6105532033805;32600.83699581487;34737.65262347344;35250.294994100484;35378.82310588431;35522.111947200494;55035;66544;67872.6606366965;67898.66050669715;68041.3195868035;375500;382384;384070;526705;528386;43614;43655.78172109119;48665.75667121642;49682.254766179256;50042.49957500524;52701.20948185857;53920.46079539155;54841.1773823385;54983.45016549943;55772.04797832057;45056.09887802291;46050.53949460462;46375.76812115918;48181;48251.75874120607;46198.53801461942;46319.76840115778;46436;46467.76766116148;46654.30018549656;44753.77623111994;45664.31503527383;45829;45922;46079.308810368544;39015.60984390233;40286;40855.59144408637;40920;41758.37362439626;30187;30455.39089218159;30643.080707578807;30713.692863071083;31029.379412412076 08:33:39 INFO - PROCESS | 18877 | |2;jquery.html;414.6392638404587;419.54060303967145;428.8949207444177;431.3594312446018;441.11556329559227;19352.419427417182;19714.901425492888;21008.36974890752;21202.469938251514;21335;17793.110344482757;18575.628487430244;19367.903160484213;19497.317593884218;20495.487612809688;5340.332458442685;5570.275864137657;5583.190437386596;5584.553235741151;5587.636803607773;5522.5581953443825;5604.075327570967;5611.046122159243;5616;6159.538034647397;6159.291681456645;6160.383961603826;6161.168242287301;6164.722587483574;6166.630002199882;5933.317668468117;6160.5687601867885;6165.568410211287;6168.722407491674;6224.253089629228;6129;6139.89481893259;6142.477889379408;6143.3242343342645;6143.416375444371;15434.45979390716;16494.010359378477;22305.776942230532;24300.27099187027;24472.388190295205;2538.1624064058815;2574.7940164786773;2588.5081834451394;2811.7610003149757;3130.1392117167734;11765.176437649368;12341.62975110748;15304;15680;15869.047857128493;2046.0894901768718;2075.813176814079;2090.372888133569;2098.8530802843807;2284.6116160252795;91699;92018.5399073007;92035.53982230046;92671.53664231703;93674.06325936722;11776.470058847372;11829.940850295694;11906;12375.876241237653;12459.19015264023;17609.38367157169;17614.647707046042;17640.117994100245;17656.55858603545;17658.91170544139;9208.723738287728;9210.493422861673;9244;9369.48467834262;9405.20055795265;9072.319576031825;9080.091990801;9106.544672766335;9113.817723645623;9316.673916413029;5235.110031294689;5241.24002019705;5278.656887302313;5329.1206950852675;5347.171188465794;2105.6420408530585;2107.5574129432684;2155.773643767382;2157.223399576151;2160.1899287767087;942.79258563116;989.4805227255605;1011.544804837826;1046.4506134279563;1050.8791488978866;20582.38252852417;20750.169993200405;20774.792252077586;20800.687989680166;21092.156313747586;1034.9689509314733;1045.2526443592867;1047.0890325416935;1052.810494111052;1099.6975831646362;10731.356118632906;11617.128715346384;11673.182877198684;11748.70628234301;11889.464974076187;360751;366572;366610;478238;495862;88630;102594;104871.95128048774;106411.46794266134;107672;1064.984025239622;1066.7706443114769;1111.1666250312267;1117.1063149480383;1120.624590762104;18282.542936426697;18482.168302426693;18641.813581864008;18861.434156975312;18866.151023204264;29459.55810662799;31938;45324.32013519734;47482;48100.5189948096;60252;60427.395726043935;60483;61042.69478652578;63548;9163.221126204347;9372.578233979351;9432.717018489457;9564.521773911416;9685;13884.722305554034;14455.349509271897;14486.275686215437;14546.927265363605;14979.625509362353;12121.636350909486;12231.204971677169;12234.632961011184;12309.26144431337;12340.136190466581;12008.579699710468;12222.877771222174;12414.193077449936;12534;12646.241225526497;12667.366631668196;12701.745965080461;12749.681257968625;12778.68053298675;12933.288669123289;9251.86122208154;9251.93602735694;9453.952730236304;9484.620615175316;9563.665271715734;12073.469994794497;12586.811197831857;12653.936730316289;12914.806277906027;12922.741545169232 08:33:39 INFO - PROCESS | 18877 | |3;mootools.html;1362.863713628638;1520.8631223189911;1560.6410525579115;1685.915704214789;1815.1922394534422;8106;8641.91358086419;8968;9387.389819661717;9404.71785846424;9368.672096476625;9464.66873659422;9468;9474.478903660296;9478.952605236964;2513.962290565643;2533.8479691218586;2539.0478570536047;2543.4277287610325;2544.580144276192;2426.4904370082218;2470.641756945242;2487.0424886418677;2494.289127598635;2497.425592113815;2486.254123762873;2494.9251522454265;2542.2119143065615;2546.5161619292276;2551.4386834896295;2440.633904914268;2442.5237078769646;2456.238566044532;2479.429731161843;2487.962680559775;2427.5509030829353;2450.6691596634582;2467.1611652038214;2474.2824580871525;2476.182859656309;9208.769780755467;9314.44113353201;9375.10936461035;9379.906200937972;9393.20157786589;5594.9720251398885;5780.595358324919;5795.130730390433;5878.323992740847;5886.7939622113445;3468.843902024415;3500.929981400383;3509.543759311299;3542.6103128655827;3574.3566158091535;1124.2299025167786;1137.5734099712608;1141.4920360439608;1148.4831825678477;1148.494662348564;12729.427175777113;12747.936260318638;12820.743585128339;12822.487100515875;12832.294223817686;4913.115639184981;4913.484084171182;4992.201247800334;5054;5117.181250999822;9992.80014399708;9995.300328977048;10000.499975001221;10003.599856005678;10007.949960250298;5752.309722833287;5768.048272035151;5772.04761214395;5773.624714393551;5775.364709881909;4591.288350305708;4592.7933243004145;4611.792469338888;4721.858344249678;5387.434319396407;4124.752514849119;4190.601892820177;4296.162248361539;4301.935470967938;4337;1292.069709808936;1301.1217428235902;1316.1971197569476;1319.5051855554168;1321.0818481155504;974.8635191073255;977.9706608801747;1032.8244198486275;1044.3420644993605;1049.4070849969742;6222.719977600928;6284.780032698834;6445;6489.5781774184525;6565.24499682533;964.5707660091332;982.8820541534918;1015.1472762879217;1026.8767747870304;1027.6762819711766;4366.214081465367;4552.248878934939;4581.839635612738;4600.631949444037;4602.792874320664;11379.886201138048;11705.590304339306;11870.643880683594;11878.88121118795;11884.346360950058;11500.424978751029;11517.193796434169;11613.30320180792;11722.355270460035;11742.119341049456;8704;8785.912140878509;8786.209241168326;8827.911720882708;8872.290216782641;6286.5599408041;6300.21247344082;6393.7122829471855;6482.448991835747;6504.1219435375615;10054.245931555017;10463.319884207502;10509.159267258448;10514.053735163872;10798.568057277935;9622.566984485855;9912.603495860085;10623;10788.352698838095;10945.781084378108;8443.07126216128;8543.359248056297;8547.487150770974;8749.343799214957;8808.20726134651;8885.689000884939;8976.461412315282;9186;9215.262778977532;9230.861537076815;8079.515229086273;8090.919090809252;8139.389545784208;8299.08710041907;8373.748787536384;7968.601569921597;8165.755027348951;8169.0605580359015;8183.345332373515;8327;7419.1467981180695;7431;7507.324340809353;7515.13575938774;7560.395168386406;4696.788644510937;5441.891162176655;5635.88728225425;5702.230198923258;5727.255456790591;5694.743736531783;5696.971515142398;5809.767609295581;5822.5633077518505;5954.10688396744 08:33:39 INFO - PROCESS | 18877 | |4;prototype.html;346.58063742871127;353.9275993738971;363.9235760490297;364.0117082122038;369.6396013886461;5620.156976453529;5621.550275977922;5626.54987600992;5630.802921897734;5632.5212356949705;5522.337319521663;5524.530414914727;5550;5569.384878385264;5586.050371436855;4221.430106935562;4356.1723272578265;4390.69265151438;4393.165298593273;4408.933865992013;4353.737416149313;4354.8911277218;4367.737935723851;4368.126374725051;4372.256716358227;4323.200207961521;4330.415393921828;4339.349097635364;4365.450265155871;4388.626966707834;4115.876523704279;4312.5903039211225;4313.460817397825;4331.523532411432;4369.279068953619;3806.257779732953;3821.9617803821884;3822;3822.6750726188307;3839.9808000960097;5342.626016178869;5357.7589008494715;5364.785408583652;5366.4096949335935;5387.380451248117;4833.854984350475;4884.365032545782;4900.093482705675;4931.605471562267;4954.752262386866;5718.571107166979;5734.512566431858;5738.856528586777;5743.190894868103;5746.25298711169;4186.5604111568155;4190.5180904195795;4192.371144328345;4194.28697121487;4195.643370313527;5676.744546495418;5907.261592300963;5950.523958083386;5969.507623094227;5984.311804142492;4267.743935363888;4270.231358355463;4271.316589345752;4275.251830929575;4276.593723596254;4331.7834108294455;4342.392065110887;4345;4380.6057454829215;4385.890352741207;4659.673822832369;4855.757212139379;4892.730899800546;4902.48523904992;4918.90162196754;5724.427557244326;5751.511121554631;5754.7556452982535;5786.42135786418;5794.362620111784;1473.5652982370227;1503.3385310463361;1505.2774668159127;1507.5778781941074;1509.8339182689895;957.3203025851584;972.8540718892223;982.8009828009816;1034.6895931220604;1041.54172164249;5600.467955544217;5623.284898106035;5635.21107045014;5647.757493351456;5649.265595472562;5883.470487656132;5889.38161493037;5910.261217347832;5912.9113063304085;5920.851978700481;5412.485813847678;5682.40334764852;5690.317161940594;5730.283714535683;5732.742026608813;3131.2798056447145;3133.326334837975;3151.16494129056;3158.7630927680516;3160.241542029896;5861.413858614104;6089.238845144357;6112.480439162632;6155.692215389213;6177.752889884354;5782.710864456844;6012.879742405127;6060.212172417558;6064.332923378425;6066.150738896558;5983.371745966698;5998.850028749229;6117.418845209698;6162.26052873649;6162.691865406801;5969.940300596939;5971.164037034905;5985.970070149621;5992.460678538952;5998.390700045494;5574.275344205227;5821.359650438533;5892.558058145742;5893.2044174035955;5895.7052147391605;6162.506999439945;6183.659898705614;6197.993972923038;6205.169475004795;6210.534209934182;4092.69304802147;4297.52727200014;4320.027993701392;4327.663061946514;4329.285667864893;5908.438698323653;5914.704264786657;5914.940850591439;5935.317438494629;5951.672658003851;5702.2016917630735;5783.421657834183;5789.9710501447225;5803.738831752666;5853.385394533512;5591;5756.597038207286;5757.481826635623;5760.135979603093;5783.508401785895;5747.281589801275;5749.252597162342;5750.166225897305;5757.437940116608;5770.740316685843;5587.888242235052;5752.741126649227;5802.187693722798;5803.82588522345;5824.475797178275;5629.493345598916;5664.660120392789;5702.51528620072;5705.22979397776;5706.572007099401 08:33:39 INFO - PROCESS | 18877 | |5;yui.html;808.6724876425046;823.851706692795;849.6813694864426;880.3045593980755;891.1445012787724;16225.675486490263;16819.15904204791;17177.57056073599;17210.827891721063;17214.655706885856;15989.280482378292;16147.43483978061;16168.514944551653;16169.272382742776;16195.676086478263;691.3397705191543;714.8748968930443;825.4634487583089;852.0244320253306;852.2202185000717;840.9159084091604;843.3211264931758;843.5191940593865;843.6709683223547;848.8259906719138;893.8837951066353;894.5974311559792;896.0099090504996;896.3904544909492;896.8385690575694;885.8804061451686;888.9777755556163;889.2574700125404;889.386323436833;889.6485888074207;661.3320546248276;661.5104822431366;662.2648859765657;662.7779693802582;662.8376047868255;16466;16467.505974820655;16501;16501.257443415074;16511.09188994605;14173.149611023371;15485.127744062314;15592.532224033184;15860.920695396564;15972.041677499386;12913.160644558167;13108;13137.671558211026;13391.732165356736;13748.862511374859;4225.598568136023;4271.530131685512;4323.502797178333;4413.249747542925;4493.213687604656;70955.64522177356;73511.26488735098;73936.26063739347;83362;83714.58142709309;13265.469381224642;13543.729125417436;13558.186508809504;13560.660983475294;13605;25162.24513264605;25586.104486342887;25594.104206352687;25613.103541375964;25653.61519577208;9662.661806836726;9671.50091735782;9898.455584942752;10041.447720375449;10498.265121441578;4893.926591101136;5001.7499125043605;5108.744562771846;5151.407588127338;5173.0688476074665;4011.438398624195;4084.4281800547947;4117.75293482392;4118.9588104118575;4128.545859955402;698.2040473859804;702.8594281143792;703.6244142701007;713.4684659928283;718.270954980695;619.3187493756922;772.9603683046294;782.6438970268514;833.6332013913858;843.4053991935671;9721.270904682036;10321.535530901128;10670.146388288918;10849.620263290746;11140.61007864737;741.036652351951;778.4939789136993;802.3500964219002;833.2500749325534;853.4793775796883;5066.36670416198;5424.593155513352;5491.423400542965;5494.945050549523;5514.5864060195645;70828.58342833114;74800;74838.6258068717;74941;98129;106364.46817765862;110698.44650776694;113189.43405282921;113603.43198283955;115404;90308;94314;94854.52572737093;97055.51472242594;98376.50811746038;9867.629362214384;10107.090361867467;10290.17312850529;10368.688939331832;10425.478726063515;55568.72215638896;55614;56132.15801763059;56326;56666.15000774909;78082;83602.16397835944;85107.57446212976;85170.57414712886;88355;11843.407829608657;12325.69185770327;12372.4432400544;12508.624741257778;12872.16330938486;15083.622909427351;15387;15590.76613850816;16296.837031629531;16477.67044659124;14358.712825743636;14508.854911451173;15547.611309717347;15734.291956862198;15746.370145194063;14680.926595366955;15349.462768803038;15718.371265149266;15744.370225190863;16364.918175409046;14491.347889344794;14854;14856.40574377056;15170.089794612359;15269.083854968294;12776.977841772821;12804.423800928795;12903.354832258537;13669.179849209078;13711.794323084961;12673.80989285143;12689.302088385228;12900.806487902877;13093.803592945922;13282.203067815963 08:33:39 INFO - PROCESS | 18877 | __end_tp_report 08:33:39 INFO - PROCESS | 18877 | __start_cc_report 08:33:39 INFO - PROCESS | 18877 | _x_x_mozilla_cycle_collect,935 08:33:39 INFO - PROCESS | 18877 | __end_cc_report 08:33:39 INFO - PROCESS | 18877 | __startTimestamp1479486819541__endTimestamp 08:33:39 INFO - PROCESS | 18877 | 08:33:39 INFO - PROCESS | 18877 | ------- Summary: start ------- 08:33:39 INFO - PROCESS | 18877 | Number of tests: 6 08:33:39 INFO - PROCESS | 18877 | 08:33:39 INFO - PROCESS | 18877 | [#0] dojo.html Cycles:165 Average:5529.02 Median:5730.48 stddev:640.95 (11.2%) stddev-sans-first:613.99 08:33:39 INFO - PROCESS | 18877 | Values: 3102.1 3139.0 3148.9 3156.9 3180.9 5518.4 5535.9 5551.5 5560.7 5566.6 5553.9 5560.7 5572.5 5582.3 5593.4 5084.6 5091.0 5118.5 5135.1 5168.6 4978.3 4980.5 5118.6 5177.8 5213.4 4951.6 4977.8 5038.2 5043.6 5045.5 5129.0 5218.9 5226.5 5231.5 5256.5 4901.1 4904.1 5109.6 5120.4 5164.8 5429.3 5516.0 5536.8 5540.3 5547.3 5948.3 5990.3 5992.0 5996.4 5997.9 5705.8 5797.2 6027.4 6039.5 6042.8 5305.0 5501.1 5506.3 5552.1 5574.8 6096.4 6098.9 6103.9 6104.4 6107.6 5631.9 5860.9 5864.4 5873.3 5875.3 5675.1 5899.7 5932.0 5934.4 5999.5 5925.6 5975.0 5975.9 5993.4 5993.8 5948.0 5950.2 5996.2 6010.6 6046.5 4449.5 4465.7 4481.6 4514.5 4514.7 4042.5 4044.7 4048.1 4071.6 4073.1 5616.2 5617.6 5619.0 5621.4 5655.0 5745.1 5843.7 5877.8 5882.8 5912.2 5772.1 5781.1 5786.1 5792.9 5810.9 5080.7 5082.8 5084.8 5085.6 5138.9 5924.1 6056.1 6097.8 6234.5 6259.2 5891.7 5996.3 5998.4 6002.5 6013.5 6157.2 6208.4 6209.7 6218.2 6221.7 5620.4 5639.5 5897.2 5900.6 5902.7 5963.2 5989.7 6002.6 6059.2 6096.4 5897.8 5907.4 5916.9 5927.2 5936.5 5585.5 5907.1 5911.1 5915.6 5919.0 5686.4 5699.0 5721.6 5753.4 5842.0 5812.7 5824.7 5856.0 5856.6 5862.8 5551.7 5608.1 5722.9 5730.5 5734.2 08:33:39 INFO - PROCESS | 18877 | 08:33:39 INFO - PROCESS | 18877 | [#1] ext.html Cycles:180 Average:65127.59 Median:41839.98 stddev:132939.10 (317.7%) stddev-sans-first:133223.70 08:33:39 INFO - PROCESS | 18877 | Values: 584.2 609.3 642.3 647.5 650.4 34535.7 46441.3 47769.0 47848.5 51682.5 47263.5 47796.5 47879.8 47879.8 47881.8 8524.0 9401.6 9580.1 9599.9 9603.5 8381.9 10891.7 11167.2 11180.7 11549.7 11521.3 11582.4 11587.9 11595.0 11595.5 11357.8 11412.3 11431.8 11443.5 11445.8 11232.6 11233.7 11244.4 11272.4 11283.0 44772.3 44940.3 45099.0 45219.5 45240.0 3851.2 3875.3 4461.0 4534.1 4563.2 33959.7 34067.3 34315.5 34373.0 35828.0 4285.7 4329.9 4381.1 4414.1 4463.0 340160.0 340546.0 341244.0 341409.0 341462.0 35003.5 65266.0 65521.0 65523.7 65688.3 41921.6 41994.4 42218.0 42232.4 42235.8 18095.0 18142.1 18280.9 18290.5 18294.8 12477.1 12707.9 14045.2 15444.0 15529.2 9575.5 9651.6 9735.4 9756.6 9789.8 3596.2 3653.5 3678.3 3682.9 3706.6 1081.5 1100.4 1122.7 1136.0 1154.5 33783.7 34166.1 34242.0 34535.7 34609.5 1088.6 1135.6 1143.7 1195.0 1207.4 18366.6 18716.8 18914.6 19942.2 20037.0 578806.0 587755.0 589508.0 600742.0 875233.0 65025.3 65755.3 65781.0 65943.3 65998.3 1347.7 1392.8 1406.2 1451.2 1469.6 32600.8 34737.7 35250.3 35378.8 35522.1 55035.0 66544.0 67872.7 67898.7 68041.3 375500.0 382384.0 384070.0 526705.0 528386.0 43614.0 43655.8 48665.8 49682.3 50042.5 52701.2 53920.5 54841.2 54983.5 55772.0 45056.1 46050.5 46375.8 48181.0 48251.8 46198.5 46319.8 46436.0 46467.8 46654.3 44753.8 45664.3 45829.0 45922.0 46079.3 39015.6 40286.0 40855.6 40920.0 41758.4 30187.0 30455.4 30643.1 30713.7 31029.4 08:33:39 INFO - PROCESS | 18877 | 08:33:39 INFO - PROCESS | 18877 | [#2] jquery.html Cycles:180 Average:28113.25 Median:2156.50 stddev:69896.77 (3241.2%) stddev-sans-first:70061.91 08:33:39 INFO - PROCESS | 18877 | Values: 414.6 419.5 428.9 431.4 441.1 19352.4 19714.9 21008.4 21202.5 21335.0 17793.1 18575.6 19367.9 19497.3 20495.5 5340.3 5570.3 5583.2 5584.6 5587.6 5522.6 5604.1 5611.0 5616.0 6159.5 6159.3 6160.4 6161.2 6164.7 6166.6 5933.3 6160.6 6165.6 6168.7 6224.3 6129.0 6139.9 6142.5 6143.3 6143.4 15434.5 16494.0 22305.8 24300.3 24472.4 2538.2 2574.8 2588.5 2811.8 3130.1 11765.2 12341.6 15304.0 15680.0 15869.0 2046.1 2075.8 2090.4 2098.9 2284.6 91699.0 92018.5 92035.5 92671.5 93674.1 11776.5 11829.9 11906.0 12375.9 12459.2 17609.4 17614.6 17640.1 17656.6 17658.9 9208.7 9210.5 9244.0 9369.5 9405.2 9072.3 9080.1 9106.5 9113.8 9316.7 5235.1 5241.2 5278.7 5329.1 5347.2 2105.6 2107.6 2155.8 2157.2 2160.2 942.8 989.5 1011.5 1046.5 1050.9 20582.4 20750.2 20774.8 20800.7 21092.2 1035.0 1045.3 1047.1 1052.8 1099.7 10731.4 11617.1 11673.2 11748.7 11889.5 360751.0 366572.0 366610.0 478238.0 495862.0 88630.0 102594.0 104872.0 106411.5 107672.0 1065.0 1066.8 1111.2 1117.1 1120.6 18282.5 18482.2 18641.8 18861.4 18866.2 29459.6 31938.0 45324.3 47482.0 48100.5 60252.0 60427.4 60483.0 61042.7 63548.0 9163.2 9372.6 9432.7 9564.5 9685.0 13884.7 14455.3 14486.3 14546.9 14979.6 12121.6 12231.2 12234.6 12309.3 12340.1 12008.6 12222.9 12414.2 12534.0 12646.2 12667.4 12701.7 12749.7 12778.7 12933.3 9251.9 9251.9 9454.0 9484.6 9563.7 12073.5 12586.8 12653.9 12914.8 12922.7 08:33:39 INFO - PROCESS | 18877 | 08:33:39 INFO - PROCESS | 18877 | [#3] mootools.html Cycles:180 Average:6145.40 Median:4709.32 stddev:3443.73 (73.1%) stddev-sans-first:3434.63 08:33:39 INFO - PROCESS | 18877 | Values: 1362.9 1520.9 1560.6 1685.9 1815.2 8106.0 8641.9 8968.0 9387.4 9404.7 9368.7 9464.7 9468.0 9474.5 9479.0 2514.0 2533.8 2539.0 2543.4 2544.6 2426.5 2470.6 2487.0 2494.3 2497.4 2486.3 2494.9 2542.2 2546.5 2551.4 2440.6 2442.5 2456.2 2479.4 2488.0 2427.6 2450.7 2467.2 2474.3 2476.2 9208.8 9314.4 9375.1 9379.9 9393.2 5595.0 5780.6 5795.1 5878.3 5886.8 3468.8 3500.9 3509.5 3542.6 3574.4 1124.2 1137.6 1141.5 1148.5 1148.5 12729.4 12747.9 12820.7 12822.5 12832.3 4913.1 4913.5 4992.2 5054.0 5117.2 9992.8 9995.3 10000.5 10003.6 10007.9 5752.3 5768.0 5772.0 5773.6 5775.4 4591.3 4592.8 4611.8 4721.9 5387.4 4124.8 4190.6 4296.2 4301.9 4337.0 1292.1 1301.1 1316.2 1319.5 1321.1 974.9 978.0 1032.8 1044.3 1049.4 6222.7 6284.8 6445.0 6489.6 6565.2 964.6 982.9 1015.1 1026.9 1027.7 4366.2 4552.2 4581.8 4600.6 4602.8 11379.9 11705.6 11870.6 11878.9 11884.3 11500.4 11517.2 11613.3 11722.4 11742.1 8704.0 8785.9 8786.2 8827.9 8872.3 6286.6 6300.2 6393.7 6482.4 6504.1 10054.2 10463.3 10509.2 10514.1 10798.6 9622.6 9912.6 10623.0 10788.4 10945.8 8443.1 8543.4 8547.5 8749.3 8808.2 8885.7 8976.5 9186.0 9215.3 9230.9 8079.5 8090.9 8139.4 8299.1 8373.7 7968.6 8165.8 8169.1 8183.3 8327.0 7419.1 7431.0 7507.3 7515.1 7560.4 4696.8 5441.9 5635.9 5702.2 5727.3 5694.7 5697.0 5809.8 5822.6 5954.1 08:33:39 INFO - PROCESS | 18877 | 08:33:39 INFO - PROCESS | 18877 | [#4] prototype.html Cycles:180 Average:4886.93 Median:5628.02 stddev:1423.96 (25.3%) stddev-sans-first:1386.57 08:33:39 INFO - PROCESS | 18877 | Values: 346.6 353.9 363.9 364.0 369.6 5620.2 5621.6 5626.5 5630.8 5632.5 5522.3 5524.5 5550.0 5569.4 5586.1 4221.4 4356.2 4390.7 4393.2 4408.9 4353.7 4354.9 4367.7 4368.1 4372.3 4323.2 4330.4 4339.3 4365.5 4388.6 4115.9 4312.6 4313.5 4331.5 4369.3 3806.3 3822.0 3822.0 3822.7 3840.0 5342.6 5357.8 5364.8 5366.4 5387.4 4833.9 4884.4 4900.1 4931.6 4954.8 5718.6 5734.5 5738.9 5743.2 5746.3 4186.6 4190.5 4192.4 4194.3 4195.6 5676.7 5907.3 5950.5 5969.5 5984.3 4267.7 4270.2 4271.3 4275.3 4276.6 4331.8 4342.4 4345.0 4380.6 4385.9 4659.7 4855.8 4892.7 4902.5 4918.9 5724.4 5751.5 5754.8 5786.4 5794.4 1473.6 1503.3 1505.3 1507.6 1509.8 957.3 972.9 982.8 1034.7 1041.5 5600.5 5623.3 5635.2 5647.8 5649.3 5883.5 5889.4 5910.3 5912.9 5920.9 5412.5 5682.4 5690.3 5730.3 5732.7 3131.3 3133.3 3151.2 3158.8 3160.2 5861.4 6089.2 6112.5 6155.7 6177.8 5782.7 6012.9 6060.2 6064.3 6066.2 5983.4 5998.9 6117.4 6162.3 6162.7 5969.9 5971.2 5986.0 5992.5 5998.4 5574.3 5821.4 5892.6 5893.2 5895.7 6162.5 6183.7 6198.0 6205.2 6210.5 4092.7 4297.5 4320.0 4327.7 4329.3 5908.4 5914.7 5914.9 5935.3 5951.7 5702.2 5783.4 5790.0 5803.7 5853.4 5591.0 5756.6 5757.5 5760.1 5783.5 5747.3 5749.3 5750.2 5757.4 5770.7 5587.9 5752.7 5802.2 5803.8 5824.5 5629.5 5664.7 5702.5 5705.2 5706.6 08:33:39 INFO - PROCESS | 18877 | 08:33:39 INFO - PROCESS | 18877 | [#5] yui.html Cycles:180 Average:21576.89 Median:4248.56 stddev:29517.76 (694.8%) stddev-sans-first:29559.37 08:33:39 INFO - PROCESS | 18877 | Values: 808.7 823.9 849.7 880.3 891.1 16225.7 16819.2 17177.6 17210.8 17214.7 15989.3 16147.4 16168.5 16169.3 16195.7 691.3 714.9 825.5 852.0 852.2 840.9 843.3 843.5 843.7 848.8 893.9 894.6 896.0 896.4 896.8 885.9 889.0 889.3 889.4 889.6 661.3 661.5 662.3 662.8 662.8 16466.0 16467.5 16501.0 16501.3 16511.1 14173.1 15485.1 15592.5 15860.9 15972.0 12913.2 13108.0 13137.7 13391.7 13748.9 4225.6 4271.5 4323.5 4413.2 4493.2 70955.6 73511.3 73936.3 83362.0 83714.6 13265.5 13543.7 13558.2 13560.7 13605.0 25162.2 25586.1 25594.1 25613.1 25653.6 9662.7 9671.5 9898.5 10041.4 10498.3 4893.9 5001.7 5108.7 5151.4 5173.1 4011.4 4084.4 4117.8 4119.0 4128.5 698.2 702.9 703.6 713.5 718.3 619.3 773.0 782.6 833.6 843.4 9721.3 10321.5 10670.1 10849.6 11140.6 741.0 778.5 802.4 833.3 853.5 5066.4 5424.6 5491.4 5494.9 5514.6 70828.6 74800.0 74838.6 74941.0 98129.0 106364.5 110698.4 113189.4 113603.4 115404.0 90308.0 94314.0 94854.5 97055.5 98376.5 9867.6 10107.1 10290.2 10368.7 10425.5 55568.7 55614.0 56132.2 56326.0 56666.2 78082.0 83602.2 85107.6 85170.6 88355.0 11843.4 12325.7 12372.4 12508.6 12872.2 15083.6 15387.0 15590.8 16296.8 16477.7 14358.7 14508.9 15547.6 15734.3 15746.4 14680.9 15349.5 15718.4 15744.4 16364.9 14491.3 14854.0 14856.4 15170.1 15269.1 12777.0 12804.4 12903.4 13669.2 13711.8 12673.8 12689.3 12900.8 13093.8 13282.2 08:33:39 INFO - PROCESS | 18877 | -------- Summary: end -------- 08:33:39 INFO - PROCESS | 18877 | 08:33:40 INFO - TEST-INFO | 18877: exit 0 08:33:40 INFO - TEST-OK | dromaeo_css | took 1112236ms 08:33:40 INFO - TEST-START | kraken 08:33:40 INFO - operating with platform_type : linux_ 08:33:40 INFO - Initialising browser for kraken test... 08:33:40 INFO - TEST-INFO | started process 19185 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpdgAdNl/profile http://localhost:41336/getInfo.html) 08:33:43 INFO - PROCESS | 19185 | __metrics Screen width/height:1600/1200 08:33:43 INFO - PROCESS | 19185 | colorDepth:24 08:33:43 INFO - PROCESS | 19185 | Browser inner width/height: 1024/697 08:33:43 INFO - PROCESS | 19185 | __metrics 08:33:43 INFO - PROCESS | 19185 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 08:33:43 INFO - PROCESS | 19185 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:33:44 INFO - PROCESS | 19185 | console.error: PushService: 08:33:44 INFO - PROCESS | 19185 | stateChangeProcessEnqueue: Error transitioning state 08:33:44 INFO - PROCESS | 19185 | UnknownError 08:33:44 INFO - TEST-INFO | 19185: exit 0 08:33:44 INFO - Browser initialized. 08:33:44 INFO - Running cycle 1/1 for kraken test... 08:33:44 INFO - TEST-INFO | started process 19278 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpdgAdNl/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:33:56 INFO - PROCESS | 19278 | RSS: Main: 142651392 08:33:56 INFO - PROCESS | 19278 | 08:33:59 INFO - PROCESS | 19278 | Cycle 1(1): loaded http://localhost:41336/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:41336/tests/kraken/driver.html?testName=audio-beat-detection) 08:33:59 INFO - PROCESS | 19278 | RSS: Main: 186241024 08:33:59 INFO - PROCESS | 19278 | 08:34:02 INFO - PROCESS | 19278 | Cycle 1(1): loaded http://localhost:41336/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:41336/tests/kraken/driver.html?testName=audio-dft) 08:34:03 INFO - PROCESS | 19278 | RSS: Main: 173608960 08:34:03 INFO - PROCESS | 19278 | 08:34:05 INFO - PROCESS | 19278 | Cycle 1(1): loaded http://localhost:41336/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:41336/tests/kraken/driver.html?testName=audio-fft) 08:34:06 INFO - PROCESS | 19278 | RSS: Main: 265269248 08:34:06 INFO - PROCESS | 19278 | 08:34:08 INFO - PROCESS | 19278 | Cycle 1(1): loaded http://localhost:41336/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:41336/tests/kraken/driver.html?testName=audio-oscillator) 08:34:09 INFO - PROCESS | 19278 | RSS: Main: 171278336 08:34:09 INFO - PROCESS | 19278 | 08:34:11 INFO - PROCESS | 19278 | Cycle 1(1): loaded http://localhost:41336/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:41336/tests/kraken/driver.html?testName=imaging-gaussian-blur) 08:34:11 INFO - PROCESS | 19278 | RSS: Main: 172961792 08:34:11 INFO - PROCESS | 19278 | 08:34:14 INFO - PROCESS | 19278 | Cycle 1(1): loaded http://localhost:41336/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:41336/tests/kraken/driver.html?testName=imaging-darkroom) 08:34:15 INFO - PROCESS | 19278 | RSS: Main: 209342464 08:34:15 INFO - PROCESS | 19278 | 08:34:18 INFO - PROCESS | 19278 | Cycle 1(1): loaded http://localhost:41336/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:41336/tests/kraken/driver.html?testName=imaging-desaturate) 08:34:19 INFO - PROCESS | 19278 | RSS: Main: 207962112 08:34:19 INFO - PROCESS | 19278 | 08:34:22 INFO - PROCESS | 19278 | Cycle 1(1): loaded http://localhost:41336/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:41336/tests/kraken/driver.html?testName=json-parse-financial) 08:34:22 INFO - PROCESS | 19278 | RSS: Main: 207781888 08:34:22 INFO - PROCESS | 19278 | 08:34:24 INFO - PROCESS | 19278 | Cycle 1(1): loaded http://localhost:41336/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:41336/tests/kraken/driver.html?testName=json-stringify-tinderbox) 08:34:24 INFO - PROCESS | 19278 | RSS: Main: 169693184 08:34:24 INFO - PROCESS | 19278 | 08:34:26 INFO - PROCESS | 19278 | Cycle 1(1): loaded http://localhost:41336/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:41336/tests/kraken/driver.html?testName=stanford-crypto-aes) 08:34:27 INFO - PROCESS | 19278 | RSS: Main: 177328128 08:34:27 INFO - PROCESS | 19278 | 08:34:28 INFO - PROCESS | 19278 | Cycle 1(1): loaded http://localhost:41336/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:41336/tests/kraken/driver.html?testName=stanford-crypto-ccm) 08:34:29 INFO - PROCESS | 19278 | RSS: Main: 187219968 08:34:29 INFO - PROCESS | 19278 | 08:34:32 INFO - PROCESS | 19278 | Cycle 1(1): loaded http://localhost:41336/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:41336/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 08:34:32 INFO - PROCESS | 19278 | RSS: Main: 188448768 08:34:32 INFO - PROCESS | 19278 | 08:34:35 INFO - PROCESS | 19278 | Cycle 1(1): loaded http://localhost:41336/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:41336/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 08:34:36 INFO - PROCESS | 19278 | RSS: Main: 190967808 08:34:36 INFO - PROCESS | 19278 | 08:34:37 INFO - PROCESS | 19278 | Cycle 1(1): loaded http://localhost:41336/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:41336/tests/kraken/driver.html?testName=ai-astar) 08:34:37 INFO - PROCESS | 19278 | RSS: Main: 239923200 08:34:37 INFO - PROCESS | 19278 | 08:34:37 INFO - PROCESS | 19278 | __start_tp_report 08:34:37 INFO - PROCESS | 19278 | _x_x_mozilla_page_load 08:34:37 INFO - PROCESS | 19278 | _x_x_mozilla_page_load_details 08:34:37 INFO - PROCESS | 19278 | |i|pagename|runs| 08:34:37 INFO - PROCESS | 19278 | |0;ai-astar;111;112;111;110;113;113;111;110;111;111 08:34:37 INFO - PROCESS | 19278 | |1;audio-beat-detection;147;120;118;166;120;123;119;122;154;119 08:34:37 INFO - PROCESS | 19278 | |2;audio-dft;160;161;160;161;161;160;160;161;161;162 08:34:37 INFO - PROCESS | 19278 | |3;audio-fft;74;75;76;117;76;76;77;74;97;76 08:34:37 INFO - PROCESS | 19278 | |4;audio-oscillator;82;82;106;81;82;82;99;82;82;107 08:34:37 INFO - PROCESS | 19278 | |5;imaging-gaussian-blur;117;116;116;116;117;117;117;117;118;118 08:34:37 INFO - PROCESS | 19278 | |6;imaging-darkroom;146;145;146;146;146;146;146;146;145;145 08:34:37 INFO - PROCESS | 19278 | |7;imaging-desaturate;94;94;96;95;95;95;96;95;95;94 08:34:37 INFO - PROCESS | 19278 | |8;json-parse-financial;49;50;48;49;50;49;50;48;48;49 08:34:37 INFO - PROCESS | 19278 | |9;json-stringify-tinderbox;59;59;65;58;59;59;58;58;59;59 08:34:37 INFO - PROCESS | 19278 | |10;stanford-crypto-aes;73;74;81;74;73;82;74;74;73;83 08:34:37 INFO - PROCESS | 19278 | |11;stanford-crypto-ccm;132;131;119;130;119;122;128;122;151;138 08:34:37 INFO - PROCESS | 19278 | |12;stanford-crypto-pbkdf2;156;153;151;151;156;154;156;155;151;157 08:34:37 INFO - PROCESS | 19278 | |13;stanford-crypto-sha256-iterative;65;63;62;61;61;61;62;61;61;63 08:34:37 INFO - PROCESS | 19278 | __end_tp_report 08:34:37 INFO - PROCESS | 19278 | __start_cc_report 08:34:37 INFO - PROCESS | 19278 | _x_x_mozilla_cycle_collect,1532 08:34:37 INFO - PROCESS | 19278 | __end_cc_report 08:34:37 INFO - PROCESS | 19278 | __startTimestamp1479486877897__endTimestamp 08:34:37 INFO - PROCESS | 19278 | 08:34:37 INFO - PROCESS | 19278 | ------- Summary: start ------- 08:34:37 INFO - PROCESS | 19278 | Number of tests: 14 08:34:37 INFO - PROCESS | 19278 | 08:34:37 INFO - PROCESS | 19278 | [#0] ai-astar Cycles:10 Average:111.30 Median:111.00 stddev:1.06 (1.0%) stddev-sans-first:1.12 08:34:37 INFO - PROCESS | 19278 | Values: 111.0 112.0 111.0 110.0 113.0 113.0 111.0 110.0 111.0 111.0 08:34:37 INFO - PROCESS | 19278 | 08:34:37 INFO - PROCESS | 19278 | [#1] audio-beat-detection Cycles:10 Average:130.80 Median:122.50 stddev:17.81 (14.5%) stddev-sans-first:17.90 08:34:37 INFO - PROCESS | 19278 | Values: 147.0 120.0 118.0 166.0 120.0 123.0 119.0 122.0 154.0 119.0 08:34:37 INFO - PROCESS | 19278 | 08:34:37 INFO - PROCESS | 19278 | [#2] audio-dft Cycles:10 Average:160.70 Median:161.00 stddev:0.67 (0.4%) stddev-sans-first:0.67 08:34:37 INFO - PROCESS | 19278 | Values: 160.0 161.0 160.0 161.0 161.0 160.0 160.0 161.0 161.0 162.0 08:34:37 INFO - PROCESS | 19278 | 08:34:37 INFO - PROCESS | 19278 | [#3] audio-fft Cycles:10 Average:81.80 Median:76.00 stddev:14.12 (18.6%) stddev-sans-first:14.70 08:34:37 INFO - PROCESS | 19278 | Values: 74.0 75.0 76.0 117.0 76.0 76.0 77.0 74.0 97.0 76.0 08:34:37 INFO - PROCESS | 19278 | 08:34:37 INFO - PROCESS | 19278 | [#4] audio-oscillator Cycles:10 Average:88.50 Median:82.00 stddev:10.90 (13.3%) stddev-sans-first:11.30 08:34:37 INFO - PROCESS | 19278 | Values: 82.0 82.0 106.0 81.0 82.0 82.0 99.0 82.0 82.0 107.0 08:34:37 INFO - PROCESS | 19278 | 08:34:37 INFO - PROCESS | 19278 | [#5] imaging-gaussian-blur Cycles:10 Average:116.90 Median:117.00 stddev:0.74 (0.6%) stddev-sans-first:0.78 08:34:37 INFO - PROCESS | 19278 | Values: 117.0 116.0 116.0 116.0 117.0 117.0 117.0 117.0 118.0 118.0 08:34:37 INFO - PROCESS | 19278 | 08:34:37 INFO - PROCESS | 19278 | [#6] imaging-darkroom Cycles:10 Average:145.70 Median:146.00 stddev:0.48 (0.3%) stddev-sans-first:0.50 08:34:37 INFO - PROCESS | 19278 | Values: 146.0 145.0 146.0 146.0 146.0 146.0 146.0 146.0 145.0 145.0 08:34:37 INFO - PROCESS | 19278 | 08:34:37 INFO - PROCESS | 19278 | [#7] imaging-desaturate Cycles:10 Average:94.90 Median:95.00 stddev:0.74 (0.8%) stddev-sans-first:0.71 08:34:37 INFO - PROCESS | 19278 | Values: 94.0 94.0 96.0 95.0 95.0 95.0 96.0 95.0 95.0 94.0 08:34:37 INFO - PROCESS | 19278 | 08:34:37 INFO - PROCESS | 19278 | [#8] json-parse-financial Cycles:10 Average:49.00 Median:49.00 stddev:0.82 (1.7%) stddev-sans-first:0.87 08:34:37 INFO - PROCESS | 19278 | Values: 49.0 50.0 48.0 49.0 50.0 49.0 50.0 48.0 48.0 49.0 08:34:37 INFO - PROCESS | 19278 | 08:34:37 INFO - PROCESS | 19278 | [#9] json-stringify-tinderbox Cycles:10 Average:59.30 Median:59.00 stddev:2.06 (3.5%) stddev-sans-first:2.18 08:34:37 INFO - PROCESS | 19278 | Values: 59.0 59.0 65.0 58.0 59.0 59.0 58.0 58.0 59.0 59.0 08:34:37 INFO - PROCESS | 19278 | 08:34:37 INFO - PROCESS | 19278 | [#10] stanford-crypto-aes Cycles:10 Average:76.10 Median:74.00 stddev:4.12 (5.6%) stddev-sans-first:4.22 08:34:37 INFO - PROCESS | 19278 | Values: 73.0 74.0 81.0 74.0 73.0 82.0 74.0 74.0 73.0 83.0 08:34:37 INFO - PROCESS | 19278 | 08:34:37 INFO - PROCESS | 19278 | [#11] stanford-crypto-ccm Cycles:10 Average:129.20 Median:130.50 stddev:9.87 (7.6%) stddev-sans-first:10.42 08:34:37 INFO - PROCESS | 19278 | Values: 132.0 131.0 119.0 130.0 119.0 122.0 128.0 122.0 151.0 138.0 08:34:37 INFO - PROCESS | 19278 | 08:34:37 INFO - PROCESS | 19278 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:154.00 Median:155.50 stddev:2.36 (1.5%) stddev-sans-first:2.39 08:34:37 INFO - PROCESS | 19278 | Values: 156.0 153.0 151.0 151.0 156.0 154.0 156.0 155.0 151.0 157.0 08:34:37 INFO - PROCESS | 19278 | 08:34:37 INFO - PROCESS | 19278 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:62.00 Median:62.00 stddev:1.33 (2.2%) stddev-sans-first:0.87 08:34:37 INFO - PROCESS | 19278 | Values: 65.0 63.0 62.0 61.0 61.0 61.0 62.0 61.0 61.0 63.0 08:34:37 INFO - PROCESS | 19278 | -------- Summary: end -------- 08:34:37 INFO - PROCESS | 19278 | 08:34:38 INFO - TEST-INFO | 19278: exit 0 08:34:38 INFO - TEST-OK | kraken | took 58641ms 08:34:38 INFO - SUITE-END | took 1170s 08:34:39 INFO - Completed test suite (00:19:31) 08:34:39 INFO - javascript benchmark 08:34:39 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3102.053873568562, 3138.9843050784743, 3148.9212769680753, 3156.9210769730767, 3180.9363812723745, 5518.4205658405845, 5535.944640553594, 5551.528120109785, 5560.721963901804, 5566.638168519048, 5553.944460555394, 5560.7219639018085, 5572.5263352614975, 5582.302212223472, 5593.412691667378, 5084.593232541406, 5091.032703786269, 5118.513741194581, 5135.05001574708, 5168.638195326329, 4978.2532620107095, 4980.501949805027, 5118.6416950813455, 5177.792888284483, 5213.3743950725775, 4951.628627852925, 4977.776000080005, 5038.168702164138, 5043.5965122790085, 5045.495450454961, 5128.974355128238, 5218.921716174261, 5226.503482169188, 5231.476852314776, 5256.526912577848, 4901.1177987962155, 4904.092742842586, 5109.565686916617, 5120.3855537335385, 5164.767585458626, 5429.348478182644, 5516.0, 5536.75084621193, 5540.279763630702, 5547.25112109864, 5948.31594366649, 5990.311114221877, 5992.041273396279, 5996.370381110008, 5997.850053748648, 5705.800296989627, 5797.159411885295, 6027.397260273981, 6039.54703397247, 6042.758289668452, 5305.018571564273, 5501.092319767234, 5506.339239291271, 5552.08390615548, 5574.832755017356, 6096.3903609639565, 6098.878022439615, 6103.877922441527, 6104.3590423005835, 6107.603005804608, 5631.915521267184, 5860.912086318709, 5864.413558644102, 5873.295204575478, 5875.29496460419, 5675.0636145035605, 5899.67551784656, 5931.9703401483575, 5934.43622855828, 5999.460048595647, 5925.644461332334, 5975.0, 5975.850603734942, 5993.3706960768495, 5993.820185394445, 5948.048312270016, 5950.196723442366, 5996.16053752475, 6010.579259451796, 6046.516278697693, 4449.532799056117, 4465.687401881837, 4481.641468682497, 4514.503404625489, 4514.68397212192, 4042.4542686737504, 4044.737092089005, 4048.1296521248073, 4071.6131967463043, 4073.06319546506, 5616.185653080281, 5617.550595952396, 5619.0, 5621.353544342372, 5655.0, 5745.080787074048, 5843.678597677169, 5877.823665290048, 5882.764689412461, 5912.201852749824, 5772.134179873053, 5781.103928891029, 5786.132080188006, 5792.88414231713, 5810.88378232433, 5080.720560369141, 5082.796688132507, 5084.847454576368, 5085.567726743194, 5138.948610513922, 5924.11138329254, 6056.06131049688, 6097.847553811012, 6234.532410069263, 6259.2488901332135, 5891.734871930687, 5996.340402555803, 5998.370171131968, 6002.519798416203, 6013.488853447506, 6157.230346206724, 6208.379162083756, 6209.720562574786, 6218.22272215973, 6221.657808820558, 5620.437956204347, 5639.548836093185, 5897.174395584536, 5900.616459930091, 5902.675352855634, 5963.194968679346, 5989.670568118795, 6002.639841609517, 6059.21230240066, 6096.390360963868, 5897.764089436546, 5907.438793314628, 5916.940830591639, 5927.170196172453, 5936.465718085393, 5585.469380408855, 5907.143464197753, 5911.142884281841, 5915.615484993462, 5918.970405147947, 5686.402927692533, 5699.0, 5721.628094173865, 5753.3958934311295, 5842.036064049555, 5812.709364531672, 5824.737886795189, 5855.970720146543, 5856.560757943086, 5862.765489380377, 5551.694656793915, 5608.10270356741, 5722.856928576819, 5730.484256416942, 5734.2258795062135], "value": 5484.526077380581, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [584.2025635008213, 609.2567068176824, 642.2838535033437, 647.4852492268649, 650.39513252675, 34535.65464345359, 46441.30338044932, 47769.0, 47848.52151478489, 51682.48317516833, 47263.527364726346, 47796.52203477973, 47879.76060119695, 47879.760601197035, 47881.76059119708, 8524.0, 9401.576929038176, 9580.0898914603, 9599.904000960007, 9603.4718090505, 8381.916180838205, 10891.67324980248, 11167.16246281528, 11180.664580062612, 11549.711257218594, 11521.2511186773, 11582.362970036645, 11587.884121158808, 11595.0, 11595.478203480863, 11357.829632555518, 11412.258203216765, 11431.828522572127, 11443.542258309657, 11445.771084578304, 11232.550697972072, 11233.66299011031, 11244.437778111143, 11272.380019098946, 11283.0, 44772.328415073796, 44940.3258951116, 45099.0, 45219.54780452186, 45240.0, 3851.1527463957887, 3875.3218186817476, 4460.977695111536, 4534.13851368239, 4563.178627846986, 33959.66040339614, 34067.31865362704, 34315.48526772101, 34373.0, 35828.0, 4285.700000999931, 4329.891752706176, 4381.07997320563, 4414.139242847646, 4463.0, 340160.0, 340546.0, 341244.0, 341409.0, 341462.0, 35003.4749478758, 65266.0, 65521.0, 65523.672381637785, 65688.34311656823, 41921.580784192374, 41994.37008444876, 42218.0, 42232.366514502304, 42235.7888210557, 18095.0, 18142.09289535518, 18280.90859545694, 18290.542736431697, 18294.817051829312, 12477.064220183522, 12707.936460317824, 14045.227512486912, 15444.0, 15529.22353882324, 9575.473348965874, 9651.613935442503, 9735.41587504752, 9756.609735610638, 9789.755256118511, 3596.2088340565033, 3653.47024681425, 3678.301122786662, 3682.9263414731554, 3706.610805865399, 1081.5241293830848, 1100.3892839474008, 1122.6744244169263, 1136.017344996572, 1154.463174623804, 33783.66216337854, 34166.14584635404, 34242.0, 34535.654643453745, 34609.48085778715, 1088.646189988257, 1135.5684839761004, 1143.7026373142876, 1194.964151075469, 1207.4325067218392, 18366.62321251066, 18716.812831871506, 18914.621707566046, 19942.20231190765, 20037.0, 578806.0, 587755.0, 589508.0, 600742.0, 875233.0, 65025.34974650193, 65755.34244657587, 65781.0, 65943.34056659372, 65998.34001659922, 1347.7035052288677, 1392.7562676531566, 1406.21252098825, 1451.2235953764684, 1469.6105532033805, 32600.83699581487, 34737.65262347344, 35250.294994100484, 35378.82310588431, 35522.111947200494, 55035.0, 66544.0, 67872.6606366965, 67898.66050669715, 68041.3195868035, 375500.0, 382384.0, 384070.0, 526705.0, 528386.0, 43614.0, 43655.78172109119, 48665.75667121642, 49682.254766179256, 50042.49957500524, 52701.20948185857, 53920.46079539155, 54841.1773823385, 54983.45016549943, 55772.04797832057, 45056.09887802291, 46050.53949460462, 46375.76812115918, 48181.0, 48251.75874120607, 46198.53801461942, 46319.76840115778, 46436.0, 46467.76766116148, 46654.30018549656, 44753.77623111994, 45664.31503527383, 45829.0, 45922.0, 46079.308810368544, 39015.60984390233, 40286.0, 40855.59144408637, 40920.0, 41758.37362439626, 30187.0, 30455.39089218159, 30643.080707578807, 30713.692863071083, 31029.379412412076], "value": 21354.813686319434, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [414.6392638404587, 419.54060303967145, 428.8949207444177, 431.3594312446018, 441.11556329559227, 19352.419427417182, 19714.901425492888, 21008.36974890752, 21202.469938251514, 21335.0, 17793.110344482757, 18575.628487430244, 19367.903160484213, 19497.317593884218, 20495.487612809688, 5340.332458442685, 5570.275864137657, 5583.190437386596, 5584.553235741151, 5587.636803607773, 5522.5581953443825, 5604.075327570967, 5611.046122159243, 5616.0, 6159.538034647397, 6159.291681456645, 6160.383961603826, 6161.168242287301, 6164.722587483574, 6166.630002199882, 5933.317668468117, 6160.5687601867885, 6165.568410211287, 6168.722407491674, 6224.253089629228, 6129.0, 6139.89481893259, 6142.477889379408, 6143.3242343342645, 6143.416375444371, 15434.45979390716, 16494.010359378477, 22305.776942230532, 24300.27099187027, 24472.388190295205, 2538.1624064058815, 2574.7940164786773, 2588.5081834451394, 2811.7610003149757, 3130.1392117167734, 11765.176437649368, 12341.62975110748, 15304.0, 15680.0, 15869.047857128493, 2046.0894901768718, 2075.813176814079, 2090.372888133569, 2098.8530802843807, 2284.6116160252795, 91699.0, 92018.5399073007, 92035.53982230046, 92671.53664231703, 93674.06325936722, 11776.470058847372, 11829.940850295694, 11906.0, 12375.876241237653, 12459.19015264023, 17609.38367157169, 17614.647707046042, 17640.117994100245, 17656.55858603545, 17658.91170544139, 9208.723738287728, 9210.493422861673, 9244.0, 9369.48467834262, 9405.20055795265, 9072.319576031825, 9080.091990801, 9106.544672766335, 9113.817723645623, 9316.673916413029, 5235.110031294689, 5241.24002019705, 5278.656887302313, 5329.1206950852675, 5347.171188465794, 2105.6420408530585, 2107.5574129432684, 2155.773643767382, 2157.223399576151, 2160.1899287767087, 942.79258563116, 989.4805227255605, 1011.544804837826, 1046.4506134279563, 1050.8791488978866, 20582.38252852417, 20750.169993200405, 20774.792252077586, 20800.687989680166, 21092.156313747586, 1034.9689509314733, 1045.2526443592867, 1047.0890325416935, 1052.810494111052, 1099.6975831646362, 10731.356118632906, 11617.128715346384, 11673.182877198684, 11748.70628234301, 11889.464974076187, 360751.0, 366572.0, 366610.0, 478238.0, 495862.0, 88630.0, 102594.0, 104871.95128048774, 106411.46794266134, 107672.0, 1064.984025239622, 1066.7706443114769, 1111.1666250312267, 1117.1063149480383, 1120.624590762104, 18282.542936426697, 18482.168302426693, 18641.813581864008, 18861.434156975312, 18866.151023204264, 29459.55810662799, 31938.0, 45324.32013519734, 47482.0, 48100.5189948096, 60252.0, 60427.395726043935, 60483.0, 61042.69478652578, 63548.0, 9163.221126204347, 9372.578233979351, 9432.717018489457, 9564.521773911416, 9685.0, 13884.722305554034, 14455.349509271897, 14486.275686215437, 14546.927265363605, 14979.625509362353, 12121.636350909486, 12231.204971677169, 12234.632961011184, 12309.26144431337, 12340.136190466581, 12008.579699710468, 12222.877771222174, 12414.193077449936, 12534.0, 12646.241225526497, 12667.366631668196, 12701.745965080461, 12749.681257968625, 12778.68053298675, 12933.288669123289, 9251.86122208154, 9251.93602735694, 9453.952730236304, 9484.620615175316, 9563.665271715734, 12073.469994794497, 12586.811197831857, 12653.936730316289, 12914.806277906027, 12922.741545169232], "value": 9890.426994382506, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1362.863713628638, 1520.8631223189911, 1560.6410525579115, 1685.915704214789, 1815.1922394534422, 8106.0, 8641.91358086419, 8968.0, 9387.389819661717, 9404.71785846424, 9368.672096476625, 9464.66873659422, 9468.0, 9474.478903660296, 9478.952605236964, 2513.962290565643, 2533.8479691218586, 2539.0478570536047, 2543.4277287610325, 2544.580144276192, 2426.4904370082218, 2470.641756945242, 2487.0424886418677, 2494.289127598635, 2497.425592113815, 2486.254123762873, 2494.9251522454265, 2542.2119143065615, 2546.5161619292276, 2551.4386834896295, 2440.633904914268, 2442.5237078769646, 2456.238566044532, 2479.429731161843, 2487.962680559775, 2427.5509030829353, 2450.6691596634582, 2467.1611652038214, 2474.2824580871525, 2476.182859656309, 9208.769780755467, 9314.44113353201, 9375.10936461035, 9379.906200937972, 9393.20157786589, 5594.9720251398885, 5780.595358324919, 5795.130730390433, 5878.323992740847, 5886.7939622113445, 3468.843902024415, 3500.929981400383, 3509.543759311299, 3542.6103128655827, 3574.3566158091535, 1124.2299025167786, 1137.5734099712608, 1141.4920360439608, 1148.4831825678477, 1148.494662348564, 12729.427175777113, 12747.936260318638, 12820.743585128339, 12822.487100515875, 12832.294223817686, 4913.115639184981, 4913.484084171182, 4992.201247800334, 5054.0, 5117.181250999822, 9992.80014399708, 9995.300328977048, 10000.499975001221, 10003.599856005678, 10007.949960250298, 5752.309722833287, 5768.048272035151, 5772.04761214395, 5773.624714393551, 5775.364709881909, 4591.288350305708, 4592.7933243004145, 4611.792469338888, 4721.858344249678, 5387.434319396407, 4124.752514849119, 4190.601892820177, 4296.162248361539, 4301.935470967938, 4337.0, 1292.069709808936, 1301.1217428235902, 1316.1971197569476, 1319.5051855554168, 1321.0818481155504, 974.8635191073255, 977.9706608801747, 1032.8244198486275, 1044.3420644993605, 1049.4070849969742, 6222.719977600928, 6284.780032698834, 6445.0, 6489.5781774184525, 6565.24499682533, 964.5707660091332, 982.8820541534918, 1015.1472762879217, 1026.8767747870304, 1027.6762819711766, 4366.214081465367, 4552.248878934939, 4581.839635612738, 4600.631949444037, 4602.792874320664, 11379.886201138048, 11705.590304339306, 11870.643880683594, 11878.88121118795, 11884.346360950058, 11500.424978751029, 11517.193796434169, 11613.30320180792, 11722.355270460035, 11742.119341049456, 8704.0, 8785.912140878509, 8786.209241168326, 8827.911720882708, 8872.290216782641, 6286.5599408041, 6300.21247344082, 6393.7122829471855, 6482.448991835747, 6504.1219435375615, 10054.245931555017, 10463.319884207502, 10509.159267258448, 10514.053735163872, 10798.568057277935, 9622.566984485855, 9912.603495860085, 10623.0, 10788.352698838095, 10945.781084378108, 8443.07126216128, 8543.359248056297, 8547.487150770974, 8749.343799214957, 8808.20726134651, 8885.689000884939, 8976.461412315282, 9186.0, 9215.262778977532, 9230.861537076815, 8079.515229086273, 8090.919090809252, 8139.389545784208, 8299.08710041907, 8373.748787536384, 7968.601569921597, 8165.755027348951, 8169.0605580359015, 8183.345332373515, 8327.0, 7419.1467981180695, 7431.0, 7507.324340809353, 7515.13575938774, 7560.395168386406, 4696.788644510937, 5441.891162176655, 5635.88728225425, 5702.230198923258, 5727.255456790591, 5694.743736531783, 5696.971515142398, 5809.767609295581, 5822.5633077518505, 5954.10688396744], "value": 4923.671113211973, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [346.58063742871127, 353.9275993738971, 363.9235760490297, 364.0117082122038, 369.6396013886461, 5620.156976453529, 5621.550275977922, 5626.54987600992, 5630.802921897734, 5632.5212356949705, 5522.337319521663, 5524.530414914727, 5550.0, 5569.384878385264, 5586.050371436855, 4221.430106935562, 4356.1723272578265, 4390.69265151438, 4393.165298593273, 4408.933865992013, 4353.737416149313, 4354.8911277218, 4367.737935723851, 4368.126374725051, 4372.256716358227, 4323.200207961521, 4330.415393921828, 4339.349097635364, 4365.450265155871, 4388.626966707834, 4115.876523704279, 4312.5903039211225, 4313.460817397825, 4331.523532411432, 4369.279068953619, 3806.257779732953, 3821.9617803821884, 3822.0, 3822.6750726188307, 3839.9808000960097, 5342.626016178869, 5357.7589008494715, 5364.785408583652, 5366.4096949335935, 5387.380451248117, 4833.854984350475, 4884.365032545782, 4900.093482705675, 4931.605471562267, 4954.752262386866, 5718.571107166979, 5734.512566431858, 5738.856528586777, 5743.190894868103, 5746.25298711169, 4186.5604111568155, 4190.5180904195795, 4192.371144328345, 4194.28697121487, 4195.643370313527, 5676.744546495418, 5907.261592300963, 5950.523958083386, 5969.507623094227, 5984.311804142492, 4267.743935363888, 4270.231358355463, 4271.316589345752, 4275.251830929575, 4276.593723596254, 4331.7834108294455, 4342.392065110887, 4345.0, 4380.6057454829215, 4385.890352741207, 4659.673822832369, 4855.757212139379, 4892.730899800546, 4902.48523904992, 4918.90162196754, 5724.427557244326, 5751.511121554631, 5754.7556452982535, 5786.42135786418, 5794.362620111784, 1473.5652982370227, 1503.3385310463361, 1505.2774668159127, 1507.5778781941074, 1509.8339182689895, 957.3203025851584, 972.8540718892223, 982.8009828009816, 1034.6895931220604, 1041.54172164249, 5600.467955544217, 5623.284898106035, 5635.21107045014, 5647.757493351456, 5649.265595472562, 5883.470487656132, 5889.38161493037, 5910.261217347832, 5912.9113063304085, 5920.851978700481, 5412.485813847678, 5682.40334764852, 5690.317161940594, 5730.283714535683, 5732.742026608813, 3131.2798056447145, 3133.326334837975, 3151.16494129056, 3158.7630927680516, 3160.241542029896, 5861.413858614104, 6089.238845144357, 6112.480439162632, 6155.692215389213, 6177.752889884354, 5782.710864456844, 6012.879742405127, 6060.212172417558, 6064.332923378425, 6066.150738896558, 5983.371745966698, 5998.850028749229, 6117.418845209698, 6162.26052873649, 6162.691865406801, 5969.940300596939, 5971.164037034905, 5985.970070149621, 5992.460678538952, 5998.390700045494, 5574.275344205227, 5821.359650438533, 5892.558058145742, 5893.2044174035955, 5895.7052147391605, 6162.506999439945, 6183.659898705614, 6197.993972923038, 6205.169475004795, 6210.534209934182, 4092.69304802147, 4297.52727200014, 4320.027993701392, 4327.663061946514, 4329.285667864893, 5908.438698323653, 5914.704264786657, 5914.940850591439, 5935.317438494629, 5951.672658003851, 5702.2016917630735, 5783.421657834183, 5789.9710501447225, 5803.738831752666, 5853.385394533512, 5591.0, 5756.597038207286, 5757.481826635623, 5760.135979603093, 5783.508401785895, 5747.281589801275, 5749.252597162342, 5750.166225897305, 5757.437940116608, 5770.740316685843, 5587.888242235052, 5752.741126649227, 5802.187693722798, 5803.82588522345, 5824.475797178275, 5629.493345598916, 5664.660120392789, 5702.51528620072, 5705.22979397776, 5706.572007099401], "value": 4437.05794733, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [808.6724876425046, 823.851706692795, 849.6813694864426, 880.3045593980755, 891.1445012787724, 16225.675486490263, 16819.15904204791, 17177.57056073599, 17210.827891721063, 17214.655706885856, 15989.280482378292, 16147.43483978061, 16168.514944551653, 16169.272382742776, 16195.676086478263, 691.3397705191543, 714.8748968930443, 825.4634487583089, 852.0244320253306, 852.2202185000717, 840.9159084091604, 843.3211264931758, 843.5191940593865, 843.6709683223547, 848.8259906719138, 893.8837951066353, 894.5974311559792, 896.0099090504996, 896.3904544909492, 896.8385690575694, 885.8804061451686, 888.9777755556163, 889.2574700125404, 889.386323436833, 889.6485888074207, 661.3320546248276, 661.5104822431366, 662.2648859765657, 662.7779693802582, 662.8376047868255, 16466.0, 16467.505974820655, 16501.0, 16501.257443415074, 16511.09188994605, 14173.149611023371, 15485.127744062314, 15592.532224033184, 15860.920695396564, 15972.041677499386, 12913.160644558167, 13108.0, 13137.671558211026, 13391.732165356736, 13748.862511374859, 4225.598568136023, 4271.530131685512, 4323.502797178333, 4413.249747542925, 4493.213687604656, 70955.64522177356, 73511.26488735098, 73936.26063739347, 83362.0, 83714.58142709309, 13265.469381224642, 13543.729125417436, 13558.186508809504, 13560.660983475294, 13605.0, 25162.24513264605, 25586.104486342887, 25594.104206352687, 25613.103541375964, 25653.61519577208, 9662.661806836726, 9671.50091735782, 9898.455584942752, 10041.447720375449, 10498.265121441578, 4893.926591101136, 5001.7499125043605, 5108.744562771846, 5151.407588127338, 5173.0688476074665, 4011.438398624195, 4084.4281800547947, 4117.75293482392, 4118.9588104118575, 4128.545859955402, 698.2040473859804, 702.8594281143792, 703.6244142701007, 713.4684659928283, 718.270954980695, 619.3187493756922, 772.9603683046294, 782.6438970268514, 833.6332013913858, 843.4053991935671, 9721.270904682036, 10321.535530901128, 10670.146388288918, 10849.620263290746, 11140.61007864737, 741.036652351951, 778.4939789136993, 802.3500964219002, 833.2500749325534, 853.4793775796883, 5066.36670416198, 5424.593155513352, 5491.423400542965, 5494.945050549523, 5514.5864060195645, 70828.58342833114, 74800.0, 74838.6258068717, 74941.0, 98129.0, 106364.46817765862, 110698.44650776694, 113189.43405282921, 113603.43198283955, 115404.0, 90308.0, 94314.0, 94854.52572737093, 97055.51472242594, 98376.50811746038, 9867.629362214384, 10107.090361867467, 10290.17312850529, 10368.688939331832, 10425.478726063515, 55568.72215638896, 55614.0, 56132.15801763059, 56326.0, 56666.15000774909, 78082.0, 83602.16397835944, 85107.57446212976, 85170.57414712886, 88355.0, 11843.407829608657, 12325.69185770327, 12372.4432400544, 12508.624741257778, 12872.16330938486, 15083.622909427351, 15387.0, 15590.76613850816, 16296.837031629531, 16477.67044659124, 14358.712825743636, 14508.854911451173, 15547.611309717347, 15734.291956862198, 15746.370145194063, 14680.926595366955, 15349.462768803038, 15718.371265149266, 15744.370225190863, 16364.918175409046, 14491.347889344794, 14854.0, 14856.40574377056, 15170.089794612359, 15269.083854968294, 12776.977841772821, 12804.423800928795, 12903.354832258537, 13669.179849209078, 13711.794323084961, 12673.80989285143, 12689.302088385228, 12900.806487902877, 13093.803592945922, 13282.203067815963], "value": 8195.541094814173, "unit": "score"}], "name": "dromaeo_css", "value": 7693.830004013702, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 112.0, 111.0, 110.0, 113.0, 113.0, 111.0, 110.0, 111.0, 111.0], "value": 111.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 120.0, 118.0, 166.0, 120.0, 123.0, 119.0, 122.0, 154.0, 119.0], "value": 130.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 161.0, 160.0, 161.0, 161.0, 160.0, 160.0, 161.0, 161.0, 162.0], "value": 160.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 75.0, 76.0, 117.0, 76.0, 76.0, 77.0, 74.0, 97.0, 76.0], "value": 81.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 82.0, 106.0, 81.0, 82.0, 82.0, 99.0, 82.0, 82.0, 107.0], "value": 88.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 116.0, 116.0, 116.0, 117.0, 117.0, 117.0, 117.0, 118.0, 118.0], "value": 116.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 145.0, 146.0, 146.0, 146.0, 146.0, 146.0, 146.0, 145.0, 145.0], "value": 145.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 96.0, 95.0, 95.0, 95.0, 96.0, 95.0, 95.0, 94.0], "value": 94.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [49.0, 50.0, 48.0, 49.0, 50.0, 49.0, 50.0, 48.0, 48.0, 49.0], "value": 49.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 59.0, 65.0, 58.0, 59.0, 59.0, 58.0, 58.0, 59.0, 59.0], "value": 59.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 74.0, 81.0, 74.0, 73.0, 82.0, 74.0, 74.0, 73.0, 83.0], "value": 76.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [132.0, 131.0, 119.0, 130.0, 119.0, 122.0, 128.0, 122.0, 151.0, 138.0], "value": 129.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [156.0, 153.0, 151.0, 151.0, 156.0, 154.0, 156.0, 155.0, 151.0, 157.0], "value": 154.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 63.0, 62.0, 61.0, 61.0, 61.0, 62.0, 61.0, 61.0, 63.0], "value": 62.0, "unit": "score"}], "name": "kraken", "value": 1460.2, "alertThreshold": 2.0}]} 08:34:39 INFO - Return code: 0 08:34:39 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 08:34:39 INFO - # TBPL SUCCESS # 08:34:39 INFO - Running post-action listener: _resource_record_post_action 08:34:39 INFO - [mozharness: 2016-11-18 16:34:39.206226Z] Finished run-tests step (success) 08:34:39 INFO - Running post-run listener: _resource_record_post_run 08:34:39 INFO - Total resource usage - Wall time: 1185s; CPU: 13.0%; Read bytes: 1736704; Write bytes: 315891712; Read time: 40; Write time: 218084 08:34:39 INFO - TinderboxPrint: CPU usage
12.9% 08:34:39 INFO - TinderboxPrint: I/O read bytes / time
1,736,704 / 40 08:34:39 INFO - TinderboxPrint: I/O write bytes / time
315,891,712 / 218,084 08:34:39 INFO - TinderboxPrint: CPU idle
8,239.7 (87.1%) 08:34:39 INFO - TinderboxPrint: CPU user
1,180.1 (12.5%) 08:34:39 INFO - TinderboxPrint: Swap in / out
0 / 0 08:34:39 INFO - install - Wall time: 14s; CPU: 13.0%; Read bytes: 0; Write bytes: 106737664; Read time: 0; Write time: 104396 08:34:39 INFO - run-tests - Wall time: 1172s; CPU: 13.0%; Read bytes: 4096; Write bytes: 209154048; Read time: 8; Write time: 113688 08:34:39 INFO - Running post-run listener: _upload_blobber_files 08:34:39 INFO - Blob upload gear active. 08:34:39 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 08:34:39 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 08:34:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Beta', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 08:34:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Beta -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 08:34:40 INFO - (blobuploader) - INFO - Open directory for files ... 08:34:40 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 08:34:40 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:34:40 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:34:41 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 08:34:41 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:34:41 INFO - (blobuploader) - INFO - Done attempting. 08:34:41 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 08:34:41 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:34:41 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:34:44 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 08:34:44 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:34:44 INFO - (blobuploader) - INFO - Done attempting. 08:34:44 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 08:34:44 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:34:44 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:34:45 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 08:34:45 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:34:45 INFO - (blobuploader) - INFO - Done attempting. 08:34:45 INFO - (blobuploader) - INFO - Iteration through files over. 08:34:45 INFO - Return code: 0 08:34:45 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 08:34:45 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 08:34:45 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/e4e65bb76d864c180376252f9c988c717bdb2df6815d88a3f9941fc2ad57c167e367d90fe583ef3b70b058ba536a0f278b97068329474ac600f185c3607f6381", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/054d1e1371aa6a27081a3fba74e80f71d48cef9c09e05a91914754732a24cca709a6b3951c752de50beeab82b3f18e92d5d4559954c3ec434772b47936a7aac3", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/3fe0972d97103e5e25787fd795bc4bd34dffdceeefea80eb5555cfc451d6fad402060abd258bf2ef3f30a567cd92d75c3dcb12cdbd47bfe6a7b0efe3ba01490b"} 08:34:45 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 08:34:45 INFO - Writing to file /builds/slave/test/properties/blobber_files 08:34:45 INFO - Contents: 08:34:45 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/e4e65bb76d864c180376252f9c988c717bdb2df6815d88a3f9941fc2ad57c167e367d90fe583ef3b70b058ba536a0f278b97068329474ac600f185c3607f6381", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/054d1e1371aa6a27081a3fba74e80f71d48cef9c09e05a91914754732a24cca709a6b3951c752de50beeab82b3f18e92d5d4559954c3ec434772b47936a7aac3", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/3fe0972d97103e5e25787fd795bc4bd34dffdceeefea80eb5555cfc451d6fad402060abd258bf2ef3f30a567cd92d75c3dcb12cdbd47bfe6a7b0efe3ba01490b"} 08:34:45 INFO - Running post-run listener: copy_logs_to_upload_dir 08:34:45 INFO - Copying logs to upload dir... 08:34:45 INFO - mkdir: /builds/slave/test/build/upload/logs 08:34:45 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1228.122214 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 28 secs) (at 2016-11-18 08:34:44.204028) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-18 08:34:44.207509) ========= 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=923d835db2ba3686ebe126b700000192-1479485655.430349-1384074954 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/e4e65bb76d864c180376252f9c988c717bdb2df6815d88a3f9941fc2ad57c167e367d90fe583ef3b70b058ba536a0f278b97068329474ac600f185c3607f6381", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/054d1e1371aa6a27081a3fba74e80f71d48cef9c09e05a91914754732a24cca709a6b3951c752de50beeab82b3f18e92d5d4559954c3ec434772b47936a7aac3", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/3fe0972d97103e5e25787fd795bc4bd34dffdceeefea80eb5555cfc451d6fad402060abd258bf2ef3f30a567cd92d75c3dcb12cdbd47bfe6a7b0efe3ba01490b"} build_url:https://queue.taskcluster.net/v1/task/Ng8QIMzcR6-37ec5joANQQ/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011312 build_url: 'https://queue.taskcluster.net/v1/task/Ng8QIMzcR6-37ec5joANQQ/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/e4e65bb76d864c180376252f9c988c717bdb2df6815d88a3f9941fc2ad57c167e367d90fe583ef3b70b058ba536a0f278b97068329474ac600f185c3607f6381", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/054d1e1371aa6a27081a3fba74e80f71d48cef9c09e05a91914754732a24cca709a6b3951c752de50beeab82b3f18e92d5d4559954c3ec434772b47936a7aac3", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/3fe0972d97103e5e25787fd795bc4bd34dffdceeefea80eb5555cfc451d6fad402060abd258bf2ef3f30a567cd92d75c3dcb12cdbd47bfe6a7b0efe3ba01490b"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-18 08:34:44.233017) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-18 08:34:44.233380) ========= 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=923d835db2ba3686ebe126b700000192-1479485655.430349-1384074954 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004417 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-18 08:34:44.318459) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-18 08:34:44.318841) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-18 08:34:44.319184) ========= ========= Total master_lag: 0.17 =========