builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-001 starttime: 1491430330.82 results: success (0) revision: eb0d361dc73c32867d5fd54dc47733994bd48e7a ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-04-05 15:12:10.815769) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-04-05 15:12:10.816195) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-05 15:12:10.816489) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-05 15:12:10.831397) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-05 15:12:10.831898) ========= 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=8887e36bb8e381bfd44124ac000001a8-1491430329.274012-1664826046 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-04-05 15:12:10-- 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% 111M=0s 2017-04-05 15:12:10 (111 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.093313 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-05 15:12:10.942890) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-05 15:12:10.943253) ========= 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=8887e36bb8e381bfd44124ac000001a8-1491430329.274012-1664826046 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.022226 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-05 15:12:10.992531) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-05 15:12:10.995957) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev eb0d361dc73c32867d5fd54dc47733994bd48e7a --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev eb0d361dc73c32867d5fd54dc47733994bd48e7a --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=8887e36bb8e381bfd44124ac000001a8-1491430329.274012-1664826046 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-04-05 15:12:11,044 truncating revision to first 12 chars 2017-04-05 15:12:11,044 Setting DEBUG logging. 2017-04-05 15:12:11,044 attempt 1/10 2017-04-05 15:12:11,044 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/eb0d361dc73c?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-04-05 15:12:11,613 unpacking tar archive at: mozilla-aurora-eb0d361dc73c/testing/mozharness/ program finished with exit code 0 elapsedTime=0.872902 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-05 15:12:11.887218) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-05 15:12:11.887783) ========= script_repo_revision: eb0d361dc73c32867d5fd54dc47733994bd48e7a ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-05 15:12:11.888401) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-05 15:12:11.891934) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-05 15:12:11.904440) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 50 secs) (at 2017-04-05 15:12:11.904990) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=8887e36bb8e381bfd44124ac000001a8-1491430329.274012-1664826046 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 15:12:12 INFO - MultiFileLogger online at 20170405 15:12:12 in /builds/slave/test 15:12:12 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 15:12:12 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 15:12:12 INFO - {'append_to_log': False, 15:12:12 INFO - 'base_work_dir': '/builds/slave/test', 15:12:12 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 15:12:12 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 15:12:12 INFO - 'branch': 'Mozilla-Aurora', 15:12:12 INFO - 'buildbot_json_path': 'buildprops.json', 15:12:12 INFO - 'config_files': ('talos/linux_config.py',), 15:12:12 INFO - 'default_actions': ('clobber', 15:12:12 INFO - 'read-buildbot-config', 15:12:12 INFO - 'download-and-extract', 15:12:12 INFO - 'populate-webroot', 15:12:12 INFO - 'create-virtualenv', 15:12:12 INFO - 'install', 15:12:12 INFO - 'run-tests'), 15:12:12 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 15:12:12 INFO - 'download_minidump_stackwalk': True, 15:12:12 INFO - 'download_symbols': 'ondemand', 15:12:12 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 15:12:12 INFO - 'tooltool.py': '/tools/tooltool.py', 15:12:12 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 15:12:12 INFO - '/tools/misc-python/virtualenv.py')}, 15:12:12 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 15:12:12 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 15:12:12 INFO - 'gecko_profile': False, 15:12:12 INFO - 'gecko_profile_interval': 0, 15:12:12 INFO - 'installer_path': 'installer.exe', 15:12:12 INFO - 'log_level': 'info', 15:12:12 INFO - 'log_name': 'talos', 15:12:12 INFO - 'log_to_console': True, 15:12:12 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 15:12:12 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 15:12:12 INFO - 'opt_config_files': (), 15:12:12 INFO - 'pip_index': False, 15:12:12 INFO - 'suite': 'dromaeojs-e10s', 15:12:12 INFO - 'system_bits': '32', 15:12:12 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 15:12:12 INFO - 'title': 'talos-linux64-ix-001', 15:12:12 INFO - 'tooltool_cache': '/builds/tooltool_cache', 15:12:12 INFO - 'use_talos_json': True, 15:12:12 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 15:12:12 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 15:12:12 INFO - 'work_dir': 'build'} 15:12:12 INFO - [mozharness: 2017-04-05 22:12:12.049618Z] Running clobber step. 15:12:12 INFO - Running pre-action listener: _resource_record_pre_action 15:12:12 INFO - Running main action method: clobber 15:12:12 INFO - rmtree: /builds/slave/test/build 15:12:12 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 15:12:13 INFO - Running post-action listener: _resource_record_post_action 15:12:13 INFO - [mozharness: 2017-04-05 22:12:13.500769Z] Finished clobber step (success) 15:12:13 INFO - [mozharness: 2017-04-05 22:12:13.500868Z] Running read-buildbot-config step. 15:12:13 INFO - Running pre-action listener: _resource_record_pre_action 15:12:13 INFO - Running main action method: read_buildbot_config 15:12:13 INFO - Using buildbot properties: 15:12:13 INFO - { 15:12:13 INFO - "project": "", 15:12:13 INFO - "product": "firefox", 15:12:13 INFO - "who": "ryanvm@gmail.com", 15:12:13 INFO - "installer_path": "public/build/target.tar.bz2", 15:12:13 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s", 15:12:13 INFO - "repository": "https://hg.mozilla.org/releases/mozilla-aurora/", 15:12:13 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs-e10s", 15:12:13 INFO - "stage_platform": "linux64-pgo", 15:12:13 INFO - "basedir": "/builds/slave/test", 15:12:13 INFO - "buildnumber": 954, 15:12:13 INFO - "platform": "ubuntu64_hw", 15:12:13 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 15:12:13 INFO - "slavebuilddir": "test", 15:12:13 INFO - "taskId": "IlFfp6zhRhOReAfCI9rAUQ", 15:12:13 INFO - "branch": "mozilla-aurora", 15:12:13 INFO - "script_repo_revision": "production", 15:12:13 INFO - "revision": "eb0d361dc73c32867d5fd54dc47733994bd48e7a", 15:12:13 INFO - "slavename": "talos-linux64-ix-001", 15:12:13 INFO - "repo_path": "releases/mozilla-aurora" 15:12:13 INFO - } 15:12:13 INFO - Finding installer, test and symbols from parent task. 15:12:13 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/IlFfp6zhRhOReAfCI9rAUQ'}, attempt #1 15:12:13 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/IlFfp6zhRhOReAfCI9rAUQ'}, attempt #1 15:12:14 INFO - Task dependencies: CIF0aaZ8RuaVBlSbQLmGZw 15:12:14 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/CIF0aaZ8RuaVBlSbQLmGZw'}, attempt #1 15:12:14 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/CIF0aaZ8RuaVBlSbQLmGZw/artifacts/public/build/target.tar.bz2 15:12:14 INFO - Set test_url: https://queue.taskcluster.net/v1/task/CIF0aaZ8RuaVBlSbQLmGZw/artifacts/public/build/test_packages.json 15:12:14 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/CIF0aaZ8RuaVBlSbQLmGZw/artifacts/public/build/target.crashreporter-symbols.zip 15:12:14 INFO - Running post-action listener: _resource_record_post_action 15:12:14 INFO - [mozharness: 2017-04-05 22:12:14.892790Z] Finished read-buildbot-config step (success) 15:12:14 INFO - [mozharness: 2017-04-05 22:12:14.893008Z] Running download-and-extract step. 15:12:14 INFO - Running pre-action listener: _resource_record_pre_action 15:12:14 INFO - Running main action method: download_and_extract 15:12:14 INFO - mkdir: /builds/slave/test/build/tests 15:12:14 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')]} 15:12:14 INFO - trying https://queue.taskcluster.net/v1/task/CIF0aaZ8RuaVBlSbQLmGZw/artifacts/public/build/target.test_packages.json 15:12:14 INFO - Downloading https://queue.taskcluster.net/v1/task/CIF0aaZ8RuaVBlSbQLmGZw/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 15:12:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/CIF0aaZ8RuaVBlSbQLmGZw/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 15:12:15 INFO - Downloaded 896 bytes. 15:12:15 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 15:12:15 INFO - Using the following test package requirements: 15:12:15 INFO - {u'common': [u'target.common.tests.zip'], 15:12:15 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 15:12:15 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 15:12:15 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 15:12:15 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 15:12:15 INFO - u'mozbase': [u'target.common.tests.zip'], 15:12:15 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 15:12:15 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 15:12:15 INFO - u'web-platform': [u'target.common.tests.zip', 15:12:15 INFO - u'target.web-platform.tests.zip'], 15:12:15 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 15:12:15 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 15:12:15 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/CIF0aaZ8RuaVBlSbQLmGZw/artifacts/public/build/target.common.tests.zip 15:12:15 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/CIF0aaZ8RuaVBlSbQLmGZw/artifacts/public/build/target.common.tests.zip'}, attempt #1 15:12:15 INFO - Fetch https://queue.taskcluster.net/v1/task/CIF0aaZ8RuaVBlSbQLmGZw/artifacts/public/build/target.common.tests.zip into memory 15:12:16 INFO - Expected file size: 59543748 15:12:16 INFO - Obtained file size: 59543748 15:12:26 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 15:12:26 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/CIF0aaZ8RuaVBlSbQLmGZw/artifacts/public/build/target.common.tests.zip 15:12:26 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/CIF0aaZ8RuaVBlSbQLmGZw/artifacts/public/build/target.common.tests.zip'}, attempt #1 15:12:26 INFO - Fetch https://queue.taskcluster.net/v1/task/CIF0aaZ8RuaVBlSbQLmGZw/artifacts/public/build/target.common.tests.zip into memory 15:12:27 INFO - Expected file size: 59543748 15:12:27 INFO - Obtained file size: 59543748 15:12:38 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/CIF0aaZ8RuaVBlSbQLmGZw/artifacts/public/build/target.talos.tests.zip 15:12:38 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/CIF0aaZ8RuaVBlSbQLmGZw/artifacts/public/build/target.talos.tests.zip'}, attempt #1 15:12:38 INFO - Fetch https://queue.taskcluster.net/v1/task/CIF0aaZ8RuaVBlSbQLmGZw/artifacts/public/build/target.talos.tests.zip into memory 15:12:38 INFO - Expected file size: 14404438 15:12:38 INFO - Obtained file size: 14404438 15:12:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:12:38 INFO - trying https://queue.taskcluster.net/v1/task/CIF0aaZ8RuaVBlSbQLmGZw/artifacts/public/build/target.tar.bz2 15:12:38 INFO - Downloading https://queue.taskcluster.net/v1/task/CIF0aaZ8RuaVBlSbQLmGZw/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 15:12:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/CIF0aaZ8RuaVBlSbQLmGZw/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 15:12:40 INFO - Downloaded 66765449 bytes. 15:12:40 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/CIF0aaZ8RuaVBlSbQLmGZw/artifacts/public/build/target.tar.bz2 15:12:40 INFO - mkdir: /builds/slave/test/properties 15:12:40 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 15:12:40 INFO - Writing to file /builds/slave/test/properties/build_url 15:12:40 INFO - Contents: 15:12:40 INFO - build_url:https://queue.taskcluster.net/v1/task/CIF0aaZ8RuaVBlSbQLmGZw/artifacts/public/build/target.tar.bz2 15:12:40 INFO - Running post-action listener: _resource_record_post_action 15:12:40 INFO - Running post-action listener: set_extra_try_arguments 15:12:40 INFO - [mozharness: 2017-04-05 22:12:40.118909Z] Finished download-and-extract step (success) 15:12:40 INFO - [mozharness: 2017-04-05 22:12:40.119005Z] Running populate-webroot step. 15:12:40 INFO - Running pre-action listener: _resource_record_pre_action 15:12:40 INFO - Running main action method: populate_webroot 15:12:40 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 15:12:40 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 15:12:40 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 15:12:40 INFO - '--tppagecycles', 15:12:40 INFO - '7'], 15:12:40 INFO - 'tests': ['tsvgm']}}, 15:12:40 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 15:12:40 INFO - 'tests': ['tresize', 'tcanvasmark']}, 15:12:40 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 15:12:40 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 15:12:40 INFO - 'tests': ['dromaeo_css', 'kraken']}, 15:12:40 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 15:12:40 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 15:12:40 INFO - 'talos_options': ['--disable-e10s'], 15:12:40 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:12:40 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 15:12:40 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:12:40 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 15:12:40 INFO - 'talos_options': ['--disable-e10s'], 15:12:40 INFO - 'tests': ['damp', 'tps']}, 15:12:40 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 15:12:40 INFO - 'tests': ['damp', 'tps']}, 15:12:40 INFO - 'g3': {'talos_options': ['--disable-e10s'], 15:12:40 INFO - 'tests': ['dromaeo_dom']}, 15:12:40 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 15:12:40 INFO - 'g4': {'talos_options': ['--disable-e10s'], 15:12:40 INFO - 'tests': ['basic_compositor_video']}, 15:12:40 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 15:12:40 INFO - 'other': {'talos_options': ['--disable-e10s'], 15:12:40 INFO - 'tests': ['a11yr', 15:12:40 INFO - 'ts_paint', 15:12:40 INFO - 'tpaint', 15:12:40 INFO - 'sessionrestore', 15:12:40 INFO - 'sessionrestore_no_auto_restore', 15:12:40 INFO - 'tabpaint']}, 15:12:40 INFO - 'other-e10s': {'tests': ['a11yr', 15:12:40 INFO - 'ts_paint', 15:12:40 INFO - 'tpaint', 15:12:40 INFO - 'sessionrestore', 15:12:40 INFO - 'sessionrestore_no_auto_restore', 15:12:40 INFO - 'tabpaint']}, 15:12:40 INFO - 'other-e10s_l64': {'tests': ['a11yr', 15:12:40 INFO - 'ts_paint', 15:12:40 INFO - 'tpaint', 15:12:40 INFO - 'sessionrestore', 15:12:40 INFO - 'sessionrestore_no_auto_restore', 15:12:40 INFO - 'tabpaint']}, 15:12:40 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 15:12:40 INFO - 'ts_paint', 15:12:40 INFO - 'tpaint', 15:12:40 INFO - 'sessionrestore', 15:12:40 INFO - 'sessionrestore_no_auto_restore', 15:12:40 INFO - 'tabpaint']}, 15:12:40 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 15:12:40 INFO - 'tests': ['a11yr', 15:12:40 INFO - 'ts_paint', 15:12:40 INFO - 'tpaint', 15:12:40 INFO - 'sessionrestore', 15:12:40 INFO - 'sessionrestore_no_auto_restore', 15:12:40 INFO - 'tabpaint']}, 15:12:40 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 15:12:40 INFO - 'tests': ['a11yr', 15:12:40 INFO - 'ts_paint', 15:12:40 INFO - 'tpaint', 15:12:40 INFO - 'sessionrestore', 15:12:40 INFO - 'sessionrestore_no_auto_restore', 15:12:40 INFO - 'tabpaint']}, 15:12:40 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 15:12:40 INFO - 'tests': ['tsvgx', 15:12:40 INFO - 'tsvgr_opacity', 15:12:40 INFO - 'tart', 15:12:40 INFO - 'tscrollx', 15:12:40 INFO - 'cart', 15:12:40 INFO - 'tsvg_static']}, 15:12:40 INFO - 'svgr-e10s': {'tests': ['tsvgx', 15:12:40 INFO - 'tsvgr_opacity', 15:12:40 INFO - 'tart', 15:12:40 INFO - 'tscrollx', 15:12:40 INFO - 'cart', 15:12:40 INFO - 'tsvg_static']}, 15:12:40 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 15:12:40 INFO - 'talos_options': ['--disable-e10s'], 15:12:40 INFO - 'tests': ['tp5o']}, 15:12:40 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 15:12:40 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 15:12:40 INFO - 'talos_options': ['--disable-e10s', 15:12:40 INFO - '--xperf_path', 15:12:40 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:12:40 INFO - 'tests': ['tp5n']}, 15:12:40 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 15:12:40 INFO - 'talos_options': ['--xperf_path', 15:12:40 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:12:40 INFO - 'tests': ['tp5n']}}, 15:12:40 INFO - 'talos.zip': {'path': '', 15:12:40 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 15:12:40 INFO - Running post-action listener: _resource_record_post_action 15:12:40 INFO - [mozharness: 2017-04-05 22:12:40.131979Z] Finished populate-webroot step (success) 15:12:40 INFO - [mozharness: 2017-04-05 22:12:40.132068Z] Running create-virtualenv step. 15:12:40 INFO - Running pre-action listener: _resource_record_pre_action 15:12:40 INFO - Running main action method: create_virtualenv 15:12:40 INFO - Creating virtualenv /builds/slave/test/build/venv 15:12:40 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 15:12:40 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 15:12:40 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 15:12:40 INFO - Using real prefix '/usr' 15:12:40 INFO - New python executable in /builds/slave/test/build/venv/bin/python 15:12:40 INFO - Installing distribute.............................................................................................................................................................................................done. 15:12:42 INFO - Installing pip.................done. 15:12:42 INFO - Return code: 0 15:12:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 15:12:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 15:12:42 INFO - Reading from file tmpfile_stdout 15:12:42 INFO - Output received: 15:12:42 INFO - pip 1.5.5 from /builds/slave/test/build/venv/local/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 15:12:42 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 15:12: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')]} 15:12:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:12:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:12: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')]} 15:12:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:12:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:12: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27aa1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28a2a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a47b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a45290>, '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 0x2a45b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a46040>, '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': '8887e36bb8e381bfd44124ac000001a8-1491430329.274012-1664826046', '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 15:12: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', 'pip>=1.5'] in /builds/slave/test/build 15:12: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 pip>=1.5 15:12:42 INFO - Using env: {'DISPLAY': ':0', 15:12:42 INFO - 'HOME': '/home/cltbld', 15:12:42 INFO - 'LANG': 'en_US.UTF-8', 15:12:42 INFO - 'LANGUAGE': 'en_US:en', 15:12:42 INFO - 'LOGNAME': 'cltbld', 15:12:42 INFO - 'MAIL': '/var/mail/cltbld', 15:12:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:12:42 INFO - 'MOZ_NO_REMOTE': '1', 15:12:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:12:42 INFO - 'NO_EM_RESTART': '1', 15:12:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:12:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:12:42 INFO - 'PWD': '/builds/slave/test', 15:12:42 INFO - 'SHELL': '/bin/bash', 15:12:42 INFO - 'SHLVL': '1', 15:12:42 INFO - 'TERM': 'linux', 15:12:42 INFO - 'TMOUT': '86400', 15:12:42 INFO - 'USER': 'cltbld', 15:12:42 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1491430329.274012-1664826046', 15:12:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:12:42 INFO - '_': '/tools/buildbot/bin/python'} 15:12:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:12:43 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 15:12:43 INFO - Cleaning up... 15:12:43 INFO - Return code: 0 15:12:43 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 15:12:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:12:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:12:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:12:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:12:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:12:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:12:43 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x27aa1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28a2a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a47b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a45290>, '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 0x2a45b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a46040>, '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': '8887e36bb8e381bfd44124ac000001a8-1491430329.274012-1664826046', '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 15:12:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 15:12:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 15:12:43 INFO - Using env: {'DISPLAY': ':0', 15:12:43 INFO - 'HOME': '/home/cltbld', 15:12:43 INFO - 'LANG': 'en_US.UTF-8', 15:12:43 INFO - 'LANGUAGE': 'en_US:en', 15:12:43 INFO - 'LOGNAME': 'cltbld', 15:12:43 INFO - 'MAIL': '/var/mail/cltbld', 15:12:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:12:43 INFO - 'MOZ_NO_REMOTE': '1', 15:12:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:12:43 INFO - 'NO_EM_RESTART': '1', 15:12:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:12:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:12:43 INFO - 'PWD': '/builds/slave/test', 15:12:43 INFO - 'SHELL': '/bin/bash', 15:12:43 INFO - 'SHLVL': '1', 15:12:43 INFO - 'TERM': 'linux', 15:12:43 INFO - 'TMOUT': '86400', 15:12:43 INFO - 'USER': 'cltbld', 15:12:43 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1491430329.274012-1664826046', 15:12:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:12:43 INFO - '_': '/tools/buildbot/bin/python'} 15:12:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:12:43 INFO - Downloading/unpacking psutil>=3.1.1 15:12:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:12:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:12:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:12:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:12:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:12:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:12:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 15:12:45 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:12:45 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:12:45 INFO - Installing collected packages: psutil 15:12:45 INFO - Running setup.py install for psutil 15:12:45 INFO - building 'psutil._psutil_linux' extension 15:12:45 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 15:12:45 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 15:12:45 INFO - building 'psutil._psutil_posix' extension 15:12:45 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 15:12:45 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 15:12:45 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:12:45 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:12:45 INFO - Successfully installed psutil 15:12:45 INFO - Cleaning up... 15:12:46 INFO - Return code: 0 15:12:46 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 15:12: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')]} 15:12:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:12:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:12: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')]} 15:12:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:12:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:12:46 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27aa1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28a2a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a47b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a45290>, '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 0x2a45b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a46040>, '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': '8887e36bb8e381bfd44124ac000001a8-1491430329.274012-1664826046', '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 15:12:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 15:12:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 15:12:46 INFO - Using env: {'DISPLAY': ':0', 15:12:46 INFO - 'HOME': '/home/cltbld', 15:12:46 INFO - 'LANG': 'en_US.UTF-8', 15:12:46 INFO - 'LANGUAGE': 'en_US:en', 15:12:46 INFO - 'LOGNAME': 'cltbld', 15:12:46 INFO - 'MAIL': '/var/mail/cltbld', 15:12:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:12:46 INFO - 'MOZ_NO_REMOTE': '1', 15:12:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:12:46 INFO - 'NO_EM_RESTART': '1', 15:12:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:12:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:12:46 INFO - 'PWD': '/builds/slave/test', 15:12:46 INFO - 'SHELL': '/bin/bash', 15:12:46 INFO - 'SHLVL': '1', 15:12:46 INFO - 'TERM': 'linux', 15:12:46 INFO - 'TMOUT': '86400', 15:12:46 INFO - 'USER': 'cltbld', 15:12:46 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1491430329.274012-1664826046', 15:12:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:12:46 INFO - '_': '/tools/buildbot/bin/python'} 15:12:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:12:46 INFO - Downloading/unpacking mozsystemmonitor==0.3 15:12:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:12:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:12:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:12:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:12:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:12:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:12:48 INFO - Downloading mozsystemmonitor-0.3.tar.gz 15:12:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 15:12:48 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 15:12:48 INFO - Installing collected packages: mozsystemmonitor 15:12:48 INFO - Running setup.py install for mozsystemmonitor 15:12:48 INFO - Successfully installed mozsystemmonitor 15:12:48 INFO - Cleaning up... 15:12:48 INFO - Return code: 0 15:12:48 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 15:12:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:12:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:12:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:12:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:12:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:12:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:12:48 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x27aa1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28a2a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a47b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a45290>, '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 0x2a45b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a46040>, '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': '8887e36bb8e381bfd44124ac000001a8-1491430329.274012-1664826046', '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 15:12:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 15:12:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 15:12:48 INFO - Using env: {'DISPLAY': ':0', 15:12:48 INFO - 'HOME': '/home/cltbld', 15:12:48 INFO - 'LANG': 'en_US.UTF-8', 15:12:48 INFO - 'LANGUAGE': 'en_US:en', 15:12:48 INFO - 'LOGNAME': 'cltbld', 15:12:48 INFO - 'MAIL': '/var/mail/cltbld', 15:12:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:12:48 INFO - 'MOZ_NO_REMOTE': '1', 15:12:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:12:48 INFO - 'NO_EM_RESTART': '1', 15:12:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:12:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:12:48 INFO - 'PWD': '/builds/slave/test', 15:12:48 INFO - 'SHELL': '/bin/bash', 15:12:48 INFO - 'SHLVL': '1', 15:12:48 INFO - 'TERM': 'linux', 15:12:48 INFO - 'TMOUT': '86400', 15:12:48 INFO - 'USER': 'cltbld', 15:12:48 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1491430329.274012-1664826046', 15:12:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:12:48 INFO - '_': '/tools/buildbot/bin/python'} 15:12:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:12:48 INFO - Downloading/unpacking jsonschema==2.5.1 15:12:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:12:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:12:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:12:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:12:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:12:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:12:50 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 15:12:50 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 15:12: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 15:12: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 15:12: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 15:12: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 15:12: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 15:12: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 15:12:50 INFO - Downloading functools32-3.2.3-2.tar.gz 15:12:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 15:12:51 INFO - warning: no files found matching '*.txt' 15:12:51 INFO - no previously-included directories found matching 'build' 15:12:51 INFO - no previously-included directories found matching 'dist' 15:12:51 INFO - no previously-included directories found matching '.git*' 15:12:51 INFO - Installing collected packages: jsonschema, functools32 15:12:51 INFO - Running setup.py install for functools32 15:12:51 INFO - warning: no files found matching '*.txt' 15:12:51 INFO - no previously-included directories found matching 'build' 15:12:51 INFO - no previously-included directories found matching 'dist' 15:12:51 INFO - no previously-included directories found matching '.git*' 15:12:51 INFO - Successfully installed jsonschema functools32 15:12:51 INFO - Cleaning up... 15:12:51 INFO - Return code: 0 15:12:51 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 15:12:51 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')]} 15:12:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:12:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:12:51 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')]} 15:12:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:12:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:12:51 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 0x27aa1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28a2a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a47b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a45290>, '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 0x2a45b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a46040>, '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': '8887e36bb8e381bfd44124ac000001a8-1491430329.274012-1664826046', '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 15:12:51 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 15:12:51 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 15:12:51 INFO - Using env: {'DISPLAY': ':0', 15:12:51 INFO - 'HOME': '/home/cltbld', 15:12:51 INFO - 'LANG': 'en_US.UTF-8', 15:12:51 INFO - 'LANGUAGE': 'en_US:en', 15:12:51 INFO - 'LOGNAME': 'cltbld', 15:12:51 INFO - 'MAIL': '/var/mail/cltbld', 15:12:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:12:51 INFO - 'MOZ_NO_REMOTE': '1', 15:12:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:12:51 INFO - 'NO_EM_RESTART': '1', 15:12:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:12:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:12:51 INFO - 'PWD': '/builds/slave/test', 15:12:51 INFO - 'SHELL': '/bin/bash', 15:12:51 INFO - 'SHLVL': '1', 15:12:51 INFO - 'TERM': 'linux', 15:12:51 INFO - 'TMOUT': '86400', 15:12:51 INFO - 'USER': 'cltbld', 15:12:51 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1491430329.274012-1664826046', 15:12:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:12:51 INFO - '_': '/tools/buildbot/bin/python'} 15:12:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:12:51 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 15:12:51 INFO - Cleaning up... 15:12:51 INFO - Return code: 0 15:12:51 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 15:12:51 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')]} 15:12:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:12:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:12:51 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')]} 15:12:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:12:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:12:51 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 0x27aa1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28a2a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a47b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a45290>, '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 0x2a45b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a46040>, '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': '8887e36bb8e381bfd44124ac000001a8-1491430329.274012-1664826046', '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 15:12:51 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 15:12:51 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 15:12:51 INFO - Using env: {'DISPLAY': ':0', 15:12:51 INFO - 'HOME': '/home/cltbld', 15:12:51 INFO - 'LANG': 'en_US.UTF-8', 15:12:51 INFO - 'LANGUAGE': 'en_US:en', 15:12:51 INFO - 'LOGNAME': 'cltbld', 15:12:51 INFO - 'MAIL': '/var/mail/cltbld', 15:12:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:12:51 INFO - 'MOZ_NO_REMOTE': '1', 15:12:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:12:51 INFO - 'NO_EM_RESTART': '1', 15:12:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:12:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:12:51 INFO - 'PWD': '/builds/slave/test', 15:12:51 INFO - 'SHELL': '/bin/bash', 15:12:51 INFO - 'SHLVL': '1', 15:12:51 INFO - 'TERM': 'linux', 15:12:51 INFO - 'TMOUT': '86400', 15:12:51 INFO - 'USER': 'cltbld', 15:12:51 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1491430329.274012-1664826046', 15:12:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:12:51 INFO - '_': '/tools/buildbot/bin/python'} 15:12:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:12:51 INFO - Downloading/unpacking blobuploader==1.2.4 15:12:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:12:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:12:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:12:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:12:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:12:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:12:53 INFO - Downloading blobuploader-1.2.4.tar.gz 15:12:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 15:12:53 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 15:12:53 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 15:12:53 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 15:12:53 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 15:12:53 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 15:12:53 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 15:12:53 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 15:12:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 15:12:54 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 15:12:54 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 15:12:54 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 15:12:54 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 15:12:54 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 15:12:54 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 15:12:54 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 15:12:54 INFO - Downloading docopt-0.6.1.tar.gz 15:12:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 15:12:54 INFO - Installing collected packages: blobuploader, requests, docopt 15:12:54 INFO - Running setup.py install for blobuploader 15:12:54 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 15:12:54 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 15:12:54 INFO - Running setup.py install for requests 15:12:54 INFO - Running setup.py install for docopt 15:12:55 INFO - Successfully installed blobuploader requests docopt 15:12:55 INFO - Cleaning up... 15:12:55 INFO - Return code: 0 15:12:55 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:12:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:12:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:12:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:12:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:12:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:12:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:12:55 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 0x27aa1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28a2a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a47b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a45290>, '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 0x2a45b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a46040>, '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': '8887e36bb8e381bfd44124ac000001a8-1491430329.274012-1664826046', '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 15:12:55 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 15:12:55 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 15:12:55 INFO - Using env: {'DISPLAY': ':0', 15:12:55 INFO - 'HOME': '/home/cltbld', 15:12:55 INFO - 'LANG': 'en_US.UTF-8', 15:12:55 INFO - 'LANGUAGE': 'en_US:en', 15:12:55 INFO - 'LOGNAME': 'cltbld', 15:12:55 INFO - 'MAIL': '/var/mail/cltbld', 15:12:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:12:55 INFO - 'MOZ_NO_REMOTE': '1', 15:12:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:12:55 INFO - 'NO_EM_RESTART': '1', 15:12:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:12:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:12:55 INFO - 'PWD': '/builds/slave/test', 15:12:55 INFO - 'SHELL': '/bin/bash', 15:12:55 INFO - 'SHLVL': '1', 15:12:55 INFO - 'TERM': 'linux', 15:12:55 INFO - 'TMOUT': '86400', 15:12:55 INFO - 'USER': 'cltbld', 15:12:55 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1491430329.274012-1664826046', 15:12:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:12:55 INFO - '_': '/tools/buildbot/bin/python'} 15:12:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:12:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:12:55 INFO - Running setup.py (path:/tmp/pip-JlPU7y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:12:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:12:55 INFO - Running setup.py (path:/tmp/pip-ygluia-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:12:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:12:55 INFO - Running setup.py (path:/tmp/pip-wMfaG6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:12:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:12:55 INFO - Running setup.py (path:/tmp/pip-WsBhWG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:12:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:12:55 INFO - Running setup.py (path:/tmp/pip-f1RwQL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:12:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:12:55 INFO - Running setup.py (path:/tmp/pip-2jBbcW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:12:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:12:55 INFO - Running setup.py (path:/tmp/pip-xyMBU4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:12:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:12:55 INFO - Running setup.py (path:/tmp/pip-2IcuOO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:12:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:12:55 INFO - Running setup.py (path:/tmp/pip-lF7YNV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:12:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:12:56 INFO - Running setup.py (path:/tmp/pip-tiFPWA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:12:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:12:56 INFO - Running setup.py (path:/tmp/pip-dqpHB1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:12:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:12:56 INFO - Running setup.py (path:/tmp/pip-hJlSJE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:12:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:12:56 INFO - Running setup.py (path:/tmp/pip-RKUoCH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:12:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:12:56 INFO - Running setup.py (path:/tmp/pip-fDNr9t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:12:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:12:56 INFO - Running setup.py (path:/tmp/pip-m_dX81-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:12:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:12:56 INFO - Running setup.py (path:/tmp/pip-LnaqPq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:12:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:12:56 INFO - Running setup.py (path:/tmp/pip-erL4Rk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:12:56 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 15:12:56 INFO - Running setup.py install for manifestparser 15:12:56 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 15:12:56 INFO - Running setup.py install for mozcrash 15:12:56 INFO - Running setup.py install for mozdebug 15:12:56 INFO - Running setup.py install for mozdevice 15:12:56 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 15:12:56 INFO - Installing dm script to /builds/slave/test/build/venv/bin 15:12:57 INFO - Running setup.py install for mozfile 15:12:57 INFO - Running setup.py install for mozhttpd 15:12:57 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 15:12:57 INFO - Running setup.py install for mozinfo 15:12:57 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 15:12:57 INFO - Running setup.py install for mozInstall 15:12:57 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 15:12:57 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 15:12:57 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 15:12:57 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 15:12:57 INFO - Running setup.py install for mozleak 15:12:57 INFO - Running setup.py install for mozlog 15:12:57 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 15:12:57 INFO - Running setup.py install for moznetwork 15:12:57 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 15:12:57 INFO - Running setup.py install for mozprocess 15:12:57 INFO - Running setup.py install for mozprofile 15:12:57 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 15:12:57 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 15:12:57 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 15:12:57 INFO - Running setup.py install for mozrunner 15:12:58 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 15:12:58 INFO - Running setup.py install for mozscreenshot 15:12:58 INFO - Running setup.py install for moztest 15:12:58 INFO - Running setup.py install for mozversion 15:12:58 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 15:12:58 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 15:12:58 INFO - Cleaning up... 15:12:58 INFO - Return code: 0 15:12:58 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:12:58 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')]} 15:12:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:12:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:12:58 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')]} 15:12:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:12:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:12:58 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 0x27aa1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28a2a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a47b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a45290>, '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 0x2a45b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a46040>, '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': '8887e36bb8e381bfd44124ac000001a8-1491430329.274012-1664826046', '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 15:12:58 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 15:12:58 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 15:12:58 INFO - Using env: {'DISPLAY': ':0', 15:12:58 INFO - 'HOME': '/home/cltbld', 15:12:58 INFO - 'LANG': 'en_US.UTF-8', 15:12:58 INFO - 'LANGUAGE': 'en_US:en', 15:12:58 INFO - 'LOGNAME': 'cltbld', 15:12:58 INFO - 'MAIL': '/var/mail/cltbld', 15:12:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:12:58 INFO - 'MOZ_NO_REMOTE': '1', 15:12:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:12:58 INFO - 'NO_EM_RESTART': '1', 15:12:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:12:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:12:58 INFO - 'PWD': '/builds/slave/test', 15:12:58 INFO - 'SHELL': '/bin/bash', 15:12:58 INFO - 'SHLVL': '1', 15:12:58 INFO - 'TERM': 'linux', 15:12:58 INFO - 'TMOUT': '86400', 15:12:58 INFO - 'USER': 'cltbld', 15:12:58 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1491430329.274012-1664826046', 15:12:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:12:58 INFO - '_': '/tools/buildbot/bin/python'} 15:12:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:12:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:12:58 INFO - Running setup.py (path:/tmp/pip-2owTml-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:12:58 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)) 15:12:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:12:58 INFO - Running setup.py (path:/tmp/pip-td5Sc_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:12:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 15:12:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:12:58 INFO - Running setup.py (path:/tmp/pip-V9JpZc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:12:58 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)) 15:12:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:12:58 INFO - Running setup.py (path:/tmp/pip-OEa2sv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:12:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.49 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 15:12:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:12:58 INFO - Running setup.py (path:/tmp/pip-l3C3rJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:12:58 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)) 15:12:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:12:58 INFO - Running setup.py (path:/tmp/pip-2jlNIi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:12:59 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)) 15:12:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:12:59 INFO - Running setup.py (path:/tmp/pip-HFM3Uh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:12:59 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)) 15:12:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:12:59 INFO - Running setup.py (path:/tmp/pip-e2tRMh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:12:59 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)) 15:12:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:12:59 INFO - Running setup.py (path:/tmp/pip-sZiF3A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:12:59 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)) 15:12:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:12:59 INFO - Running setup.py (path:/tmp/pip-Oobryc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:12:59 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)) 15:12:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:12:59 INFO - Running setup.py (path:/tmp/pip-JRXMUO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:12:59 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)) 15:12:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:12:59 INFO - Running setup.py (path:/tmp/pip-FIjICa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:12:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 15:12:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:12:59 INFO - Running setup.py (path:/tmp/pip-oQAijE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:12:59 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)) 15:12:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:12:59 INFO - Running setup.py (path:/tmp/pip-A0AibF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:12:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 15:12:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:12:59 INFO - Running setup.py (path:/tmp/pip-owpaRi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:12:59 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)) 15:12:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:12:59 INFO - Running setup.py (path:/tmp/pip-vS30w1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:12:59 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 15:12:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:12:59 INFO - Running setup.py (path:/tmp/pip-EteWCb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:12:59 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)) 15:12:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 15:12:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 15:12:59 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)) 15:12:59 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 15:12:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 15:12:59 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 15:12:59 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 15:12:59 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 15:12:59 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 15:12:59 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 15:12:59 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 15:12:59 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 15:13:01 INFO - Downloading blessings-1.6.tar.gz 15:13:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 15:13:01 INFO - Installing collected packages: blessings 15:13:01 INFO - Running setup.py install for blessings 15:13:02 INFO - Successfully installed blessings 15:13:02 INFO - Cleaning up... 15:13:02 INFO - Return code: 0 15:13:02 INFO - Done creating virtualenv /builds/slave/test/build/venv. 15:13:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:13:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:13:02 INFO - Reading from file tmpfile_stdout 15:13:02 INFO - Current package versions: 15:13:02 INFO - argparse == 1.2.1 15:13:02 INFO - blessings == 1.6 15:13:02 INFO - blobuploader == 1.2.4 15:13:02 INFO - docopt == 0.6.1 15:13:02 INFO - functools32 == 3.2.3-2 15:13:02 INFO - jsonschema == 2.5.1 15:13:02 INFO - manifestparser == 1.1 15:13:02 INFO - mozInstall == 1.12 15:13:02 INFO - mozcrash == 1.0 15:13:02 INFO - mozdebug == 0.1 15:13:02 INFO - mozdevice == 0.49 15:13:02 INFO - mozfile == 1.2 15:13:02 INFO - mozhttpd == 0.7 15:13:02 INFO - mozinfo == 0.9 15:13:02 INFO - mozleak == 0.1 15:13:02 INFO - mozlog == 3.4 15:13:02 INFO - moznetwork == 0.27 15:13:02 INFO - mozprocess == 0.25 15:13:02 INFO - mozprofile == 0.28 15:13:02 INFO - mozrunner == 6.13 15:13:02 INFO - mozscreenshot == 0.1 15:13:02 INFO - mozsystemmonitor == 0.3 15:13:02 INFO - moztest == 0.8 15:13:02 INFO - mozversion == 1.4 15:13:02 INFO - psutil == 3.1.1 15:13:02 INFO - requests == 1.2.3 15:13:02 INFO - wsgiref == 0.1.2 15:13:02 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:13:02 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')]} 15:13:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:13:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:13:02 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')]} 15:13:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:13:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:13:02 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 0x27aa1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28a2a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a47b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a45290>, '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 0x2a45b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a46040>, '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': '8887e36bb8e381bfd44124ac000001a8-1491430329.274012-1664826046', '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 15:13:02 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 15:13:02 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 15:13:02 INFO - Using env: {'DISPLAY': ':0', 15:13:02 INFO - 'HOME': '/home/cltbld', 15:13:02 INFO - 'LANG': 'en_US.UTF-8', 15:13:02 INFO - 'LANGUAGE': 'en_US:en', 15:13:02 INFO - 'LOGNAME': 'cltbld', 15:13:02 INFO - 'MAIL': '/var/mail/cltbld', 15:13:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:13:02 INFO - 'MOZ_NO_REMOTE': '1', 15:13:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:13:02 INFO - 'NO_EM_RESTART': '1', 15:13:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:13:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:13:02 INFO - 'PWD': '/builds/slave/test', 15:13:02 INFO - 'SHELL': '/bin/bash', 15:13:02 INFO - 'SHLVL': '1', 15:13:02 INFO - 'TERM': 'linux', 15:13:02 INFO - 'TMOUT': '86400', 15:13:02 INFO - 'USER': 'cltbld', 15:13:02 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1491430329.274012-1664826046', 15:13:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:13:02 INFO - '_': '/tools/buildbot/bin/python'} 15:13:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:13:02 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)) 15:13:02 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)) 15:13:02 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)) 15:13:02 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)) 15:13:02 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)) 15:13:02 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)) 15:13:02 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)) 15:13:02 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)) 15:13:02 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)) 15:13:02 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)) 15:13:02 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)) 15:13:02 INFO - Cleaning up... 15:13:02 INFO - Return code: 0 15:13:02 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 15:13:02 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')]} 15:13:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:13:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:13:02 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')]} 15:13:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:13:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:13:02 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 0x27aa1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28a2a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a47b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a45290>, '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 0x2a45b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a46040>, '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': '8887e36bb8e381bfd44124ac000001a8-1491430329.274012-1664826046', '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 15:13:02 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 15:13:02 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 15:13:02 INFO - Using env: {'DISPLAY': ':0', 15:13:02 INFO - 'HOME': '/home/cltbld', 15:13:02 INFO - 'LANG': 'en_US.UTF-8', 15:13:02 INFO - 'LANGUAGE': 'en_US:en', 15:13:02 INFO - 'LOGNAME': 'cltbld', 15:13:02 INFO - 'MAIL': '/var/mail/cltbld', 15:13:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:13:02 INFO - 'MOZ_NO_REMOTE': '1', 15:13:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:13:02 INFO - 'NO_EM_RESTART': '1', 15:13:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:13:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:13:02 INFO - 'PWD': '/builds/slave/test', 15:13:02 INFO - 'SHELL': '/bin/bash', 15:13:02 INFO - 'SHLVL': '1', 15:13:02 INFO - 'TERM': 'linux', 15:13:02 INFO - 'TMOUT': '86400', 15:13:02 INFO - 'USER': 'cltbld', 15:13:02 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1491430329.274012-1664826046', 15:13:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:13:02 INFO - '_': '/tools/buildbot/bin/python'} 15:13:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:13:02 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 15:13:02 INFO - Cleaning up... 15:13:02 INFO - Return code: 0 15:13:02 INFO - Running post-action listener: _resource_record_post_action 15:13:02 INFO - Running post-action listener: _start_resource_monitoring 15:13:02 INFO - Starting resource monitoring. 15:13:02 INFO - [mozharness: 2017-04-05 22:13:02.844650Z] Finished create-virtualenv step (success) 15:13:02 INFO - [mozharness: 2017-04-05 22:13:02.845163Z] Running install step. 15:13:02 INFO - Running pre-action listener: _resource_record_pre_action 15:13:02 INFO - Running main action method: install 15:13:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:13:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:13:03 INFO - Reading from file tmpfile_stdout 15:13:03 INFO - Detecting whether we're running mozinstall >=1.0... 15:13:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 15:13:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 15:13:03 INFO - Reading from file tmpfile_stdout 15:13:03 INFO - Output received: 15:13:03 INFO - Usage: mozinstall [options] installer 15:13:03 INFO - Options: 15:13:03 INFO - -h, --help show this help message and exit 15:13:03 INFO - -d DEST, --destination=DEST 15:13:03 INFO - Directory to install application into. [default: 15:13:03 INFO - "/builds/slave/test"] 15:13:03 INFO - --app=APP Application being installed. [default: firefox] 15:13:03 INFO - mkdir: /builds/slave/test/build/application 15:13:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/target.tar.bz2', '--destination', '/builds/slave/test/build/application'] 15:13:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 15:13:19 INFO - Reading from file tmpfile_stdout 15:13:19 INFO - Output received: 15:13:19 INFO - /builds/slave/test/build/application/firefox/firefox 15:13:19 INFO - Running post-action listener: _resource_record_post_action 15:13:19 INFO - [mozharness: 2017-04-05 22:13:19.704756Z] Finished install step (success) 15:13:19 INFO - [mozharness: 2017-04-05 22:13:19.705029Z] Running run-tests step. 15:13:19 INFO - Running pre-action listener: _resource_record_pre_action 15:13:19 INFO - Running main action method: run_tests 15:13:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 15:13:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 15:13:19 INFO - Python 2.7.3 15:13:19 INFO - Return code: 0 15:13:19 INFO - grabbing minidump binary from tooltool 15:13:19 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')]} 15:13:19 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 0x2a45290>, '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 0x2a45b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a46040>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 15:13:19 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 15:13:19 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 15:13:19 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 15:13:19 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 15:13:19 INFO - Return code: 0 15:13:19 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 15:13:19 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 15:13:19 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 15:13:19 INFO - ENV: RUST_BACKTRACE is now 1 15:13:19 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 15:13:19 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 15:13:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/CIF0aaZ8RuaVBlSbQLmGZw/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-001', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 15:13:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/CIF0aaZ8RuaVBlSbQLmGZw/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-001 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 15:13:19 INFO - Using env: {'DISPLAY': ':0', 15:13:19 INFO - 'HOME': '/home/cltbld', 15:13:19 INFO - 'LANG': 'en_US.UTF-8', 15:13:19 INFO - 'LANGUAGE': 'en_US:en', 15:13:19 INFO - 'LOGNAME': 'cltbld', 15:13:19 INFO - 'MAIL': '/var/mail/cltbld', 15:13:19 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 15:13:19 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 15:13:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:13:19 INFO - 'MOZ_NO_REMOTE': '1', 15:13:19 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 15:13:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:13:19 INFO - 'NO_EM_RESTART': '1', 15:13:19 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:13:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:13:19 INFO - 'PWD': '/builds/slave/test', 15:13:19 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 15:13:19 INFO - 'RUST_BACKTRACE': '1', 15:13:19 INFO - 'SHELL': '/bin/bash', 15:13:19 INFO - 'SHLVL': '1', 15:13:19 INFO - 'TERM': 'linux', 15:13:19 INFO - 'TMOUT': '86400', 15:13:19 INFO - 'USER': 'cltbld', 15:13:19 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1491430329.274012-1664826046', 15:13:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:13:19 INFO - '_': '/tools/buildbot/bin/python'} 15:13:19 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/CIF0aaZ8RuaVBlSbQLmGZw/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-001', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 15:13:19 INFO - mozversion application_buildid: 20170405211817 15:13:19 INFO - mozversion application_changeset: eb0d361dc73c32867d5fd54dc47733994bd48e7a 15:13:19 INFO - mozversion application_display_name: FirefoxDeveloperEdition 15:13:19 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 15:13:19 INFO - mozversion application_name: Firefox 15:13:19 INFO - mozversion application_remotingname: firefox-dev 15:13:19 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 15:13:19 INFO - mozversion application_vendor: Mozilla 15:13:19 INFO - mozversion application_version: 54.0a2 15:13:19 INFO - mozversion platform_buildid: 20170405211817 15:13:19 INFO - mozversion platform_changeset: eb0d361dc73c32867d5fd54dc47733994bd48e7a 15:13:19 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 15:13:19 INFO - mozversion platform_version: 54.0a2 15:13:19 INFO - using testdate: 1491430399 15:13:19 INFO - actual date: 1491430399 15:13:19 INFO - starting webserver on 'localhost:46644' 15:13:19 INFO - SUITE-START | Running 2 tests 15:13:19 INFO - TEST-START | dromaeo_css 15:13:19 INFO - operating with platform_type : linux_ 15:13:19 INFO - Initialising browser for dromaeo_css test... 15:13:20 INFO - TEST-INFO | started process 26375 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpxucVxS/profile http://localhost:46644/getInfo.html) 15:13:24 INFO - PROCESS | 26375 | __metrics Screen width/height:1600/1200 15:13:24 INFO - PROCESS | 26375 | colorDepth:24 15:13:24 INFO - PROCESS | 26375 | Browser inner width/height: 1024/697 15:13:24 INFO - PROCESS | 26375 | __metrics 15:13:25 ERROR - PROCESS | 26375 | 1491430405266 addons.xpi WARN Exception running bootstrap method shutdown on shield-recipe-client@mozilla.org: TypeError: log is null (resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/firefox/browser/features/shield-recipe-client@mozilla.org.xpi!/bootstrap.js:96:5) JS Stack trace: this.shutdown@resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/firefox/browser/features/shield-recipe-client@bootstrap.js:96:5 < callBootstrapMethod@XPIProvider.jsm:4954:11 < observe@XPIProvider.jsm:2917:15 < permitUnload@remote-browser.xml:357:13 < CanCloseWindow@browser.js:6373:36 < canClose@browser.js:5234:12 < forceQuit@jar:file:///tmp/tmpxucVxS/profile/extensions/talos-powers@TalosPowersService.js:237:7 < whenDone@jar:file:///tmp/tmpxucVxS/profile/extensions/talos-powers@TalosPowersService.js:222:9 < promise callback*forceQuit@jar:file:///tmp/tmpxucVxS/profile/extensions/talos-powers@TalosPowersService.js:224:7 < receiveMessage@jar:file:///tmp/tmpxucVxS/profile/extensions/talos-powers@TalosPowersService.js:55:9 15:13:25 ERROR - PROCESS | 26375 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3360: TypeError: this.tabs is undefined 15:13:26 INFO - TEST-INFO | 26375: exit 0 15:13:26 INFO - Browser initialized. 15:13:26 INFO - Running cycle 1/1 for dromaeo_css test... 15:13:26 INFO - TEST-INFO | started process 26508 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpxucVxS/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:13:38 INFO - PROCESS | 26508 | RSS: Main: 147079168 15:13:38 INFO - PROCESS | 26508 | 15:16:38 INFO - PROCESS | 26508 | Cycle 1(1): loaded http://localhost:46644/tests/dromaeo/cssquery-dojo.html (next: http://localhost:46644/tests/dromaeo/cssquery-ext.html) 15:16:39 INFO - PROCESS | 26508 | RSS: Main: 156958720 15:16:39 INFO - PROCESS | 26508 | 15:18:26 INFO - PROCESS | 26508 | ************************* 15:18:26 INFO - PROCESS | 26508 | A coding exception was thrown and uncaught in a Task. 15:18:26 INFO - PROCESS | 26508 | 15:18:26 ERROR - PROCESS | 26508 | Full message: TypeError: NetworkError when attempting to fetch resource. 15:18:26 INFO - PROCESS | 26508 | Full stack: 15:18:26 INFO - PROCESS | 26508 | ************************* 15:18:26 INFO - PROCESS | 26508 | ************************* 15:18:26 INFO - PROCESS | 26508 | A coding exception was thrown and uncaught in a Task. 15:18:26 INFO - PROCESS | 26508 | 15:18:26 ERROR - PROCESS | 26508 | Full message: TypeError: NetworkError when attempting to fetch resource. 15:18:26 INFO - PROCESS | 26508 | Full stack: 15:18:26 INFO - PROCESS | 26508 | ************************* 15:18:26 INFO - PROCESS | 26508 | ************************* 15:18:26 INFO - PROCESS | 26508 | A coding exception was thrown and uncaught in a Task. 15:18:26 INFO - PROCESS | 26508 | 15:18:26 ERROR - PROCESS | 26508 | Full message: TypeError: NetworkError when attempting to fetch resource. 15:18:26 INFO - PROCESS | 26508 | Full stack: 15:18:26 INFO - PROCESS | 26508 | ************************* 15:18:26 INFO - PROCESS | 26508 | ************************* 15:18:26 INFO - PROCESS | 26508 | A coding exception was thrown and uncaught in a Task. 15:18:26 INFO - PROCESS | 26508 | 15:18:26 ERROR - PROCESS | 26508 | Full message: TypeError: NetworkError when attempting to fetch resource. 15:18:26 INFO - PROCESS | 26508 | Full stack: 15:18:26 INFO - PROCESS | 26508 | ************************* 15:19:41 INFO - PROCESS | 26508 | Cycle 1(1): loaded http://localhost:46644/tests/dromaeo/cssquery-ext.html (next: http://localhost:46644/tests/dromaeo/cssquery-jquery.html) 15:19:42 INFO - PROCESS | 26508 | RSS: Main: 153772032 15:19:42 INFO - PROCESS | 26508 | 15:22:44 INFO - PROCESS | 26508 | Cycle 1(1): loaded http://localhost:46644/tests/dromaeo/cssquery-jquery.html (next: http://localhost:46644/tests/dromaeo/cssquery-mootools.html) 15:22:44 INFO - PROCESS | 26508 | RSS: Main: 155467776 15:22:44 INFO - PROCESS | 26508 | 15:25:46 INFO - PROCESS | 26508 | Cycle 1(1): loaded http://localhost:46644/tests/dromaeo/cssquery-mootools.html (next: http://localhost:46644/tests/dromaeo/cssquery-prototype.html) 15:25:47 INFO - PROCESS | 26508 | RSS: Main: 152068096 15:25:47 INFO - PROCESS | 26508 | 15:28:49 INFO - PROCESS | 26508 | Cycle 1(1): loaded http://localhost:46644/tests/dromaeo/cssquery-prototype.html (next: http://localhost:46644/tests/dromaeo/cssquery-yui.html) 15:28:50 INFO - PROCESS | 26508 | RSS: Main: 157720576 15:28:50 INFO - PROCESS | 26508 | 15:31:52 INFO - PROCESS | 26508 | Cycle 1(1): loaded http://localhost:46644/tests/dromaeo/cssquery-yui.html (next: http://localhost:46644/tests/dromaeo/cssquery-dojo.html) 15:31:52 INFO - PROCESS | 26508 | RSS: Main: 159166464 15:31:52 INFO - PROCESS | 26508 | 15:31:52 INFO - PROCESS | 26508 | __start_tp_report 15:31:52 INFO - PROCESS | 26508 | _x_x_mozilla_page_load 15:31:52 INFO - PROCESS | 26508 | _x_x_mozilla_page_load_details 15:31:52 INFO - PROCESS | 26508 | |i|pagename|runs| 15:31:52 INFO - PROCESS | 26508 | |0;dojo.html;3409.5397121388614;3420.811855347955;3434.3818112739705;3458.3947809133397;3470.5661792275964;5807.883842323156;5860.706964651772;5874.970625146873;5875.559333050022;5881.264841894763;5811.418858114186;5835.0663893777;5837.270341207349;5841.941580584204;5842.678652674102;5154.484551544843;5274.789008439658;5286.444923283038;5287.41838397776;5309.62832601718;5317.5480084192695;5323.520883120518;5323.893522129555;5329.440408757083;5331.920021199685;5080.187170052793;5100;5310.867228319304;5312.495312945264;5314.335708036496;5230.21546767984;5232.659877107995;5246.265522826808;5260.447652996419;5292.311999440087;5186.896262074775;5279.683219006872;5280.788768449257;5285.86785330366;5294.746197709163;5582.609217354787;5786.392428795;5814.098814683689;5911.467967882868;5929.258842644669;6118.588722523077;6148.047052706793;6176.660283684396;6202;6219.782307619212;6346.682665866734;6349.269833969107;6350.110984462179;6355.237371515402;6364.77723279683;5908.084246941731;5908.46823785857;5910.734016969247;5919.289685237799;5947;6198.690065496708;6202.72087756052;6262.467690246289;6311.084892690534;6317.905231421532;6125.20492926512;6183.721732522047;6188.566800323934;6200.224971878515;6202.875942481215;6268.028455589391;6271.592346497463;6282.780102696383;6284.245890493079;6291.1192433059405;6035.094735789579;6037.154798328237;6134.19168101403;6149;6189.752409903554;6254.468370188585;6270.905936410957;6271.529635277372;6273.65494897785;6278.937210627835;4645.256758918556;4684.0866031123605;4691.507391723888;4717.599004084691;4830.734309612934;4264.360345948133;4296.37702533131;4304.827806887752;4315.827366905289;4322.913541729148;5891.941080589225;5941.079132734433;6126.172966649535;6139.785107521216;6141.355157708376;6201.56589038772;6219.720112594944;6242.438180563771;6255.593386429868;6273.560850740404;6066.575339726177;6117.694115294217;6160.075988601746;6168.136460895478;6175.752969881244;5126.641135120506;5330.360356757214;5353.866153346197;5370.677759334452;5381.48875856793;6307.24313082433;6412.198475190601;6456.644884531396;6479.708413121421;6490.350964903472;6328.46208072319;6344.206974128234;6345.619262844244;6350.7777227796805;6355.3644635536075;6446.677666116581;6557.2131344239;6577.14497115372;6590.703418346282;6593.472522198117;6006.909896351645;6023.48800351975;6048.546359023179;6099.146119543356;6147.538934580014;6260;6263.780767673292;6267.843303917439;6276.592021518587;6285.497160227263;6041.305249896318;6050.6369617823075;6071.787487437919;6087.878242435215;6089.2997305310455;5917.5857689961285;5956.344802071855;6016.308124565731;6031.607945483705;6034.668093254913;6019.6756713522955;6049.667268300285;6080.69596520181;6082.118092876596;6116.235470566179;6044.727987240497;6131.356207598138;6139.877202456015;6139.938600613937;6142.170806941006;5815.273090863642;5831.912521312269;5941.7623295067715;5960.731767070405;6006.579539432372 15:31:52 INFO - PROCESS | 26508 | |1;ext.html;770.6108415250301;841.3395484544634;859.1494420523679;922.4004397141857;933.104219948849;41578.792106039466;42791;43122.78438607806;43145.46972567882;45361.31958020632;43395.566044339546;43608.12783744323;43656;43729.78135109328;43758.56241437585;9157.404768690047;9293;9302.767430814216;10199;10433.113185379252;10226.43754593497;10240.641577544788;10264.332818366782;10303.227257955647;10308.845367319496;10286.537105830219;10335.948320258389;10407.479626018707;10442.791144177112;10446.112080473169;10248.333858299224;10286.9485652572;10319.1744660427;10319.638812641597;10382.117520010808;10122.240831937634;10134.746631334276;10175.982401759838;10184.032516910956;10196.592136314539;35147.29705405878;35207.295854082775;35340.29319413623;35434;35587.64412355869;3718.442233664945;3728.384816505273;3744.4008958566496;3757.3424650686293;3873.8063096845326;26778.866105669345;26839.597406038924;26906.86546567274;27043.729562704317;27374.726252737415;4356.956430435686;4403.207422663919;4408.691391602589;4439.356293337481;4498.977505112486;232040;237418;239883;277483;279739;46770.5322946773;46949.76525117353;47188.2921756174;47234;47261.05477890423;49061.509384905694;49191.50808491869;49225.753871230416;49318.75340623346;49322.50677493179;15546;15584.142872141914;15589.90870639067;15634.9218253908;15653.452129175652;13577.59267221985;13610.659733506742;13698.452061917611;13699.863001370059;13704.451821927012;13018.869811301955;13130;13158.078934474495;13158.21050736959;13164.210147390995;5617.101263797855;5628.240187574707;5665.348484924204;5666.575006874501;5686.175504551817;1005.4470041477158;1012.731626119079;1024.2727663359099;1025.1337619711333;1033.9793204136026;27509.44981100367;27969;28368.148955530953;28857.278568035967;29165.708342916725;1092.0717390218251;1100.5047728522036;1103.4593049405894;1118.1781390677845;1128.2722643894642;14424.378783051778;14757.77863332051;14798.186099764616;14889.255537223096;15194.772078418833;315641;321559;333651;444593;447167;48783;48939.51060489421;49079;49089.509104908495;49587;1328.130074801007;1349.1635186184433;1490.4336352186099;1496.753035749111;1515.9166245856584;28750.712492875642;30271.481942714818;30454;30479.847600761856;30791;48573.27140092831;48592.75703621459;48835.26747098868;48917.510824891295;49051.509484904695;343417;345087;345091;345523;346710;30363.24091897632;30446.086617401514;31651.20871978219;33311.50032749559;33941.66058339385;40822;41147.38278925879;41320.586794132876;41337.379939300336;41507.792461037505;31143.221419464695;31194.532082018333;31366.372672545964;31414.52878206783;32023.839880800446;31297;31399.529007064455;31399.843000785764;31463.37073258476;32085.518717219726;35557.46663799993;35747;35941;36788.816055919546;36871.44692829556;29487.410251794416;29989.400211996075;30022.099337019925;30271.545926810675;30307.545386819656;24841.50316993614;24918.252452426455;24980.625290621017;25003.624945625466;25350.239492815246 15:31:52 INFO - PROCESS | 26508 | |2;jquery.html;471.66983111821736;471.87731189890616;476.4806361066437;489.0683248411777;490.92390679444685;19520.41438756836;19637.607247855034;21376.144954201853;21471.892640536815;21489.24787632433;20732.89633551834;21354.679679804776;22920.197793077245;23063;23127.884360578217;6775.627340496283;6881.346272104167;6898.793036208922;6957.7216911323485;6964.199117101548;6621.6689165541775;6838.692258848364;6844.452443804508;6851.383375496204;6855.622940738257;6572.901406478906;6597.340265973412;6609.570377925444;6651.301613330603;6652.634105124216;6648.567843090232;6789.456843452512;6863.7597684081065;6873.037774711544;6881.724731010753;6666.466682665375;6673.0991316172185;6678.497338098938;6684.364985326386;6698.397144256992;23051.76948230513;24794.132205372905;24801.87599061993;24963.375915602075;25050.749492505023;2985.970140298591;3046.558249053897;3048.588440560518;3048.6798886116862;3165.414398336315;15686;16376.508704738757;16784.66430671392;16965.491035268962;17123.400680976232;2044.3253726270295;2089.579086221369;2128.3717955763855;2136.113512892148;2137.5724855029057;97632;106053.46973265085;107148;116389.4180529092;117332;18257.63484730298;18307.450776476726;18969;19049.428517144508;19049.61900761977;32527.837360813046;32547.674523254937;32708;32724.509132363033;33054.66945330564;10065.899341006496;10104.595816167419;10149.746256343651;10229.28395012342;10378;8431.28334091609;8472.44929079608;8563.987462946203;8700.260477859327;8764.737057888273;9234.584443700049;9304;9443.527823608792;9475.241980641533;9635.373700709431;3834.578196398394;3868.497095377639;3953.9802300988886;3972.56301806801;4009.7745751108414;953.3898305084751;969.5976169889558;971.8882328532309;986.2208855004609;993.1359717046216;21688.91555422254;21907.452313692283;21921.890390547946;21922.013509392116;21958.560828783335;988.4678747940663;994.1053052252886;999.3054826895383;1009.6769033909079;1021.6832781837654;11677.591284305008;11805.173637845268;11976.461059252355;12090.939545302217;12114.575989840314;617617;630481;634638;646383;651776;104913.47543262235;110900.4454977736;112999;115798;117003;1318.2222488731502;1323.4375390459015;1327.6282640860381;1328.2372664857073;1347.5014244729316;18613.906930465262;18775.812241877953;18799.71800423022;18821.435356939313;19148.23407063702;39264.03679815941;45324.546754532035;47613.28580071371;52538.474615253355;54136.187957181464;66993.3300666987;66995.3300466989;67638.66180669262;68182.65908670425;68920;7999.240072193133;11300.434978251218;12394.566190183301;12581.811272830731;12909.54816581415;13296.202227866359;14141.787873182117;14378.784318235445;14391;14634.195119268543;12157.574484892986;12268.509259629873;12347.19743216688;12393.380330983235;12476.937615311865;10873.347599144077;11512.769744605228;11854.466549005143;12035.578754743541;12051.457684404399;12541.811872822098;12671.113022088366;13077.215367078006;13126.540571079966;13681.179129252278;12398.62804115878;12693.555725549562;12701.618951431472;12805.679858003252;12829.486820527074;12436.378181090728;12486.438110284877;12528.498860045496;12605.243685378906;12624 15:31:52 INFO - PROCESS | 26508 | |3;mootools.html;1525.5042111313826;1554.7279226135424;1559.4931647214655;1560.2666746629081;1566.764985252212;9945.353552019133;10214.336068155564;11526.0779137669;11948.64154075378;11977.64067077988;11133.165012624046;11408.429578521062;11478;11492.367919764409;11820.7635847283;2398.292503711405;2412.131632612267;2420.721617014048;2422.3338581890034;2424.0425032112307;2327.2669109230537;2380.9047638094457;2391.485830546432;2391.8086553075714;2395.568797616428;2292.885355732215;2317.8261630377706;2322.907083716649;2338.497223097034;2339.508703172336;2207.39296693409;2232.620454522735;2360.126753101355;2367.171489978511;2393.401649587603;2207.249535158054;2212.7455342635644;2216.9778302216932;2221.489057516764;2226.565819665166;11813.586524471688;11959.461824217931;11984.340861252627;12016.038716902627;12021.579244726392;5658.151277308396;5744.798932037401;5807.912881306784;5825.0679891217205;5827.329857066449;3252.6259480159847;3315.469524876032;3454.222799870034;3470.2712430389647;3504.8083651558336;1227.4783217132683;1289.2522337044493;1302.4204229118047;1306.333769777411;1378;18331.725024124647;18433.446996590123;18467.076646167774;18482.353117640818;18508.90745546277;4417.668674849399;4599.517050709695;4615.653825963066;4639.118567472169;4758.191107511731;14471.565853024425;14498.782518262024;14509.637259068397;14517.927410362881;14523.273836308143;5718.027935251017;5765.769369225268;5812.651240925558;5833.066709326487;5835.562332825055;4384.210842048462;5013.197888337849;5316.9202461963105;5331.546818520469;5405.729713514387;4238.427812245307;4270.978645106817;4362.498312694017;4399.296112621965;4405.361222622766;1123.640435060789;1128.8476055732372;1153.1236260442124;1154.0825044089968;1156.0751398880861;1014.9746256343503;1023.1967905194535;1042.74452759073;1055.7677310991724;1059.819830628795;6836.829079272959;7051.189113252041;7127.857442851114;7133.429325653935;7287.161976372785;1036.7045392063226;1056.8626078609732;1070.9892901071046;1077.2997551591527;1086.8315411111291;4464.241079016575;4506.278995360726;4538.636909047268;4554.111948170075;4562.840300589463;14989.250537473083;15032.248387580577;15449.922750386177;15538.922305388627;15546.378144874305;15417.537473875802;15440.613984650248;15445;15490.302936367665;15527.146006969499;10988.175886808362;11112;11256.943715281372;11279.379634120201;11282.717932051764;6776.220734615582;6951.200611929693;7004.684789184601;7051.153861536648;7070.540414873017;13376.933115334361;13396.26320552379;13730.51943181984;13737;13750.312484375941;13808.447662093404;13851;13877.722445550831;13911.373988170759;13915.930420347833;8125;8368.874466883124;9553.856692149484;10111.494425278559;10323.793524129625;10997.230193886351;11025;11127.221094523306;11137.443127843737;11280.943595281971;9338.859917101114;9429.669961551313;9499.097585729345;9634.9036509634;9665.178459830993;8839.337049721426;8879.733607991771;8904.287656987295;8978.461292322481;9104.499252541174;8373.790655233668;8436.409451338348;8505.87241191395;8514.574271286287;8542.615582298688;6555.737770489127;6602.570832895846;6640.169978752656;6642.4686025118845;6643.468522518284;6316.273628532777;6377.553571249968;6409.839754006187;6487.772927947688;6543.70553325092 15:31:52 INFO - PROCESS | 26508 | |4;prototype.html;397.62821761652873;432.6863024307378;435.82566973210714;437.19556016928857;437.75704484011374;5339.546138578221;5395.244665746799;5407.810726624564;5421.048422567872;5443.401225865156;5100.923486147711;5398.64908780929;5406.702631355274;5418.485243901833;5426.945730542693;4445.422095127629;4453.688241823073;4455.8217671293105;4455.836356187111;4479;4377.737335759849;4472.741265660837;4477.820887164509;4481.417415735949;4483.887902802423;4423.3807266982485;4490.326451032339;4497.955020449786;4545.909081818361;4550.135474259897;4448.799804008811;4456.309272062836;4475.485319188302;4476.574725401082;4494.1461122386645;4212.326027835532;4214.726042807208;4222.831086756526;4227.450431443893;4229.97885010576;5248.580113590903;5249.448807875195;5252.868678283074;5256.8685782855355;5261.605379596507;4977.527134922177;5232.215167724834;5286.947130528684;5291.756437237246;5300.681959082467;5642.4357564243655;5674.120511320711;5694.487496125327;5719.513841323493;5730.312362516483;4484.730916145042;4663.44038715353;4736.242201247784;4748.335233067373;4748.430188377417;5641.633293835887;5742.598018138732;5749.390170752196;5789.8552536186935;5812.041013232812;4759.143354196209;4794;4807.423109226916;4839.41926968766;4870.09903167915;4948.233023881304;4956.851294461172;4966.478519755446;4968.30443737877;4969.776360063805;5037.4458809530925;5204.895902082013;5222.764975576109;5239.554637855748;5282.445343238982;5632.211490391349;5655.575831812631;5659.773609055674;5663.7451314690115;5695.063678349298;1687.9746803797952;1696.50801267631;1699.3287651377636;1702.3105642214923;1707.7011522983428;1227.3311045480234;1302.1731200687443;1335.105479328852;1338.4713038349992;1342.7381660576093;5334.839954801362;5504.935649131576;5589.9379117967455;5607.467290607386;5610.663360198319;5821.79623713168;5845.561582881301;5865.530757539386;5877.970610146922;5923.2752933651;5391.4608539145775;5617.578681598815;5638.971805140948;5655.491005809415;5694.174344719992;3053.5267033609825;3069.5088785794164;3075.1697041799034;3093.907182784475;3106.673799251091;6002.939970600238;6097.542684298695;6106.328303886569;6110.572259941761;6111.113888486145;5634.154876768517;5815.912761308584;5826.446487583673;5828.271466066742;5866.354700982888;5812.244408226903;5942.405759424023;6009.969950150221;6040.335563088057;6047.667378294236;5458.181272809111;5702.600817942704;5720.199172115824;5796.507296879812;5802.970985145047;5615.326160860723;5615.522680572197;5663.150527420919;5716.371199168171;5721.799737009184;5871.442212989759;5927.673977931255;5945.197398351167;5947.910781338197;5948.345681975065;4767.189577771718;4816.012717392996;4848.515148485264;4873.317735516959;4908.558229759339;5553.8333849984565;5816.302043754607;5836.416358364299;5865.266841644794;5897.498712609477;5694.544436445157;5707.1153971134545;5713.514351280188;5714.342850572071;5726.942730572808;5569.972150139223;5674.4892959633835;5674.659520428788;5753.769849206153;5782.2483077199695;5609.74756135983;5615.6630602164005;5618.85952851182;5635.492805647511;5674.943250567607;5709.857253568694;5748.712564371848;5755.395683453345;5807.970960145172;5822.0598597707885;5409.702466364388;5529.806456773994;5554.555635549227;5573.052581061148;5634 15:31:52 INFO - PROCESS | 26508 | |5;yui.html;758.6206896551721;763.4083585221456;913.0058579569753;921.6497730862276;934.9626014959402;16271.267792949317;16521.256543455558;16571.254293556787;16959.83040169598;17466;16883.24025418856;17078.914605426988;17242.13789310536;17876.64246715065;18871.24515019401;864.511550973701;868.6481974800216;906.7189171356868;908.5593487158723;913.3834661603424;869.6608322754131;878.0692465986075;880.1242763450376;881.8897637795276;888.1207604471591;933.1974501928336;933.6218831373304;934.9626014959393;935.6210734652477;937.0208132501552;923.875276837625;925.0610630210342;926.0276709455112;926.8470702334107;930.9991758859253;672.143017652497;675.3280485916545;679.6533767778468;680.3842522517081;681.3356976947437;17804.821951780446;17991.73012404815;18120.093995300183;18341.26634934601;18377.081145942648;15835;16012.679746405123;16146.273417696231;16227.91886040574;16342.591435214095;13056.34718264083;13264.867351326557;13395.263260520667;13623.795643065361;13625.318734063258;3970.5830887756947;4006.098627808749;4015.759054456742;4060.0255938574824;4107.732997355162;89287;89607.55196224042;90308.64537032016;91645;93274.5336273321;11131.944340278247;11140;11184.552617895355;11210.495527701272;11280.605178818701;23525.529489410117;23727.40681482942;23756.406089847893;23775.405614859767;24009.759902400754;8705.303575714055;8964.641414343354;8990.100989900957;9117.544122793966;9156.45061296311;4434.268345722984;4509.7970591323465;4576.702514336557;4583.793729282191;4617.676762626651;3752.7373083883867;3941.625545573166;3968.8214030368704;3975.602439756059;4001.6998725095737;635.3106879036205;646.2245305633259;653.0335104045944;657.0571230284557;658.706875440434;832.0172182724999;837.9832800492522;848.728406909783;859.1494420523636;862.4092496639696;11087.611933582448;11225.214235003472;11480.540778368771;11716.062714982781;11807.527698891949;660.9504287178385;662.7315937045504;688.0882830249939;707.8938159276047;862.5256109139948;5250.291210686585;5356.598255130881;5485.17722341644;5487.259220005328;5500.7524661390335;69746.302536975;78875.60562197267;79199.60400197962;79591;81424;67216.32783672199;67320.32679673239;67440;68110.31889681138;68189.3181068193;61837.38162618406;62592;63809.36190638034;65683.34316656868;65908.01137982935;9886.159676427296;10051.145652619609;10091.848622270525;10119.59521619127;10220.4378759166;42068.78965605152;42249.78875105605;43137.78431107824;43289;43395.783021084695;41933.58066419419;43463.13073738444;47406.52593474021;47454.52545474501;47675.52324476711;10850.565977360817;10995.945020274847;10998.395088270221;11017.724556886142;11050.557977681125;13640.863591364356;13810.37853296584;13822.792658109935;13877.861221387657;13959.511417100353;13308.86691133115;13358.131721438076;13463.77035380387;13538.12002219892;13667.521636742666;12176.147669663038;12374;12535.24788512692;12633;12637.431315590637;13073.803892941803;13217.662637073345;13378.531751388655;13441.731165376834;13498.59504214875;10157.54291056919;10496.79006419852;10521.316114452537;10604.098651614699;10831.2959657622;11574.71063223426;11622.593209237637;11712.472938717949;11783.175177737476;11862.169648124549 15:31:52 INFO - PROCESS | 26508 | __end_tp_report 15:31:52 INFO - PROCESS | 26508 | __start_cc_report 15:31:52 INFO - PROCESS | 26508 | _x_x_mozilla_cycle_collect,318 15:31:52 INFO - PROCESS | 26508 | __end_cc_report 15:31:52 INFO - PROCESS | 26508 | __startTimestamp1491431512811__endTimestamp 15:31:52 INFO - PROCESS | 26508 | 15:31:52 INFO - PROCESS | 26508 | ------- Summary: start ------- 15:31:52 INFO - PROCESS | 26508 | Number of tests: 6 15:31:52 INFO - PROCESS | 26508 | 15:31:52 INFO - PROCESS | 26508 | [#0] dojo.html Cycles:165 Average:5799.50 Median:6041.31 stddev:661.30 (10.9%) stddev-sans-first:636.19 15:31:52 INFO - PROCESS | 26508 | Values: 3409.5 3420.8 3434.4 3458.4 3470.6 5807.9 5860.7 5875.0 5875.6 5881.3 5811.4 5835.1 5837.3 5841.9 5842.7 5154.5 5274.8 5286.4 5287.4 5309.6 5317.5 5323.5 5323.9 5329.4 5331.9 5080.2 5100.0 5310.9 5312.5 5314.3 5230.2 5232.7 5246.3 5260.4 5292.3 5186.9 5279.7 5280.8 5285.9 5294.7 5582.6 5786.4 5814.1 5911.5 5929.3 6118.6 6148.0 6176.7 6202.0 6219.8 6346.7 6349.3 6350.1 6355.2 6364.8 5908.1 5908.5 5910.7 5919.3 5947.0 6198.7 6202.7 6262.5 6311.1 6317.9 6125.2 6183.7 6188.6 6200.2 6202.9 6268.0 6271.6 6282.8 6284.2 6291.1 6035.1 6037.2 6134.2 6149.0 6189.8 6254.5 6270.9 6271.5 6273.7 6278.9 4645.3 4684.1 4691.5 4717.6 4830.7 4264.4 4296.4 4304.8 4315.8 4322.9 5891.9 5941.1 6126.2 6139.8 6141.4 6201.6 6219.7 6242.4 6255.6 6273.6 6066.6 6117.7 6160.1 6168.1 6175.8 5126.6 5330.4 5353.9 5370.7 5381.5 6307.2 6412.2 6456.6 6479.7 6490.4 6328.5 6344.2 6345.6 6350.8 6355.4 6446.7 6557.2 6577.1 6590.7 6593.5 6006.9 6023.5 6048.5 6099.1 6147.5 6260.0 6263.8 6267.8 6276.6 6285.5 6041.3 6050.6 6071.8 6087.9 6089.3 5917.6 5956.3 6016.3 6031.6 6034.7 6019.7 6049.7 6080.7 6082.1 6116.2 6044.7 6131.4 6139.9 6139.9 6142.2 5815.3 5831.9 5941.8 5960.7 6006.6 15:31:52 INFO - PROCESS | 26508 | 15:31:52 INFO - PROCESS | 26508 | [#1] ext.html Cycles:180 Average:47958.15 Median:31245.77 stddev:86712.35 (277.5%) stddev-sans-first:86883.22 15:31:52 INFO - PROCESS | 26508 | Values: 770.6 841.3 859.1 922.4 933.1 41578.8 42791.0 43122.8 43145.5 45361.3 43395.6 43608.1 43656.0 43729.8 43758.6 9157.4 9293.0 9302.8 10199.0 10433.1 10226.4 10240.6 10264.3 10303.2 10308.8 10286.5 10335.9 10407.5 10442.8 10446.1 10248.3 10286.9 10319.2 10319.6 10382.1 10122.2 10134.7 10176.0 10184.0 10196.6 35147.3 35207.3 35340.3 35434.0 35587.6 3718.4 3728.4 3744.4 3757.3 3873.8 26778.9 26839.6 26906.9 27043.7 27374.7 4357.0 4403.2 4408.7 4439.4 4499.0 232040.0 237418.0 239883.0 277483.0 279739.0 46770.5 46949.8 47188.3 47234.0 47261.1 49061.5 49191.5 49225.8 49318.8 49322.5 15546.0 15584.1 15589.9 15634.9 15653.5 13577.6 13610.7 13698.5 13699.9 13704.5 13018.9 13130.0 13158.1 13158.2 13164.2 5617.1 5628.2 5665.3 5666.6 5686.2 1005.4 1012.7 1024.3 1025.1 1034.0 27509.4 27969.0 28368.1 28857.3 29165.7 1092.1 1100.5 1103.5 1118.2 1128.3 14424.4 14757.8 14798.2 14889.3 15194.8 315641.0 321559.0 333651.0 444593.0 447167.0 48783.0 48939.5 49079.0 49089.5 49587.0 1328.1 1349.2 1490.4 1496.8 1515.9 28750.7 30271.5 30454.0 30479.8 30791.0 48573.3 48592.8 48835.3 48917.5 49051.5 343417.0 345087.0 345091.0 345523.0 346710.0 30363.2 30446.1 31651.2 33311.5 33941.7 40822.0 41147.4 41320.6 41337.4 41507.8 31143.2 31194.5 31366.4 31414.5 32023.8 31297.0 31399.5 31399.8 31463.4 32085.5 35557.5 35747.0 35941.0 36788.8 36871.4 29487.4 29989.4 30022.1 30271.5 30307.5 24841.5 24918.3 24980.6 25003.6 25350.2 15:31:52 INFO - PROCESS | 26508 | 15:31:52 INFO - PROCESS | 26508 | [#2] jquery.html Cycles:180 Average:36772.08 Median:21940.29 stddev:104838.16 (477.8%) stddev-sans-first:105096.83 15:31:52 INFO - PROCESS | 26508 | Values: 471.7 471.9 476.5 489.1 490.9 19520.4 19637.6 21376.1 21471.9 21489.2 20732.9 21354.7 22920.2 23063.0 23127.9 6775.6 6881.3 6898.8 6957.7 6964.2 6621.7 6838.7 6844.5 6851.4 6855.6 6572.9 6597.3 6609.6 6651.3 6652.6 6648.6 6789.5 6863.8 6873.0 6881.7 6666.5 6673.1 6678.5 6684.4 6698.4 23051.8 24794.1 24801.9 24963.4 25050.7 2986.0 3046.6 3048.6 3048.7 3165.4 15686.0 16376.5 16784.7 16965.5 17123.4 2044.3 2089.6 2128.4 2136.1 2137.6 97632.0 106053.5 107148.0 116389.4 117332.0 18257.6 18307.5 18969.0 19049.4 19049.6 32527.8 32547.7 32708.0 32724.5 33054.7 10065.9 10104.6 10149.7 10229.3 10378.0 8431.3 8472.4 8564.0 8700.3 8764.7 9234.6 9304.0 9443.5 9475.2 9635.4 3834.6 3868.5 3954.0 3972.6 4009.8 953.4 969.6 971.9 986.2 993.1 21688.9 21907.5 21921.9 21922.0 21958.6 988.5 994.1 999.3 1009.7 1021.7 11677.6 11805.2 11976.5 12090.9 12114.6 617617.0 630481.0 634638.0 646383.0 651776.0 104913.5 110900.4 112999.0 115798.0 117003.0 1318.2 1323.4 1327.6 1328.2 1347.5 18613.9 18775.8 18799.7 18821.4 19148.2 39264.0 45324.5 47613.3 52538.5 54136.2 66993.3 66995.3 67638.7 68182.7 68920.0 7999.2 11300.4 12394.6 12581.8 12909.5 13296.2 14141.8 14378.8 14391.0 14634.2 12157.6 12268.5 12347.2 12393.4 12476.9 10873.3 11512.8 11854.5 12035.6 12051.5 12541.8 12671.1 13077.2 13126.5 13681.2 12398.6 12693.6 12701.6 12805.7 12829.5 12436.4 12486.4 12528.5 12605.2 12624.0 15:31:52 INFO - PROCESS | 26508 | 15:31:52 INFO - PROCESS | 26508 | [#3] mootools.html Cycles:180 Average:7295.49 Median:2325.09 stddev:4862.53 (209.1%) stddev-sans-first:4856.85 15:31:52 INFO - PROCESS | 26508 | Values: 1525.5 1554.7 1559.5 1560.3 1566.8 9945.4 10214.3 11526.1 11948.6 11977.6 11133.2 11408.4 11478.0 11492.4 11820.8 2398.3 2412.1 2420.7 2422.3 2424.0 2327.3 2380.9 2391.5 2391.8 2395.6 2292.9 2317.8 2322.9 2338.5 2339.5 2207.4 2232.6 2360.1 2367.2 2393.4 2207.2 2212.7 2217.0 2221.5 2226.6 11813.6 11959.5 11984.3 12016.0 12021.6 5658.2 5744.8 5807.9 5825.1 5827.3 3252.6 3315.5 3454.2 3470.3 3504.8 1227.5 1289.3 1302.4 1306.3 1378.0 18331.7 18433.4 18467.1 18482.4 18508.9 4417.7 4599.5 4615.7 4639.1 4758.2 14471.6 14498.8 14509.6 14517.9 14523.3 5718.0 5765.8 5812.7 5833.1 5835.6 4384.2 5013.2 5316.9 5331.5 5405.7 4238.4 4271.0 4362.5 4399.3 4405.4 1123.6 1128.8 1153.1 1154.1 1156.1 1015.0 1023.2 1042.7 1055.8 1059.8 6836.8 7051.2 7127.9 7133.4 7287.2 1036.7 1056.9 1071.0 1077.3 1086.8 4464.2 4506.3 4538.6 4554.1 4562.8 14989.3 15032.2 15449.9 15538.9 15546.4 15417.5 15440.6 15445.0 15490.3 15527.1 10988.2 11112.0 11256.9 11279.4 11282.7 6776.2 6951.2 7004.7 7051.2 7070.5 13376.9 13396.3 13730.5 13737.0 13750.3 13808.4 13851.0 13877.7 13911.4 13915.9 8125.0 8368.9 9553.9 10111.5 10323.8 10997.2 11025.0 11127.2 11137.4 11280.9 9338.9 9429.7 9499.1 9634.9 9665.2 8839.3 8879.7 8904.3 8978.5 9104.5 8373.8 8436.4 8505.9 8514.6 8542.6 6555.7 6602.6 6640.2 6642.5 6643.5 6316.3 6377.6 6409.8 6487.8 6543.7 15:31:52 INFO - PROCESS | 26508 | 15:31:52 INFO - PROCESS | 26508 | [#4] prototype.html Cycles:180 Average:4936.54 Median:5424.00 stddev:1313.23 (24.2%) stddev-sans-first:1271.96 15:31:52 INFO - PROCESS | 26508 | Values: 397.6 432.7 435.8 437.2 437.8 5339.5 5395.2 5407.8 5421.0 5443.4 5100.9 5398.6 5406.7 5418.5 5426.9 4445.4 4453.7 4455.8 4455.8 4479.0 4377.7 4472.7 4477.8 4481.4 4483.9 4423.4 4490.3 4498.0 4545.9 4550.1 4448.8 4456.3 4475.5 4476.6 4494.1 4212.3 4214.7 4222.8 4227.5 4230.0 5248.6 5249.4 5252.9 5256.9 5261.6 4977.5 5232.2 5286.9 5291.8 5300.7 5642.4 5674.1 5694.5 5719.5 5730.3 4484.7 4663.4 4736.2 4748.3 4748.4 5641.6 5742.6 5749.4 5789.9 5812.0 4759.1 4794.0 4807.4 4839.4 4870.1 4948.2 4956.9 4966.5 4968.3 4969.8 5037.4 5204.9 5222.8 5239.6 5282.4 5632.2 5655.6 5659.8 5663.7 5695.1 1688.0 1696.5 1699.3 1702.3 1707.7 1227.3 1302.2 1335.1 1338.5 1342.7 5334.8 5504.9 5589.9 5607.5 5610.7 5821.8 5845.6 5865.5 5878.0 5923.3 5391.5 5617.6 5639.0 5655.5 5694.2 3053.5 3069.5 3075.2 3093.9 3106.7 6002.9 6097.5 6106.3 6110.6 6111.1 5634.2 5815.9 5826.4 5828.3 5866.4 5812.2 5942.4 6010.0 6040.3 6047.7 5458.2 5702.6 5720.2 5796.5 5803.0 5615.3 5615.5 5663.2 5716.4 5721.8 5871.4 5927.7 5945.2 5947.9 5948.3 4767.2 4816.0 4848.5 4873.3 4908.6 5553.8 5816.3 5836.4 5865.3 5897.5 5694.5 5707.1 5713.5 5714.3 5726.9 5570.0 5674.5 5674.7 5753.8 5782.2 5609.7 5615.7 5618.9 5635.5 5674.9 5709.9 5748.7 5755.4 5808.0 5822.1 5409.7 5529.8 5554.6 5573.1 5634.0 15:31:52 INFO - PROCESS | 26508 | 15:31:52 INFO - PROCESS | 26508 | [#5] yui.html Cycles:180 Average:17991.25 Median:42159.29 stddev:22902.19 (54.3%) stddev-sans-first:22929.88 15:31:52 INFO - PROCESS | 26508 | Values: 758.6 763.4 913.0 921.6 935.0 16271.3 16521.3 16571.3 16959.8 17466.0 16883.2 17078.9 17242.1 17876.6 18871.2 864.5 868.6 906.7 908.6 913.4 869.7 878.1 880.1 881.9 888.1 933.2 933.6 935.0 935.6 937.0 923.9 925.1 926.0 926.8 931.0 672.1 675.3 679.7 680.4 681.3 17804.8 17991.7 18120.1 18341.3 18377.1 15835.0 16012.7 16146.3 16227.9 16342.6 13056.3 13264.9 13395.3 13623.8 13625.3 3970.6 4006.1 4015.8 4060.0 4107.7 89287.0 89607.6 90308.6 91645.0 93274.5 11131.9 11140.0 11184.6 11210.5 11280.6 23525.5 23727.4 23756.4 23775.4 24009.8 8705.3 8964.6 8990.1 9117.5 9156.5 4434.3 4509.8 4576.7 4583.8 4617.7 3752.7 3941.6 3968.8 3975.6 4001.7 635.3 646.2 653.0 657.1 658.7 832.0 838.0 848.7 859.1 862.4 11087.6 11225.2 11480.5 11716.1 11807.5 661.0 662.7 688.1 707.9 862.5 5250.3 5356.6 5485.2 5487.3 5500.8 69746.3 78875.6 79199.6 79591.0 81424.0 67216.3 67320.3 67440.0 68110.3 68189.3 61837.4 62592.0 63809.4 65683.3 65908.0 9886.2 10051.1 10091.8 10119.6 10220.4 42068.8 42249.8 43137.8 43289.0 43395.8 41933.6 43463.1 47406.5 47454.5 47675.5 10850.6 10995.9 10998.4 11017.7 11050.6 13640.9 13810.4 13822.8 13877.9 13959.5 13308.9 13358.1 13463.8 13538.1 13667.5 12176.1 12374.0 12535.2 12633.0 12637.4 13073.8 13217.7 13378.5 13441.7 13498.6 10157.5 10496.8 10521.3 10604.1 10831.3 11574.7 11622.6 11712.5 11783.2 11862.2 15:31:52 INFO - PROCESS | 26508 | -------- Summary: end -------- 15:31:52 INFO - PROCESS | 26508 | 15:31:53 INFO - TEST-INFO | 26508: exit 0 15:31:53 INFO - TEST-OK | dromaeo_css | took 1113623ms 15:31:53 INFO - TEST-START | kraken 15:31:53 INFO - operating with platform_type : linux_ 15:31:53 INFO - Initialising browser for kraken test... 15:31:53 INFO - TEST-INFO | started process 26883 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpQD0mYI/profile http://localhost:46644/getInfo.html) 15:31:57 INFO - PROCESS | 26883 | __metrics Screen width/height:1600/1200 15:31:57 INFO - PROCESS | 26883 | colorDepth:24 15:31:57 INFO - PROCESS | 26883 | Browser inner width/height: 1024/697 15:31:57 INFO - PROCESS | 26883 | __metrics 15:31:58 ERROR - PROCESS | 26883 | 1491431518725 addons.xpi WARN Exception running bootstrap method shutdown on shield-recipe-client@mozilla.org: TypeError: log is null (resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/firefox/browser/features/shield-recipe-client@mozilla.org.xpi!/bootstrap.js:96:5) JS Stack trace: this.shutdown@resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/firefox/browser/features/shield-recipe-client@bootstrap.js:96:5 < callBootstrapMethod@XPIProvider.jsm:4954:11 < observe@XPIProvider.jsm:2917:15 < permitUnload@remote-browser.xml:357:13 < CanCloseWindow@browser.js:6373:36 < canClose@browser.js:5234:12 < forceQuit@jar:file:///tmp/tmpQD0mYI/profile/extensions/talos-powers@TalosPowersService.js:237:7 < whenDone@jar:file:///tmp/tmpQD0mYI/profile/extensions/talos-powers@TalosPowersService.js:222:9 < promise callback*forceQuit@jar:file:///tmp/tmpQD0mYI/profile/extensions/talos-powers@TalosPowersService.js:224:7 < receiveMessage@jar:file:///tmp/tmpQD0mYI/profile/extensions/talos-powers@TalosPowersService.js:55:9 15:31:58 ERROR - PROCESS | 26883 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3360: TypeError: this.tabs is undefined 15:31:59 INFO - TEST-INFO | 26883: exit 0 15:31:59 INFO - Browser initialized. 15:31:59 INFO - Running cycle 1/1 for kraken test... 15:31:59 INFO - TEST-INFO | started process 27014 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpQD0mYI/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:32:11 INFO - PROCESS | 27014 | RSS: Main: 146821120 15:32:11 INFO - PROCESS | 27014 | 15:32:14 INFO - PROCESS | 27014 | Cycle 1(1): loaded http://localhost:46644/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:46644/tests/kraken/driver.html?testName=audio-beat-detection) 15:32:14 INFO - PROCESS | 27014 | RSS: Main: 154193920 15:32:14 INFO - PROCESS | 27014 | 15:32:17 INFO - PROCESS | 27014 | Cycle 1(1): loaded http://localhost:46644/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:46644/tests/kraken/driver.html?testName=audio-dft) 15:32:18 INFO - PROCESS | 27014 | RSS: Main: 152907776 15:32:18 INFO - PROCESS | 27014 | 15:32:20 INFO - PROCESS | 27014 | Cycle 1(1): loaded http://localhost:46644/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:46644/tests/kraken/driver.html?testName=audio-fft) 15:32:21 INFO - PROCESS | 27014 | RSS: Main: 153141248 15:32:21 INFO - PROCESS | 27014 | 15:32:23 INFO - PROCESS | 27014 | Cycle 1(1): loaded http://localhost:46644/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:46644/tests/kraken/driver.html?testName=audio-oscillator) 15:32:24 INFO - PROCESS | 27014 | RSS: Main: 153092096 15:32:24 INFO - PROCESS | 27014 | 15:32:26 INFO - PROCESS | 27014 | Cycle 1(1): loaded http://localhost:46644/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:46644/tests/kraken/driver.html?testName=imaging-gaussian-blur) 15:32:27 INFO - PROCESS | 27014 | RSS: Main: 152969216 15:32:27 INFO - PROCESS | 27014 | 15:32:30 INFO - PROCESS | 27014 | Cycle 1(1): loaded http://localhost:46644/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:46644/tests/kraken/driver.html?testName=imaging-darkroom) 15:32:30 INFO - PROCESS | 27014 | RSS: Main: 155807744 15:32:30 INFO - PROCESS | 27014 | 15:32:34 INFO - PROCESS | 27014 | Cycle 1(1): loaded http://localhost:46644/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:46644/tests/kraken/driver.html?testName=imaging-desaturate) 15:32:34 INFO - PROCESS | 27014 | RSS: Main: 156291072 15:32:34 INFO - PROCESS | 27014 | 15:32:37 INFO - PROCESS | 27014 | Cycle 1(1): loaded http://localhost:46644/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:46644/tests/kraken/driver.html?testName=json-parse-financial) 15:32:38 INFO - PROCESS | 27014 | RSS: Main: 155365376 15:32:38 INFO - PROCESS | 27014 | 15:32:39 INFO - PROCESS | 27014 | Cycle 1(1): loaded http://localhost:46644/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:46644/tests/kraken/driver.html?testName=json-stringify-tinderbox) 15:32:40 INFO - PROCESS | 27014 | RSS: Main: 154849280 15:32:40 INFO - PROCESS | 27014 | 15:32:42 INFO - PROCESS | 27014 | Cycle 1(1): loaded http://localhost:46644/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:46644/tests/kraken/driver.html?testName=stanford-crypto-aes) 15:32:42 INFO - PROCESS | 27014 | RSS: Main: 155316224 15:32:42 INFO - PROCESS | 27014 | 15:32:44 INFO - PROCESS | 27014 | Cycle 1(1): loaded http://localhost:46644/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:46644/tests/kraken/driver.html?testName=stanford-crypto-ccm) 15:32:45 INFO - PROCESS | 27014 | RSS: Main: 155664384 15:32:45 INFO - PROCESS | 27014 | 15:32:48 INFO - PROCESS | 27014 | Cycle 1(1): loaded http://localhost:46644/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:46644/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 15:32:48 INFO - PROCESS | 27014 | RSS: Main: 155258880 15:32:48 INFO - PROCESS | 27014 | 15:32:51 INFO - PROCESS | 27014 | Cycle 1(1): loaded http://localhost:46644/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:46644/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 15:32:52 INFO - PROCESS | 27014 | RSS: Main: 155316224 15:32:52 INFO - PROCESS | 27014 | 15:32:53 INFO - PROCESS | 27014 | Cycle 1(1): loaded http://localhost:46644/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:46644/tests/kraken/driver.html?testName=ai-astar) 15:32:54 INFO - PROCESS | 27014 | RSS: Main: 157061120 15:32:54 INFO - PROCESS | 27014 | 15:32:54 INFO - PROCESS | 27014 | __start_tp_report 15:32:54 INFO - PROCESS | 27014 | _x_x_mozilla_page_load 15:32:54 INFO - PROCESS | 27014 | _x_x_mozilla_page_load_details 15:32:54 INFO - PROCESS | 27014 | |i|pagename|runs| 15:32:54 INFO - PROCESS | 27014 | |0;ai-astar;103;112;114;112;112;114;114;113;111;113 15:32:54 INFO - PROCESS | 27014 | |1;audio-beat-detection;147;117;122;153;118;120;119;120;137;119 15:32:54 INFO - PROCESS | 27014 | |2;audio-dft;162;163;165;164;163;163;161;167;163;163 15:32:54 INFO - PROCESS | 27014 | |3;audio-fft;75;77;76;112;87;76;77;76;107;78 15:32:54 INFO - PROCESS | 27014 | |4;audio-oscillator;84;83;109;84;83;83;94;83;83;109 15:32:54 INFO - PROCESS | 27014 | |5;imaging-gaussian-blur;114;115;113;114;114;114;113;114;114;114 15:32:54 INFO - PROCESS | 27014 | |6;imaging-darkroom;150;147;148;148;148;148;147;148;148;148 15:32:54 INFO - PROCESS | 27014 | |7;imaging-desaturate;100;95;95;95;95;94;95;95;95;94 15:32:54 INFO - PROCESS | 27014 | |8;json-parse-financial;67;60;59;61;59;60;60;60;61;60 15:32:54 INFO - PROCESS | 27014 | |9;json-stringify-tinderbox;53;53;53;53;53;54;53;54;54;54 15:32:54 INFO - PROCESS | 27014 | |10;stanford-crypto-aes;79;81;80;78;79;80;82;80;77;81 15:32:54 INFO - PROCESS | 27014 | |11;stanford-crypto-ccm;123;124;143;123;135;131;120;124;167;129 15:32:54 INFO - PROCESS | 27014 | |12;stanford-crypto-pbkdf2;165;166;163;162;160;157;161;161;162;158 15:32:54 INFO - PROCESS | 27014 | |13;stanford-crypto-sha256-iterative;61;61;62;60;66;65;60;60;59;60 15:32:54 INFO - PROCESS | 27014 | __end_tp_report 15:32:54 INFO - PROCESS | 27014 | __start_cc_report 15:32:54 INFO - PROCESS | 27014 | _x_x_mozilla_cycle_collect,793 15:32:54 INFO - PROCESS | 27014 | __end_cc_report 15:32:54 INFO - PROCESS | 27014 | __startTimestamp1491431574166__endTimestamp 15:32:54 INFO - PROCESS | 27014 | 15:32:54 INFO - PROCESS | 27014 | ------- Summary: start ------- 15:32:54 INFO - PROCESS | 27014 | Number of tests: 14 15:32:54 INFO - PROCESS | 27014 | 15:32:54 INFO - PROCESS | 27014 | [#0] ai-astar Cycles:10 Average:111.80 Median:113.00 stddev:3.26 (2.9%) stddev-sans-first:1.09 15:32:54 INFO - PROCESS | 27014 | Values: 103.0 112.0 114.0 112.0 112.0 114.0 114.0 113.0 111.0 113.0 15:32:54 INFO - PROCESS | 27014 | 15:32:54 INFO - PROCESS | 27014 | [#1] audio-beat-detection Cycles:10 Average:127.20 Median:121.00 stddev:13.36 (11.0%) stddev-sans-first:12.10 15:32:54 INFO - PROCESS | 27014 | Values: 147.0 117.0 122.0 153.0 118.0 120.0 119.0 120.0 137.0 119.0 15:32:54 INFO - PROCESS | 27014 | 15:32:54 INFO - PROCESS | 27014 | [#2] audio-dft Cycles:10 Average:163.40 Median:163.00 stddev:1.65 (1.0%) stddev-sans-first:1.67 15:32:54 INFO - PROCESS | 27014 | Values: 162.0 163.0 165.0 164.0 163.0 163.0 161.0 167.0 163.0 163.0 15:32:54 INFO - PROCESS | 27014 | 15:32:54 INFO - PROCESS | 27014 | [#3] audio-fft Cycles:10 Average:84.10 Median:76.50 stddev:13.86 (18.1%) stddev-sans-first:14.30 15:32:54 INFO - PROCESS | 27014 | Values: 75.0 77.0 76.0 112.0 87.0 76.0 77.0 76.0 107.0 78.0 15:32:54 INFO - PROCESS | 27014 | 15:32:54 INFO - PROCESS | 27014 | [#4] audio-oscillator Cycles:10 Average:89.50 Median:83.00 stddev:10.81 (13.0%) stddev-sans-first:11.29 15:32:54 INFO - PROCESS | 27014 | Values: 84.0 83.0 109.0 84.0 83.0 83.0 94.0 83.0 83.0 109.0 15:32:54 INFO - PROCESS | 27014 | 15:32:54 INFO - PROCESS | 27014 | [#5] imaging-gaussian-blur Cycles:10 Average:113.90 Median:114.00 stddev:0.57 (0.5%) stddev-sans-first:0.60 15:32:54 INFO - PROCESS | 27014 | Values: 114.0 115.0 113.0 114.0 114.0 114.0 113.0 114.0 114.0 114.0 15:32:54 INFO - PROCESS | 27014 | 15:32:54 INFO - PROCESS | 27014 | [#6] imaging-darkroom Cycles:10 Average:148.00 Median:148.00 stddev:0.82 (0.6%) stddev-sans-first:0.44 15:32:54 INFO - PROCESS | 27014 | Values: 150.0 147.0 148.0 148.0 148.0 148.0 147.0 148.0 148.0 148.0 15:32:54 INFO - PROCESS | 27014 | 15:32:54 INFO - PROCESS | 27014 | [#7] imaging-desaturate Cycles:10 Average:95.30 Median:95.00 stddev:1.70 (1.8%) stddev-sans-first:0.44 15:32:54 INFO - PROCESS | 27014 | Values: 100.0 95.0 95.0 95.0 95.0 94.0 95.0 95.0 95.0 94.0 15:32:54 INFO - PROCESS | 27014 | 15:32:54 INFO - PROCESS | 27014 | [#8] json-parse-financial Cycles:10 Average:60.70 Median:60.00 stddev:2.31 (3.9%) stddev-sans-first:0.71 15:32:54 INFO - PROCESS | 27014 | Values: 67.0 60.0 59.0 61.0 59.0 60.0 60.0 60.0 61.0 60.0 15:32:54 INFO - PROCESS | 27014 | 15:32:54 INFO - PROCESS | 27014 | [#9] json-stringify-tinderbox Cycles:10 Average:53.40 Median:53.50 stddev:0.52 (1.0%) stddev-sans-first:0.53 15:32:54 INFO - PROCESS | 27014 | Values: 53.0 53.0 53.0 53.0 53.0 54.0 53.0 54.0 54.0 54.0 15:32:54 INFO - PROCESS | 27014 | 15:32:54 INFO - PROCESS | 27014 | [#10] stanford-crypto-aes Cycles:10 Average:79.70 Median:80.00 stddev:1.49 (1.9%) stddev-sans-first:1.56 15:32:54 INFO - PROCESS | 27014 | Values: 79.0 81.0 80.0 78.0 79.0 80.0 82.0 80.0 77.0 81.0 15:32:54 INFO - PROCESS | 27014 | 15:32:54 INFO - PROCESS | 27014 | [#11] stanford-crypto-ccm Cycles:10 Average:131.90 Median:130.00 stddev:14.14 (10.9%) stddev-sans-first:14.62 15:32:54 INFO - PROCESS | 27014 | Values: 123.0 124.0 143.0 123.0 135.0 131.0 120.0 124.0 167.0 129.0 15:32:54 INFO - PROCESS | 27014 | 15:32:54 INFO - PROCESS | 27014 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:161.50 Median:162.00 stddev:2.80 (1.7%) stddev-sans-first:2.67 15:32:54 INFO - PROCESS | 27014 | Values: 165.0 166.0 163.0 162.0 160.0 157.0 161.0 161.0 162.0 158.0 15:32:54 INFO - PROCESS | 27014 | 15:32:54 INFO - PROCESS | 27014 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:61.40 Median:61.00 stddev:2.32 (3.8%) stddev-sans-first:2.46 15:32:54 INFO - PROCESS | 27014 | Values: 61.0 61.0 62.0 60.0 66.0 65.0 60.0 60.0 59.0 60.0 15:32:54 INFO - PROCESS | 27014 | -------- Summary: end -------- 15:32:54 INFO - PROCESS | 27014 | 15:32:55 INFO - TEST-INFO | 27014: exit 0 15:32:55 INFO - TEST-OK | kraken | took 61607ms 15:32:55 INFO - SUITE-END | took 1175s 15:32:55 INFO - Completed test suite (00:19:35) 15:32:55 INFO - javascript benchmark 15:32:55 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7833.496141210805, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3409.5397121388614, 3420.811855347955, 3434.3818112739705, 3458.3947809133397, 3470.5661792275964, 5807.883842323156, 5860.706964651772, 5874.970625146873, 5875.559333050022, 5881.264841894763, 5811.418858114186, 5835.0663893777, 5837.270341207349, 5841.941580584204, 5842.678652674102, 5154.484551544843, 5274.789008439658, 5286.444923283038, 5287.41838397776, 5309.62832601718, 5317.5480084192695, 5323.520883120518, 5323.893522129555, 5329.440408757083, 5331.920021199685, 5080.187170052793, 5100.0, 5310.867228319304, 5312.495312945264, 5314.335708036496, 5230.21546767984, 5232.659877107995, 5246.265522826808, 5260.447652996419, 5292.311999440087, 5186.896262074775, 5279.683219006872, 5280.788768449257, 5285.86785330366, 5294.746197709163, 5582.609217354787, 5786.392428795, 5814.098814683689, 5911.467967882868, 5929.258842644669, 6118.588722523077, 6148.047052706793, 6176.660283684396, 6202.0, 6219.782307619212, 6346.682665866734, 6349.269833969107, 6350.110984462179, 6355.237371515402, 6364.77723279683, 5908.084246941731, 5908.46823785857, 5910.734016969247, 5919.289685237799, 5947.0, 6198.690065496708, 6202.72087756052, 6262.467690246289, 6311.084892690534, 6317.905231421532, 6125.20492926512, 6183.721732522047, 6188.566800323934, 6200.224971878515, 6202.875942481215, 6268.028455589391, 6271.592346497463, 6282.780102696383, 6284.245890493079, 6291.1192433059405, 6035.094735789579, 6037.154798328237, 6134.19168101403, 6149.0, 6189.752409903554, 6254.468370188585, 6270.905936410957, 6271.529635277372, 6273.65494897785, 6278.937210627835, 4645.256758918556, 4684.0866031123605, 4691.507391723888, 4717.599004084691, 4830.734309612934, 4264.360345948133, 4296.37702533131, 4304.827806887752, 4315.827366905289, 4322.913541729148, 5891.941080589225, 5941.079132734433, 6126.172966649535, 6139.785107521216, 6141.355157708376, 6201.56589038772, 6219.720112594944, 6242.438180563771, 6255.593386429868, 6273.560850740404, 6066.575339726177, 6117.694115294217, 6160.075988601746, 6168.136460895478, 6175.752969881244, 5126.641135120506, 5330.360356757214, 5353.866153346197, 5370.677759334452, 5381.48875856793, 6307.24313082433, 6412.198475190601, 6456.644884531396, 6479.708413121421, 6490.350964903472, 6328.46208072319, 6344.206974128234, 6345.619262844244, 6350.7777227796805, 6355.3644635536075, 6446.677666116581, 6557.2131344239, 6577.14497115372, 6590.703418346282, 6593.472522198117, 6006.909896351645, 6023.48800351975, 6048.546359023179, 6099.146119543356, 6147.538934580014, 6260.0, 6263.780767673292, 6267.843303917439, 6276.592021518587, 6285.497160227263, 6041.305249896318, 6050.6369617823075, 6071.787487437919, 6087.878242435215, 6089.2997305310455, 5917.5857689961285, 5956.344802071855, 6016.308124565731, 6031.607945483705, 6034.668093254913, 6019.6756713522955, 6049.667268300285, 6080.69596520181, 6082.118092876596, 6116.235470566179, 6044.727987240497, 6131.356207598138, 6139.877202456015, 6139.938600613937, 6142.170806941006, 5815.273090863642, 5831.912521312269, 5941.7623295067715, 5960.731767070405, 6006.579539432372], "value": 5755.198477174513, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [770.6108415250301, 841.3395484544634, 859.1494420523679, 922.4004397141857, 933.104219948849, 41578.792106039466, 42791.0, 43122.78438607806, 43145.46972567882, 45361.31958020632, 43395.566044339546, 43608.12783744323, 43656.0, 43729.78135109328, 43758.56241437585, 9157.404768690047, 9293.0, 9302.767430814216, 10199.0, 10433.113185379252, 10226.43754593497, 10240.641577544788, 10264.332818366782, 10303.227257955647, 10308.845367319496, 10286.537105830219, 10335.948320258389, 10407.479626018707, 10442.791144177112, 10446.112080473169, 10248.333858299224, 10286.9485652572, 10319.1744660427, 10319.638812641597, 10382.117520010808, 10122.240831937634, 10134.746631334276, 10175.982401759838, 10184.032516910956, 10196.592136314539, 35147.29705405878, 35207.295854082775, 35340.29319413623, 35434.0, 35587.64412355869, 3718.442233664945, 3728.384816505273, 3744.4008958566496, 3757.3424650686293, 3873.8063096845326, 26778.866105669345, 26839.597406038924, 26906.86546567274, 27043.729562704317, 27374.726252737415, 4356.956430435686, 4403.207422663919, 4408.691391602589, 4439.356293337481, 4498.977505112486, 232040.0, 237418.0, 239883.0, 277483.0, 279739.0, 46770.5322946773, 46949.76525117353, 47188.2921756174, 47234.0, 47261.05477890423, 49061.509384905694, 49191.50808491869, 49225.753871230416, 49318.75340623346, 49322.50677493179, 15546.0, 15584.142872141914, 15589.90870639067, 15634.9218253908, 15653.452129175652, 13577.59267221985, 13610.659733506742, 13698.452061917611, 13699.863001370059, 13704.451821927012, 13018.869811301955, 13130.0, 13158.078934474495, 13158.21050736959, 13164.210147390995, 5617.101263797855, 5628.240187574707, 5665.348484924204, 5666.575006874501, 5686.175504551817, 1005.4470041477158, 1012.731626119079, 1024.2727663359099, 1025.1337619711333, 1033.9793204136026, 27509.44981100367, 27969.0, 28368.148955530953, 28857.278568035967, 29165.708342916725, 1092.0717390218251, 1100.5047728522036, 1103.4593049405894, 1118.1781390677845, 1128.2722643894642, 14424.378783051778, 14757.77863332051, 14798.186099764616, 14889.255537223096, 15194.772078418833, 315641.0, 321559.0, 333651.0, 444593.0, 447167.0, 48783.0, 48939.51060489421, 49079.0, 49089.509104908495, 49587.0, 1328.130074801007, 1349.1635186184433, 1490.4336352186099, 1496.753035749111, 1515.9166245856584, 28750.712492875642, 30271.481942714818, 30454.0, 30479.847600761856, 30791.0, 48573.27140092831, 48592.75703621459, 48835.26747098868, 48917.510824891295, 49051.509484904695, 343417.0, 345087.0, 345091.0, 345523.0, 346710.0, 30363.24091897632, 30446.086617401514, 31651.20871978219, 33311.50032749559, 33941.66058339385, 40822.0, 41147.38278925879, 41320.586794132876, 41337.379939300336, 41507.792461037505, 31143.221419464695, 31194.532082018333, 31366.372672545964, 31414.52878206783, 32023.839880800446, 31297.0, 31399.529007064455, 31399.843000785764, 31463.37073258476, 32085.518717219726, 35557.46663799993, 35747.0, 35941.0, 36788.816055919546, 36871.44692829556, 29487.410251794416, 29989.400211996075, 30022.099337019925, 30271.545926810675, 30307.545386819656, 24841.50316993614, 24918.252452426455, 24980.625290621017, 25003.624945625466, 25350.239492815246], "value": 18678.296296739718, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [471.66983111821736, 471.87731189890616, 476.4806361066437, 489.0683248411777, 490.92390679444685, 19520.41438756836, 19637.607247855034, 21376.144954201853, 21471.892640536815, 21489.24787632433, 20732.89633551834, 21354.679679804776, 22920.197793077245, 23063.0, 23127.884360578217, 6775.627340496283, 6881.346272104167, 6898.793036208922, 6957.7216911323485, 6964.199117101548, 6621.6689165541775, 6838.692258848364, 6844.452443804508, 6851.383375496204, 6855.622940738257, 6572.901406478906, 6597.340265973412, 6609.570377925444, 6651.301613330603, 6652.634105124216, 6648.567843090232, 6789.456843452512, 6863.7597684081065, 6873.037774711544, 6881.724731010753, 6666.466682665375, 6673.0991316172185, 6678.497338098938, 6684.364985326386, 6698.397144256992, 23051.76948230513, 24794.132205372905, 24801.87599061993, 24963.375915602075, 25050.749492505023, 2985.970140298591, 3046.558249053897, 3048.588440560518, 3048.6798886116862, 3165.414398336315, 15686.0, 16376.508704738757, 16784.66430671392, 16965.491035268962, 17123.400680976232, 2044.3253726270295, 2089.579086221369, 2128.3717955763855, 2136.113512892148, 2137.5724855029057, 97632.0, 106053.46973265085, 107148.0, 116389.4180529092, 117332.0, 18257.63484730298, 18307.450776476726, 18969.0, 19049.428517144508, 19049.61900761977, 32527.837360813046, 32547.674523254937, 32708.0, 32724.509132363033, 33054.66945330564, 10065.899341006496, 10104.595816167419, 10149.746256343651, 10229.28395012342, 10378.0, 8431.28334091609, 8472.44929079608, 8563.987462946203, 8700.260477859327, 8764.737057888273, 9234.584443700049, 9304.0, 9443.527823608792, 9475.241980641533, 9635.373700709431, 3834.578196398394, 3868.497095377639, 3953.9802300988886, 3972.56301806801, 4009.7745751108414, 953.3898305084751, 969.5976169889558, 971.8882328532309, 986.2208855004609, 993.1359717046216, 21688.91555422254, 21907.452313692283, 21921.890390547946, 21922.013509392116, 21958.560828783335, 988.4678747940663, 994.1053052252886, 999.3054826895383, 1009.6769033909079, 1021.6832781837654, 11677.591284305008, 11805.173637845268, 11976.461059252355, 12090.939545302217, 12114.575989840314, 617617.0, 630481.0, 634638.0, 646383.0, 651776.0, 104913.47543262235, 110900.4454977736, 112999.0, 115798.0, 117003.0, 1318.2222488731502, 1323.4375390459015, 1327.6282640860381, 1328.2372664857073, 1347.5014244729316, 18613.906930465262, 18775.812241877953, 18799.71800423022, 18821.435356939313, 19148.23407063702, 39264.03679815941, 45324.546754532035, 47613.28580071371, 52538.474615253355, 54136.187957181464, 66993.3300666987, 66995.3300466989, 67638.66180669262, 68182.65908670425, 68920.0, 7999.240072193133, 11300.434978251218, 12394.566190183301, 12581.811272830731, 12909.54816581415, 13296.202227866359, 14141.787873182117, 14378.784318235445, 14391.0, 14634.195119268543, 12157.574484892986, 12268.509259629873, 12347.19743216688, 12393.380330983235, 12476.937615311865, 10873.347599144077, 11512.769744605228, 11854.466549005143, 12035.578754743541, 12051.457684404399, 12541.811872822098, 12671.113022088366, 13077.215367078006, 13126.540571079966, 13681.179129252278, 12398.62804115878, 12693.555725549562, 12701.618951431472, 12805.679858003252, 12829.486820527074, 12436.378181090728, 12486.438110284877, 12528.498860045496, 12605.243685378906, 12624.0], "value": 11439.241626740386, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1525.5042111313826, 1554.7279226135424, 1559.4931647214655, 1560.2666746629081, 1566.764985252212, 9945.353552019133, 10214.336068155564, 11526.0779137669, 11948.64154075378, 11977.64067077988, 11133.165012624046, 11408.429578521062, 11478.0, 11492.367919764409, 11820.7635847283, 2398.292503711405, 2412.131632612267, 2420.721617014048, 2422.3338581890034, 2424.0425032112307, 2327.2669109230537, 2380.9047638094457, 2391.485830546432, 2391.8086553075714, 2395.568797616428, 2292.885355732215, 2317.8261630377706, 2322.907083716649, 2338.497223097034, 2339.508703172336, 2207.39296693409, 2232.620454522735, 2360.126753101355, 2367.171489978511, 2393.401649587603, 2207.249535158054, 2212.7455342635644, 2216.9778302216932, 2221.489057516764, 2226.565819665166, 11813.586524471688, 11959.461824217931, 11984.340861252627, 12016.038716902627, 12021.579244726392, 5658.151277308396, 5744.798932037401, 5807.912881306784, 5825.0679891217205, 5827.329857066449, 3252.6259480159847, 3315.469524876032, 3454.222799870034, 3470.2712430389647, 3504.8083651558336, 1227.4783217132683, 1289.2522337044493, 1302.4204229118047, 1306.333769777411, 1378.0, 18331.725024124647, 18433.446996590123, 18467.076646167774, 18482.353117640818, 18508.90745546277, 4417.668674849399, 4599.517050709695, 4615.653825963066, 4639.118567472169, 4758.191107511731, 14471.565853024425, 14498.782518262024, 14509.637259068397, 14517.927410362881, 14523.273836308143, 5718.027935251017, 5765.769369225268, 5812.651240925558, 5833.066709326487, 5835.562332825055, 4384.210842048462, 5013.197888337849, 5316.9202461963105, 5331.546818520469, 5405.729713514387, 4238.427812245307, 4270.978645106817, 4362.498312694017, 4399.296112621965, 4405.361222622766, 1123.640435060789, 1128.8476055732372, 1153.1236260442124, 1154.0825044089968, 1156.0751398880861, 1014.9746256343503, 1023.1967905194535, 1042.74452759073, 1055.7677310991724, 1059.819830628795, 6836.829079272959, 7051.189113252041, 7127.857442851114, 7133.429325653935, 7287.161976372785, 1036.7045392063226, 1056.8626078609732, 1070.9892901071046, 1077.2997551591527, 1086.8315411111291, 4464.241079016575, 4506.278995360726, 4538.636909047268, 4554.111948170075, 4562.840300589463, 14989.250537473083, 15032.248387580577, 15449.922750386177, 15538.922305388627, 15546.378144874305, 15417.537473875802, 15440.613984650248, 15445.0, 15490.302936367665, 15527.146006969499, 10988.175886808362, 11112.0, 11256.943715281372, 11279.379634120201, 11282.717932051764, 6776.220734615582, 6951.200611929693, 7004.684789184601, 7051.153861536648, 7070.540414873017, 13376.933115334361, 13396.26320552379, 13730.51943181984, 13737.0, 13750.312484375941, 13808.447662093404, 13851.0, 13877.722445550831, 13911.373988170759, 13915.930420347833, 8125.0, 8368.874466883124, 9553.856692149484, 10111.494425278559, 10323.793524129625, 10997.230193886351, 11025.0, 11127.221094523306, 11137.443127843737, 11280.943595281971, 9338.859917101114, 9429.669961551313, 9499.097585729345, 9634.9036509634, 9665.178459830993, 8839.337049721426, 8879.733607991771, 8904.287656987295, 8978.461292322481, 9104.499252541174, 8373.790655233668, 8436.409451338348, 8505.87241191395, 8514.574271286287, 8542.615582298688, 6555.737770489127, 6602.570832895846, 6640.169978752656, 6642.4686025118845, 6643.468522518284, 6316.273628532777, 6377.553571249968, 6409.839754006187, 6487.772927947688, 6543.70553325092], "value": 5434.678966257711, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [397.62821761652873, 432.6863024307378, 435.82566973210714, 437.19556016928857, 437.75704484011374, 5339.546138578221, 5395.244665746799, 5407.810726624564, 5421.048422567872, 5443.401225865156, 5100.923486147711, 5398.64908780929, 5406.702631355274, 5418.485243901833, 5426.945730542693, 4445.422095127629, 4453.688241823073, 4455.8217671293105, 4455.836356187111, 4479.0, 4377.737335759849, 4472.741265660837, 4477.820887164509, 4481.417415735949, 4483.887902802423, 4423.3807266982485, 4490.326451032339, 4497.955020449786, 4545.909081818361, 4550.135474259897, 4448.799804008811, 4456.309272062836, 4475.485319188302, 4476.574725401082, 4494.1461122386645, 4212.326027835532, 4214.726042807208, 4222.831086756526, 4227.450431443893, 4229.97885010576, 5248.580113590903, 5249.448807875195, 5252.868678283074, 5256.8685782855355, 5261.605379596507, 4977.527134922177, 5232.215167724834, 5286.947130528684, 5291.756437237246, 5300.681959082467, 5642.4357564243655, 5674.120511320711, 5694.487496125327, 5719.513841323493, 5730.312362516483, 4484.730916145042, 4663.44038715353, 4736.242201247784, 4748.335233067373, 4748.430188377417, 5641.633293835887, 5742.598018138732, 5749.390170752196, 5789.8552536186935, 5812.041013232812, 4759.143354196209, 4794.0, 4807.423109226916, 4839.41926968766, 4870.09903167915, 4948.233023881304, 4956.851294461172, 4966.478519755446, 4968.30443737877, 4969.776360063805, 5037.4458809530925, 5204.895902082013, 5222.764975576109, 5239.554637855748, 5282.445343238982, 5632.211490391349, 5655.575831812631, 5659.773609055674, 5663.7451314690115, 5695.063678349298, 1687.9746803797952, 1696.50801267631, 1699.3287651377636, 1702.3105642214923, 1707.7011522983428, 1227.3311045480234, 1302.1731200687443, 1335.105479328852, 1338.4713038349992, 1342.7381660576093, 5334.839954801362, 5504.935649131576, 5589.9379117967455, 5607.467290607386, 5610.663360198319, 5821.79623713168, 5845.561582881301, 5865.530757539386, 5877.970610146922, 5923.2752933651, 5391.4608539145775, 5617.578681598815, 5638.971805140948, 5655.491005809415, 5694.174344719992, 3053.5267033609825, 3069.5088785794164, 3075.1697041799034, 3093.907182784475, 3106.673799251091, 6002.939970600238, 6097.542684298695, 6106.328303886569, 6110.572259941761, 6111.113888486145, 5634.154876768517, 5815.912761308584, 5826.446487583673, 5828.271466066742, 5866.354700982888, 5812.244408226903, 5942.405759424023, 6009.969950150221, 6040.335563088057, 6047.667378294236, 5458.181272809111, 5702.600817942704, 5720.199172115824, 5796.507296879812, 5802.970985145047, 5615.326160860723, 5615.522680572197, 5663.150527420919, 5716.371199168171, 5721.799737009184, 5871.442212989759, 5927.673977931255, 5945.197398351167, 5947.910781338197, 5948.345681975065, 4767.189577771718, 4816.012717392996, 4848.515148485264, 4873.317735516959, 4908.558229759339, 5553.8333849984565, 5816.302043754607, 5836.416358364299, 5865.266841644794, 5897.498712609477, 5694.544436445157, 5707.1153971134545, 5713.514351280188, 5714.342850572071, 5726.942730572808, 5569.972150139223, 5674.4892959633835, 5674.659520428788, 5753.769849206153, 5782.2483077199695, 5609.74756135983, 5615.6630602164005, 5618.85952851182, 5635.492805647511, 5674.943250567607, 5709.857253568694, 5748.712564371848, 5755.395683453345, 5807.970960145172, 5822.0598597707885, 5409.702466364388, 5529.806456773994, 5554.555635549227, 5573.052581061148, 5634.0], "value": 4555.014743278456, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [758.6206896551721, 763.4083585221456, 913.0058579569753, 921.6497730862276, 934.9626014959402, 16271.267792949317, 16521.256543455558, 16571.254293556787, 16959.83040169598, 17466.0, 16883.24025418856, 17078.914605426988, 17242.13789310536, 17876.64246715065, 18871.24515019401, 864.511550973701, 868.6481974800216, 906.7189171356868, 908.5593487158723, 913.3834661603424, 869.6608322754131, 878.0692465986075, 880.1242763450376, 881.8897637795276, 888.1207604471591, 933.1974501928336, 933.6218831373304, 934.9626014959393, 935.6210734652477, 937.0208132501552, 923.875276837625, 925.0610630210342, 926.0276709455112, 926.8470702334107, 930.9991758859253, 672.143017652497, 675.3280485916545, 679.6533767778468, 680.3842522517081, 681.3356976947437, 17804.821951780446, 17991.73012404815, 18120.093995300183, 18341.26634934601, 18377.081145942648, 15835.0, 16012.679746405123, 16146.273417696231, 16227.91886040574, 16342.591435214095, 13056.34718264083, 13264.867351326557, 13395.263260520667, 13623.795643065361, 13625.318734063258, 3970.5830887756947, 4006.098627808749, 4015.759054456742, 4060.0255938574824, 4107.732997355162, 89287.0, 89607.55196224042, 90308.64537032016, 91645.0, 93274.5336273321, 11131.944340278247, 11140.0, 11184.552617895355, 11210.495527701272, 11280.605178818701, 23525.529489410117, 23727.40681482942, 23756.406089847893, 23775.405614859767, 24009.759902400754, 8705.303575714055, 8964.641414343354, 8990.100989900957, 9117.544122793966, 9156.45061296311, 4434.268345722984, 4509.7970591323465, 4576.702514336557, 4583.793729282191, 4617.676762626651, 3752.7373083883867, 3941.625545573166, 3968.8214030368704, 3975.602439756059, 4001.6998725095737, 635.3106879036205, 646.2245305633259, 653.0335104045944, 657.0571230284557, 658.706875440434, 832.0172182724999, 837.9832800492522, 848.728406909783, 859.1494420523636, 862.4092496639696, 11087.611933582448, 11225.214235003472, 11480.540778368771, 11716.062714982781, 11807.527698891949, 660.9504287178385, 662.7315937045504, 688.0882830249939, 707.8938159276047, 862.5256109139948, 5250.291210686585, 5356.598255130881, 5485.17722341644, 5487.259220005328, 5500.7524661390335, 69746.302536975, 78875.60562197267, 79199.60400197962, 79591.0, 81424.0, 67216.32783672199, 67320.32679673239, 67440.0, 68110.31889681138, 68189.3181068193, 61837.38162618406, 62592.0, 63809.36190638034, 65683.34316656868, 65908.01137982935, 9886.159676427296, 10051.145652619609, 10091.848622270525, 10119.59521619127, 10220.4378759166, 42068.78965605152, 42249.78875105605, 43137.78431107824, 43289.0, 43395.783021084695, 41933.58066419419, 43463.13073738444, 47406.52593474021, 47454.52545474501, 47675.52324476711, 10850.565977360817, 10995.945020274847, 10998.395088270221, 11017.724556886142, 11050.557977681125, 13640.863591364356, 13810.37853296584, 13822.792658109935, 13877.861221387657, 13959.511417100353, 13308.86691133115, 13358.131721438076, 13463.77035380387, 13538.12002219892, 13667.521636742666, 12176.147669663038, 12374.0, 12535.24788512692, 12633.0, 12637.431315590637, 13073.803892941803, 13217.662637073345, 13378.531751388655, 13441.731165376834, 13498.59504214875, 10157.54291056919, 10496.79006419852, 10521.316114452537, 10604.098651614699, 10831.2959657622, 11574.71063223426, 11622.593209237637, 11712.472938717949, 11783.175177737476, 11862.169648124549], "value": 7589.948367523492, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1481.8000000000002, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [103.0, 112.0, 114.0, 112.0, 112.0, 114.0, 114.0, 113.0, 111.0, 113.0], "value": 111.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 117.0, 122.0, 153.0, 118.0, 120.0, 119.0, 120.0, 137.0, 119.0], "value": 127.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 163.0, 165.0, 164.0, 163.0, 163.0, 161.0, 167.0, 163.0, 163.0], "value": 163.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 77.0, 76.0, 112.0, 87.0, 76.0, 77.0, 76.0, 107.0, 78.0], "value": 84.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 83.0, 109.0, 84.0, 83.0, 83.0, 94.0, 83.0, 83.0, 109.0], "value": 89.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 115.0, 113.0, 114.0, 114.0, 114.0, 113.0, 114.0, 114.0, 114.0], "value": 113.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 147.0, 148.0, 148.0, 148.0, 148.0, 147.0, 148.0, 148.0, 148.0], "value": 148.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [100.0, 95.0, 95.0, 95.0, 95.0, 94.0, 95.0, 95.0, 95.0, 94.0], "value": 95.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 60.0, 59.0, 61.0, 59.0, 60.0, 60.0, 60.0, 61.0, 60.0], "value": 60.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 53.0, 53.0, 53.0, 53.0, 54.0, 53.0, 54.0, 54.0, 54.0], "value": 53.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 81.0, 80.0, 78.0, 79.0, 80.0, 82.0, 80.0, 77.0, 81.0], "value": 79.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [123.0, 124.0, 143.0, 123.0, 135.0, 131.0, 120.0, 124.0, 167.0, 129.0], "value": 131.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 166.0, 163.0, 162.0, 160.0, 157.0, 161.0, 161.0, 162.0, 158.0], "value": 161.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 61.0, 62.0, 60.0, 66.0, 65.0, 60.0, 60.0, 59.0, 60.0], "value": 61.4, "unit": "score"}]}]} 15:32:55 INFO - Return code: 0 15:32:55 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 15:32:55 ERROR - # TBPL SUCCESS # 15:32:55 INFO - Running post-action listener: _resource_record_post_action 15:32:55 INFO - [mozharness: 2017-04-05 22:32:55.506186Z] Finished run-tests step (success) 15:32:55 INFO - Running post-run listener: _resource_record_post_run 15:32:55 INFO - Total resource usage - Wall time: 1192s; CPU: 13.0%; Read bytes: 266240; Write bytes: 364732416; Read time: 28; Write time: 192696 15:32:55 INFO - TinderboxPrint: CPU usage
13.4% 15:32:55 INFO - TinderboxPrint: I/O read bytes / time
266,240 / 28 15:32:55 INFO - TinderboxPrint: I/O write bytes / time
364,732,416 / 192,696 15:32:55 INFO - TinderboxPrint: CPU idle
8,232.7 (86.6%) 15:32:55 INFO - TinderboxPrint: CPU user
1,219.1 (12.8%) 15:32:55 INFO - TinderboxPrint: Swap in / out
0 / 0 15:32:55 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 110727168; Read time: 0; Write time: 80080 15:32:55 INFO - run-tests - Wall time: 1176s; CPU: 13.0%; Read bytes: 266240; Write bytes: 254005248; Read time: 28; Write time: 112616 15:32:56 INFO - Running post-run listener: _upload_blobber_files 15:32:56 INFO - Blob upload gear active. 15:32:56 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 15:32:56 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 15:32:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 15:32:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 15:32:56 INFO - (blobuploader) - INFO - Open directory for files ... 15:32:56 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 15:32:56 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:32:56 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:32:59 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 15:32:59 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:32:59 INFO - (blobuploader) - INFO - Done attempting. 15:32:59 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 15:32:59 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:32:59 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:33:00 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 15:33:00 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:33:00 INFO - (blobuploader) - INFO - Done attempting. 15:33:00 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 15:33:00 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:33:00 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:33:01 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 15:33:01 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:33:01 INFO - (blobuploader) - INFO - Done attempting. 15:33:01 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 15:33:01 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:33:01 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:33:02 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 15:33:02 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:33:02 INFO - (blobuploader) - INFO - Done attempting. 15:33:02 INFO - (blobuploader) - INFO - Iteration through files over. 15:33:02 INFO - Return code: 0 15:33:02 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 15:33:02 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 15:33:02 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/4abf668d618dbbc5e658dc18ea451190bcb5ba2cfaea95a943e691238a31234549672afc1fcd57a446e5daaecb39095185a1e05bfa9896b591105de190846536", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/8a904efdde63f8daac3e24922c70c8c344582b80db69111b139865a36f13ec40a265463c6701144b6a219f6dbb04c224e7cd3c5f5f48d47a8ae6303a2122b546", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/cb95f81799aae09189d0b067dd97f2c733fd06932dbf836dc6ee8793918edbde066704e43152c16fefbd8b0e1621da2aba766421b0fe27a8064dd0baf58d4f28", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/a6f05884621db42853be2bd681a9e86aaed65a967370bd468b8b6a2693085b16203e39678bc8db958bab8928c1dd52f00bfb7d59c0bf8a84915f2528fa758a82"} 15:33:02 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 15:33:02 INFO - Writing to file /builds/slave/test/properties/blobber_files 15:33:02 INFO - Contents: 15:33:02 INFO - blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/4abf668d618dbbc5e658dc18ea451190bcb5ba2cfaea95a943e691238a31234549672afc1fcd57a446e5daaecb39095185a1e05bfa9896b591105de190846536", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/8a904efdde63f8daac3e24922c70c8c344582b80db69111b139865a36f13ec40a265463c6701144b6a219f6dbb04c224e7cd3c5f5f48d47a8ae6303a2122b546", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/cb95f81799aae09189d0b067dd97f2c733fd06932dbf836dc6ee8793918edbde066704e43152c16fefbd8b0e1621da2aba766421b0fe27a8064dd0baf58d4f28", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/a6f05884621db42853be2bd681a9e86aaed65a967370bd468b8b6a2693085b16203e39678bc8db958bab8928c1dd52f00bfb7d59c0bf8a84915f2528fa758a82"} 15:33:02 INFO - Running post-run listener: copy_logs_to_upload_dir 15:33:02 INFO - Copying logs to upload dir... 15:33:02 INFO - mkdir: /builds/slave/test/build/upload/logs 15:33:02 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1250.178701 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 50 secs) (at 2017-04-05 15:33:02.104245) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-05 15:33:02.108127) ========= 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=8887e36bb8e381bfd44124ac000001a8-1491430329.274012-1664826046 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/4abf668d618dbbc5e658dc18ea451190bcb5ba2cfaea95a943e691238a31234549672afc1fcd57a446e5daaecb39095185a1e05bfa9896b591105de190846536", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/8a904efdde63f8daac3e24922c70c8c344582b80db69111b139865a36f13ec40a265463c6701144b6a219f6dbb04c224e7cd3c5f5f48d47a8ae6303a2122b546", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/cb95f81799aae09189d0b067dd97f2c733fd06932dbf836dc6ee8793918edbde066704e43152c16fefbd8b0e1621da2aba766421b0fe27a8064dd0baf58d4f28", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/a6f05884621db42853be2bd681a9e86aaed65a967370bd468b8b6a2693085b16203e39678bc8db958bab8928c1dd52f00bfb7d59c0bf8a84915f2528fa758a82"} build_url:https://queue.taskcluster.net/v1/task/CIF0aaZ8RuaVBlSbQLmGZw/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011304 build_url: 'https://queue.taskcluster.net/v1/task/CIF0aaZ8RuaVBlSbQLmGZw/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/4abf668d618dbbc5e658dc18ea451190bcb5ba2cfaea95a943e691238a31234549672afc1fcd57a446e5daaecb39095185a1e05bfa9896b591105de190846536", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/8a904efdde63f8daac3e24922c70c8c344582b80db69111b139865a36f13ec40a265463c6701144b6a219f6dbb04c224e7cd3c5f5f48d47a8ae6303a2122b546", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/cb95f81799aae09189d0b067dd97f2c733fd06932dbf836dc6ee8793918edbde066704e43152c16fefbd8b0e1621da2aba766421b0fe27a8064dd0baf58d4f28", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/a6f05884621db42853be2bd681a9e86aaed65a967370bd468b8b6a2693085b16203e39678bc8db958bab8928c1dd52f00bfb7d59c0bf8a84915f2528fa758a82"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-05 15:33:02.136875) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-05 15:33:02.137186) ========= 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=8887e36bb8e381bfd44124ac000001a8-1491430329.274012-1664826046 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 2017-04-05 15:33:02.220697) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-05 15:33:02.221079) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-05 15:33:02.221384) ========= ========= Total master_lag: 0.18 =========