builder: graphics_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-054 starttime: 1485062933.56 results: success (0) revision: d295888faea067587708534300861dcba5a38928 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-01-21 21:28:53.559486) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-01-21 21:28:53.559927) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-21 21:28:53.560203) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-21 21:28:53.625578) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-21 21:28:53.625842) ========= 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=cbe409c6de289db6ac707de3000001d4-1485046988.551146-486559624 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-01-21 21:28:53-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 50.4M=0s 2017-01-21 21:28:54 (50.4 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.133732 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-21 21:28:53.775590) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-21 21:28:53.775921) ========= 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=cbe409c6de289db6ac707de3000001d4-1485046988.551146-486559624 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.022034 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-21 21:28:53.825325) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-21 21:28:53.825645) ========= bash -c 'python archiver_client.py mozharness --repo projects/graphics --rev d295888faea067587708534300861dcba5a38928 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'python archiver_client.py mozharness --repo projects/graphics --rev d295888faea067587708534300861dcba5a38928 --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=cbe409c6de289db6ac707de3000001d4-1485046988.551146-486559624 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-01-21 21:28:54,141 truncating revision to first 12 chars 2017-01-21 21:28:54,141 Setting DEBUG logging. 2017-01-21 21:28:54,142 attempt 1/10 2017-01-21 21:28:54,142 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/projects/graphics/d295888faea0?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-01-21 21:28:54,574 unpacking tar archive at: graphics-d295888faea0/testing/mozharness/ program finished with exit code 0 elapsedTime=0.771008 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-21 21:28:54.609447) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-21 21:28:54.609779) ========= script_repo_revision: d295888faea067587708534300861dcba5a38928 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-21 21:28:54.610173) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-21 21:28:54.610450) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-21 21:28:54.634396) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 40 secs) (at 2017-01-21 21:28:54.634675) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Graphics --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Graphics 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', 'Graphics', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Graphics'] 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=cbe409c6de289db6ac707de3000001d4-1485046988.551146-486559624 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 21:28:55 INFO - MultiFileLogger online at 20170121 21:28:55 in /builds/slave/test 21:28:55 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Graphics --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Graphics 21:28:55 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 21:28:55 INFO - {'append_to_log': False, 21:28:55 INFO - 'base_work_dir': '/builds/slave/test', 21:28:55 INFO - 'blob_upload_branch': 'Graphics', 21:28:55 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 21:28:55 INFO - 'branch': 'Graphics', 21:28:55 INFO - 'buildbot_json_path': 'buildprops.json', 21:28:55 INFO - 'config_files': ('talos/linux_config.py',), 21:28:55 INFO - 'default_actions': ('clobber', 21:28:55 INFO - 'read-buildbot-config', 21:28:55 INFO - 'download-and-extract', 21:28:55 INFO - 'populate-webroot', 21:28:55 INFO - 'create-virtualenv', 21:28:55 INFO - 'install', 21:28:55 INFO - 'run-tests'), 21:28:55 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 21:28:55 INFO - 'download_minidump_stackwalk': True, 21:28:55 INFO - 'download_symbols': 'ondemand', 21:28:55 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 21:28:55 INFO - 'tooltool.py': '/tools/tooltool.py', 21:28:55 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 21:28:55 INFO - '/tools/misc-python/virtualenv.py')}, 21:28:55 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 21:28:55 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 21:28:55 INFO - 'installer_path': 'installer.exe', 21:28:55 INFO - 'log_level': 'info', 21:28:55 INFO - 'log_name': 'talos', 21:28:55 INFO - 'log_to_console': True, 21:28:55 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 21:28:55 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 21:28:55 INFO - 'opt_config_files': (), 21:28:55 INFO - 'pip_index': False, 21:28:55 INFO - 'sps_profile': False, 21:28:55 INFO - 'sps_profile_interval': 0, 21:28:55 INFO - 'suite': 'dromaeojs-e10s', 21:28:55 INFO - 'system_bits': '32', 21:28:55 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 21:28:55 INFO - 'title': 'talos-linux64-ix-054', 21:28:55 INFO - 'tooltool_cache': '/builds/tooltool_cache', 21:28:55 INFO - 'use_talos_json': True, 21:28:55 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 21:28:55 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 21:28:55 INFO - 'work_dir': 'build'} 21:28:55 INFO - [mozharness: 2017-01-22 05:28:55.057662Z] Running clobber step. 21:28:55 INFO - Running pre-action listener: _resource_record_pre_action 21:28:55 INFO - Running main action method: clobber 21:28:55 INFO - rmtree: /builds/slave/test/build 21:28:55 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 21:28:55 INFO - Running post-action listener: _resource_record_post_action 21:28:55 INFO - [mozharness: 2017-01-22 05:28:55.515811Z] Finished clobber step (success) 21:28:55 INFO - [mozharness: 2017-01-22 05:28:55.515912Z] Running read-buildbot-config step. 21:28:55 INFO - Running pre-action listener: _resource_record_pre_action 21:28:55 INFO - Running main action method: read_buildbot_config 21:28:55 INFO - Using buildbot properties: 21:28:55 INFO - { 21:28:55 INFO - "project": "", 21:28:55 INFO - "product": "firefox", 21:28:55 INFO - "who": "sikeda@mozilla.com", 21:28:55 INFO - "installer_path": "public/build/target.tar.bz2", 21:28:55 INFO - "builddir": "graphics_ubuntu64_hw_test-dromaeojs-e10s", 21:28:55 INFO - "repository": "https://hg.mozilla.org/projects/graphics/", 21:28:55 INFO - "buildername": "Ubuntu HW 12.04 x64 graphics talos dromaeojs-e10s", 21:28:55 INFO - "stage_platform": "linux64", 21:28:55 INFO - "basedir": "/builds/slave/test", 21:28:55 INFO - "buildnumber": 66, 21:28:55 INFO - "platform": "ubuntu64_hw", 21:28:55 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 21:28:55 INFO - "slavebuilddir": "test", 21:28:55 INFO - "taskId": "G9mmYXxyQu-Xf1NvUxUG3w", 21:28:55 INFO - "branch": "graphics", 21:28:55 INFO - "script_repo_revision": "default", 21:28:55 INFO - "revision": "d295888faea067587708534300861dcba5a38928", 21:28:55 INFO - "slavename": "talos-linux64-ix-054", 21:28:55 INFO - "repo_path": "projects/graphics" 21:28:55 INFO - } 21:28:55 INFO - Finding installer, test and symbols from parent task. 21:28:55 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/G9mmYXxyQu-Xf1NvUxUG3w'}, attempt #1 21:28:55 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/G9mmYXxyQu-Xf1NvUxUG3w'}, attempt #1 21:28:56 INFO - Task dependencies: RintsF4ISi2O_RCPw0ndYQ 21:28:56 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/RintsF4ISi2O_RCPw0ndYQ'}, attempt #1 21:28:56 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/RintsF4ISi2O_RCPw0ndYQ/artifacts/public/build/target.tar.bz2 21:28:56 INFO - Set test_url: https://queue.taskcluster.net/v1/task/RintsF4ISi2O_RCPw0ndYQ/artifacts/public/build/test_packages.json 21:28:56 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/RintsF4ISi2O_RCPw0ndYQ/artifacts/public/build/target.crashreporter-symbols.zip 21:28:56 INFO - Running post-action listener: _resource_record_post_action 21:28:56 INFO - [mozharness: 2017-01-22 05:28:56.891801Z] Finished read-buildbot-config step (success) 21:28:56 INFO - [mozharness: 2017-01-22 05:28:56.892018Z] Running download-and-extract step. 21:28:56 INFO - Running pre-action listener: _resource_record_pre_action 21:28:56 INFO - Running main action method: download_and_extract 21:28:56 INFO - mkdir: /builds/slave/test/build/tests 21:28:56 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')]} 21:28:56 INFO - trying https://queue.taskcluster.net/v1/task/RintsF4ISi2O_RCPw0ndYQ/artifacts/public/build/target.test_packages.json 21:28:56 INFO - Downloading https://queue.taskcluster.net/v1/task/RintsF4ISi2O_RCPw0ndYQ/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 21:28:56 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/RintsF4ISi2O_RCPw0ndYQ/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 21:28:57 INFO - Downloaded 896 bytes. 21:28:57 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 21:28:57 INFO - Using the following test package requirements: 21:28:57 INFO - {u'common': [u'target.common.tests.zip'], 21:28:57 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 21:28:57 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 21:28:57 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 21:28:57 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 21:28:57 INFO - u'mozbase': [u'target.common.tests.zip'], 21:28:57 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 21:28:57 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 21:28:57 INFO - u'web-platform': [u'target.common.tests.zip', 21:28:57 INFO - u'target.web-platform.tests.zip'], 21:28:57 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 21:28:57 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 21:28:57 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/RintsF4ISi2O_RCPw0ndYQ/artifacts/public/build/target.common.tests.zip 21:28:57 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/RintsF4ISi2O_RCPw0ndYQ/artifacts/public/build/target.common.tests.zip'}, attempt #1 21:28:57 INFO - Fetch https://queue.taskcluster.net/v1/task/RintsF4ISi2O_RCPw0ndYQ/artifacts/public/build/target.common.tests.zip into memory 21:28:58 INFO - Expected file size: 21877316 21:28:58 INFO - Obtained file size: 21877316 21:29:02 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 21:29:02 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/RintsF4ISi2O_RCPw0ndYQ/artifacts/public/build/target.common.tests.zip 21:29:02 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/RintsF4ISi2O_RCPw0ndYQ/artifacts/public/build/target.common.tests.zip'}, attempt #1 21:29:02 INFO - Fetch https://queue.taskcluster.net/v1/task/RintsF4ISi2O_RCPw0ndYQ/artifacts/public/build/target.common.tests.zip into memory 21:29:03 INFO - Expected file size: 21877316 21:29:03 INFO - Obtained file size: 21877316 21:29:07 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/RintsF4ISi2O_RCPw0ndYQ/artifacts/public/build/target.talos.tests.zip 21:29:07 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/RintsF4ISi2O_RCPw0ndYQ/artifacts/public/build/target.talos.tests.zip'}, attempt #1 21:29:07 INFO - Fetch https://queue.taskcluster.net/v1/task/RintsF4ISi2O_RCPw0ndYQ/artifacts/public/build/target.talos.tests.zip into memory 21:29:08 INFO - Expected file size: 14403476 21:29:08 INFO - Obtained file size: 14403476 21:29:08 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')]} 21:29:08 INFO - trying https://queue.taskcluster.net/v1/task/RintsF4ISi2O_RCPw0ndYQ/artifacts/public/build/target.tar.bz2 21:29:08 INFO - Downloading https://queue.taskcluster.net/v1/task/RintsF4ISi2O_RCPw0ndYQ/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 21:29:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/RintsF4ISi2O_RCPw0ndYQ/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 21:29:10 INFO - Downloaded 61575291 bytes. 21:29:10 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/RintsF4ISi2O_RCPw0ndYQ/artifacts/public/build/target.tar.bz2 21:29:10 INFO - mkdir: /builds/slave/test/properties 21:29:10 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 21:29:10 INFO - Writing to file /builds/slave/test/properties/build_url 21:29:10 INFO - Contents: 21:29:10 INFO - build_url:https://queue.taskcluster.net/v1/task/RintsF4ISi2O_RCPw0ndYQ/artifacts/public/build/target.tar.bz2 21:29:10 INFO - Running post-action listener: _resource_record_post_action 21:29:10 INFO - Running post-action listener: set_extra_try_arguments 21:29:10 INFO - [mozharness: 2017-01-22 05:29:10.244176Z] Finished download-and-extract step (success) 21:29:10 INFO - [mozharness: 2017-01-22 05:29:10.244295Z] Running populate-webroot step. 21:29:10 INFO - Running pre-action listener: _resource_record_pre_action 21:29:10 INFO - Running main action method: populate_webroot 21:29:10 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 21:29:10 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 21:29:10 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 21:29:10 INFO - '--tppagecycles', 21:29:10 INFO - '7'], 21:29:10 INFO - 'tests': ['tsvgm']}}, 21:29:10 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 21:29:10 INFO - 'tests': ['tresize', 'tcanvasmark']}, 21:29:10 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 21:29:10 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 21:29:10 INFO - 'tests': ['dromaeo_css', 'kraken']}, 21:29:10 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 21:29:10 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 21:29:10 INFO - 'talos_options': ['--disable-e10s'], 21:29:10 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 21:29:10 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 21:29:10 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 21:29:10 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 21:29:10 INFO - 'talos_options': ['--disable-e10s'], 21:29:10 INFO - 'tests': ['damp', 'tps']}, 21:29:10 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 21:29:10 INFO - 'tests': ['damp', 'tps']}, 21:29:10 INFO - 'g3': {'talos_options': ['--disable-e10s'], 21:29:10 INFO - 'tests': ['dromaeo_dom']}, 21:29:10 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 21:29:10 INFO - 'g4': {'talos_options': ['--disable-e10s'], 21:29:10 INFO - 'tests': ['basic_compositor_video']}, 21:29:10 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 21:29:10 INFO - 'other': {'talos_options': ['--disable-e10s'], 21:29:10 INFO - 'tests': ['a11yr', 21:29:10 INFO - 'ts_paint', 21:29:10 INFO - 'tpaint', 21:29:10 INFO - 'sessionrestore', 21:29:10 INFO - 'sessionrestore_no_auto_restore', 21:29:10 INFO - 'tabpaint']}, 21:29:10 INFO - 'other-e10s': {'tests': ['a11yr', 21:29:10 INFO - 'ts_paint', 21:29:10 INFO - 'tpaint', 21:29:10 INFO - 'sessionrestore', 21:29:10 INFO - 'sessionrestore_no_auto_restore', 21:29:10 INFO - 'tabpaint']}, 21:29:10 INFO - 'other-e10s_l64': {'tests': ['a11yr', 21:29:10 INFO - 'ts_paint', 21:29:10 INFO - 'tpaint', 21:29:10 INFO - 'sessionrestore', 21:29:10 INFO - 'sessionrestore_no_auto_restore', 21:29:10 INFO - 'tabpaint']}, 21:29:10 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 21:29:10 INFO - 'ts_paint', 21:29:10 INFO - 'tpaint', 21:29:10 INFO - 'sessionrestore', 21:29:10 INFO - 'sessionrestore_no_auto_restore', 21:29:10 INFO - 'tabpaint']}, 21:29:10 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 21:29:10 INFO - 'tests': ['a11yr', 21:29:10 INFO - 'ts_paint', 21:29:10 INFO - 'tpaint', 21:29:10 INFO - 'sessionrestore', 21:29:10 INFO - 'sessionrestore_no_auto_restore', 21:29:10 INFO - 'tabpaint']}, 21:29:10 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 21:29:10 INFO - 'tests': ['a11yr', 21:29:10 INFO - 'ts_paint', 21:29:10 INFO - 'tpaint', 21:29:10 INFO - 'sessionrestore', 21:29:10 INFO - 'sessionrestore_no_auto_restore', 21:29:10 INFO - 'tabpaint']}, 21:29:10 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 21:29:10 INFO - 'tests': ['tsvgx', 21:29:10 INFO - 'tsvgr_opacity', 21:29:10 INFO - 'tart', 21:29:10 INFO - 'tscrollx', 21:29:10 INFO - 'cart', 21:29:10 INFO - 'tsvg_static']}, 21:29:10 INFO - 'svgr-e10s': {'tests': ['tsvgx', 21:29:10 INFO - 'tsvgr_opacity', 21:29:10 INFO - 'tart', 21:29:10 INFO - 'tscrollx', 21:29:10 INFO - 'cart', 21:29:10 INFO - 'tsvg_static']}, 21:29:10 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 21:29:10 INFO - 'talos_options': ['--disable-e10s'], 21:29:10 INFO - 'tests': ['tp5o']}, 21:29:10 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 21:29:10 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 21:29:10 INFO - 'talos_options': ['--disable-e10s', 21:29:10 INFO - '--xperf_path', 21:29:10 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 21:29:10 INFO - 'tests': ['tp5n']}, 21:29:10 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 21:29:10 INFO - 'talos_options': ['--xperf_path', 21:29:10 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 21:29:10 INFO - 'tests': ['tp5n']}}, 21:29:10 INFO - 'talos.zip': {'path': '', 21:29:10 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 21:29:10 INFO - Running post-action listener: _resource_record_post_action 21:29:10 INFO - [mozharness: 2017-01-22 05:29:10.257492Z] Finished populate-webroot step (success) 21:29:10 INFO - [mozharness: 2017-01-22 05:29:10.257586Z] Running create-virtualenv step. 21:29:10 INFO - Running pre-action listener: _resource_record_pre_action 21:29:10 INFO - Running main action method: create_virtualenv 21:29:10 INFO - Creating virtualenv /builds/slave/test/build/venv 21:29:10 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 21:29:10 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 21:29:10 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 21:29:10 INFO - Using real prefix '/usr' 21:29:10 INFO - New python executable in /builds/slave/test/build/venv/bin/python 21:29:10 INFO - Installing distribute.............................................................................................................................................................................................done. 21:29:12 INFO - Installing pip.................done. 21:29:12 INFO - Return code: 0 21:29:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 21:29:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 21:29:13 INFO - Reading from file tmpfile_stdout 21:29:13 INFO - Output received: 21:29:13 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) 21:29:13 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 21:29:13 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')]} 21:29:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:29:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:29:13 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')]} 21:29:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:29:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:29:13 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 0x22831f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x244fa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25f4c70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25f23f0>, '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 0x25f2cf0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25f31a0>, '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': 'cbe409c6de289db6ac707de3000001d4-1485046988.551146-486559624', '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 21:29:13 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 21:29:13 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 21:29:13 INFO - Using env: {'DISPLAY': ':0', 21:29:13 INFO - 'HOME': '/home/cltbld', 21:29:13 INFO - 'LANG': 'en_US.UTF-8', 21:29:13 INFO - 'LANGUAGE': 'en_US:en', 21:29:13 INFO - 'LOGNAME': 'cltbld', 21:29:13 INFO - 'MAIL': '/var/mail/cltbld', 21:29:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:29:13 INFO - 'MOZ_NO_REMOTE': '1', 21:29:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:29:13 INFO - 'NO_EM_RESTART': '1', 21:29:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:29:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:29:13 INFO - 'PWD': '/builds/slave/test', 21:29:13 INFO - 'SHELL': '/bin/bash', 21:29:13 INFO - 'SHLVL': '1', 21:29:13 INFO - 'TERM': 'linux', 21:29:13 INFO - 'TMOUT': '86400', 21:29:13 INFO - 'USER': 'cltbld', 21:29:13 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1485046988.551146-486559624', 21:29:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:29:13 INFO - '_': '/tools/buildbot/bin/python'} 21:29:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:29:13 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 21:29:13 INFO - Cleaning up... 21:29:13 INFO - Return code: 0 21:29:13 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 21:29:13 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')]} 21:29:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:29:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:29:13 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')]} 21:29:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:29:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:29:13 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 0x22831f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x244fa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25f4c70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25f23f0>, '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 0x25f2cf0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25f31a0>, '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': 'cbe409c6de289db6ac707de3000001d4-1485046988.551146-486559624', '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 21:29:13 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 21:29:13 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 21:29:13 INFO - Using env: {'DISPLAY': ':0', 21:29:13 INFO - 'HOME': '/home/cltbld', 21:29:13 INFO - 'LANG': 'en_US.UTF-8', 21:29:13 INFO - 'LANGUAGE': 'en_US:en', 21:29:13 INFO - 'LOGNAME': 'cltbld', 21:29:13 INFO - 'MAIL': '/var/mail/cltbld', 21:29:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:29:13 INFO - 'MOZ_NO_REMOTE': '1', 21:29:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:29:13 INFO - 'NO_EM_RESTART': '1', 21:29:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:29:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:29:13 INFO - 'PWD': '/builds/slave/test', 21:29:13 INFO - 'SHELL': '/bin/bash', 21:29:13 INFO - 'SHLVL': '1', 21:29:13 INFO - 'TERM': 'linux', 21:29:13 INFO - 'TMOUT': '86400', 21:29:13 INFO - 'USER': 'cltbld', 21:29:13 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1485046988.551146-486559624', 21:29:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:29:13 INFO - '_': '/tools/buildbot/bin/python'} 21:29:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:29:13 INFO - Downloading/unpacking psutil>=3.1.1 21:29:13 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 21:29:13 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 21:29:13 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 21:29:13 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 21:29:13 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 21:29:13 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 21:29:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 21:29:15 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 21:29:15 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 21:29:15 INFO - Installing collected packages: psutil 21:29:15 INFO - Running setup.py install for psutil 21:29:15 INFO - building 'psutil._psutil_linux' extension 21:29:15 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 21:29:15 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 21:29:15 INFO - building 'psutil._psutil_posix' extension 21:29:15 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 21:29:15 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 21:29:16 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 21:29:16 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 21:29:16 INFO - Successfully installed psutil 21:29:16 INFO - Cleaning up... 21:29:16 INFO - Return code: 0 21:29:16 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 21:29:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:29:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:29:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:29:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:29:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:29:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:29:16 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 0x22831f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x244fa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25f4c70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25f23f0>, '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 0x25f2cf0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25f31a0>, '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': 'cbe409c6de289db6ac707de3000001d4-1485046988.551146-486559624', '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 21:29:16 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 21:29:16 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 21:29:16 INFO - Using env: {'DISPLAY': ':0', 21:29:16 INFO - 'HOME': '/home/cltbld', 21:29:16 INFO - 'LANG': 'en_US.UTF-8', 21:29:16 INFO - 'LANGUAGE': 'en_US:en', 21:29:16 INFO - 'LOGNAME': 'cltbld', 21:29:16 INFO - 'MAIL': '/var/mail/cltbld', 21:29:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:29:16 INFO - 'MOZ_NO_REMOTE': '1', 21:29:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:29:16 INFO - 'NO_EM_RESTART': '1', 21:29:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:29:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:29:16 INFO - 'PWD': '/builds/slave/test', 21:29:16 INFO - 'SHELL': '/bin/bash', 21:29:16 INFO - 'SHLVL': '1', 21:29:16 INFO - 'TERM': 'linux', 21:29:16 INFO - 'TMOUT': '86400', 21:29:16 INFO - 'USER': 'cltbld', 21:29:16 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1485046988.551146-486559624', 21:29:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:29:16 INFO - '_': '/tools/buildbot/bin/python'} 21:29:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:29:16 INFO - Downloading/unpacking mozsystemmonitor==0.3 21:29:16 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 21:29:16 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 21:29:16 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 21:29:16 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 21:29:16 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 21:29:16 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 21:29:18 INFO - Downloading mozsystemmonitor-0.3.tar.gz 21:29:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 21:29:18 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 21:29:18 INFO - Installing collected packages: mozsystemmonitor 21:29:18 INFO - Running setup.py install for mozsystemmonitor 21:29:18 INFO - Successfully installed mozsystemmonitor 21:29:18 INFO - Cleaning up... 21:29:18 INFO - Return code: 0 21:29:18 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 21:29:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:29:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:29:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:29:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:29:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:29:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:29:18 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 0x22831f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x244fa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25f4c70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25f23f0>, '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 0x25f2cf0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25f31a0>, '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': 'cbe409c6de289db6ac707de3000001d4-1485046988.551146-486559624', '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 21:29:18 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 21:29:18 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 21:29:18 INFO - Using env: {'DISPLAY': ':0', 21:29:18 INFO - 'HOME': '/home/cltbld', 21:29:18 INFO - 'LANG': 'en_US.UTF-8', 21:29:18 INFO - 'LANGUAGE': 'en_US:en', 21:29:18 INFO - 'LOGNAME': 'cltbld', 21:29:18 INFO - 'MAIL': '/var/mail/cltbld', 21:29:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:29:18 INFO - 'MOZ_NO_REMOTE': '1', 21:29:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:29:18 INFO - 'NO_EM_RESTART': '1', 21:29:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:29:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:29:18 INFO - 'PWD': '/builds/slave/test', 21:29:18 INFO - 'SHELL': '/bin/bash', 21:29:18 INFO - 'SHLVL': '1', 21:29:18 INFO - 'TERM': 'linux', 21:29:18 INFO - 'TMOUT': '86400', 21:29:18 INFO - 'USER': 'cltbld', 21:29:18 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1485046988.551146-486559624', 21:29:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:29:18 INFO - '_': '/tools/buildbot/bin/python'} 21:29:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:29:18 INFO - Downloading/unpacking jsonschema==2.5.1 21:29:18 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 21:29:18 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 21:29:18 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 21:29:18 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 21:29:18 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 21:29:18 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 21:29:20 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 21:29:20 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 21:29:20 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 21:29:20 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 21:29:20 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 21:29:20 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 21:29:20 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 21:29:20 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 21:29:21 INFO - Downloading functools32-3.2.3-2.tar.gz 21:29:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 21:29:21 INFO - warning: no files found matching '*.txt' 21:29:21 INFO - no previously-included directories found matching 'build' 21:29:21 INFO - no previously-included directories found matching 'dist' 21:29:21 INFO - no previously-included directories found matching '.git*' 21:29:21 INFO - Installing collected packages: jsonschema, functools32 21:29:21 INFO - Running setup.py install for functools32 21:29:21 INFO - warning: no files found matching '*.txt' 21:29:21 INFO - no previously-included directories found matching 'build' 21:29:21 INFO - no previously-included directories found matching 'dist' 21:29:21 INFO - no previously-included directories found matching '.git*' 21:29:21 INFO - Successfully installed jsonschema functools32 21:29:21 INFO - Cleaning up... 21:29:21 INFO - Return code: 0 21:29:21 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 21:29:21 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')]} 21:29:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:29:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:29:21 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')]} 21:29:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:29:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:29:21 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 0x22831f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x244fa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25f4c70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25f23f0>, '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 0x25f2cf0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25f31a0>, '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': 'cbe409c6de289db6ac707de3000001d4-1485046988.551146-486559624', '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 21:29:21 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 21:29:21 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 21:29:21 INFO - Using env: {'DISPLAY': ':0', 21:29:21 INFO - 'HOME': '/home/cltbld', 21:29:21 INFO - 'LANG': 'en_US.UTF-8', 21:29:21 INFO - 'LANGUAGE': 'en_US:en', 21:29:21 INFO - 'LOGNAME': 'cltbld', 21:29:21 INFO - 'MAIL': '/var/mail/cltbld', 21:29:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:29:21 INFO - 'MOZ_NO_REMOTE': '1', 21:29:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:29:21 INFO - 'NO_EM_RESTART': '1', 21:29:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:29:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:29:21 INFO - 'PWD': '/builds/slave/test', 21:29:21 INFO - 'SHELL': '/bin/bash', 21:29:21 INFO - 'SHLVL': '1', 21:29:21 INFO - 'TERM': 'linux', 21:29:21 INFO - 'TMOUT': '86400', 21:29:21 INFO - 'USER': 'cltbld', 21:29:21 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1485046988.551146-486559624', 21:29:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:29:21 INFO - '_': '/tools/buildbot/bin/python'} 21:29:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:29:21 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 21:29:21 INFO - Cleaning up... 21:29:21 INFO - Return code: 0 21:29:21 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 21:29:21 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')]} 21:29:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:29:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:29:21 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')]} 21:29:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:29:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:29:21 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 0x22831f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x244fa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25f4c70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25f23f0>, '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 0x25f2cf0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25f31a0>, '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': 'cbe409c6de289db6ac707de3000001d4-1485046988.551146-486559624', '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 21:29:21 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 21:29:21 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 21:29:21 INFO - Using env: {'DISPLAY': ':0', 21:29:21 INFO - 'HOME': '/home/cltbld', 21:29:21 INFO - 'LANG': 'en_US.UTF-8', 21:29:21 INFO - 'LANGUAGE': 'en_US:en', 21:29:21 INFO - 'LOGNAME': 'cltbld', 21:29:21 INFO - 'MAIL': '/var/mail/cltbld', 21:29:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:29:21 INFO - 'MOZ_NO_REMOTE': '1', 21:29:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:29:21 INFO - 'NO_EM_RESTART': '1', 21:29:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:29:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:29:21 INFO - 'PWD': '/builds/slave/test', 21:29:21 INFO - 'SHELL': '/bin/bash', 21:29:21 INFO - 'SHLVL': '1', 21:29:21 INFO - 'TERM': 'linux', 21:29:21 INFO - 'TMOUT': '86400', 21:29:21 INFO - 'USER': 'cltbld', 21:29:21 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1485046988.551146-486559624', 21:29:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:29:21 INFO - '_': '/tools/buildbot/bin/python'} 21:29:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:29:21 INFO - Downloading/unpacking blobuploader==1.2.4 21:29:21 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 21:29:21 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 21:29:21 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 21:29:21 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 21:29:21 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 21:29:21 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 21:29:23 INFO - Downloading blobuploader-1.2.4.tar.gz 21:29:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 21:29:23 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 21:29:23 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 21:29:23 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 21:29:23 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 21:29:23 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 21:29:23 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 21:29:23 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 21:29:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 21:29:24 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 21:29:24 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 21:29:24 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 21:29:24 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 21:29:24 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 21:29:24 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 21:29:24 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 21:29:24 INFO - Downloading docopt-0.6.1.tar.gz 21:29:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 21:29:24 INFO - Installing collected packages: blobuploader, requests, docopt 21:29:24 INFO - Running setup.py install for blobuploader 21:29:24 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 21:29:24 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 21:29:24 INFO - Running setup.py install for requests 21:29:25 INFO - Running setup.py install for docopt 21:29:25 INFO - Successfully installed blobuploader requests docopt 21:29:25 INFO - Cleaning up... 21:29:25 INFO - Return code: 0 21:29:25 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:29:25 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')]} 21:29:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:29:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:29:25 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')]} 21:29:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:29:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:29:25 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 0x22831f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x244fa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25f4c70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25f23f0>, '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 0x25f2cf0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25f31a0>, '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': 'cbe409c6de289db6ac707de3000001d4-1485046988.551146-486559624', '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 21:29:25 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 21:29:25 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 21:29:25 INFO - Using env: {'DISPLAY': ':0', 21:29:25 INFO - 'HOME': '/home/cltbld', 21:29:25 INFO - 'LANG': 'en_US.UTF-8', 21:29:25 INFO - 'LANGUAGE': 'en_US:en', 21:29:25 INFO - 'LOGNAME': 'cltbld', 21:29:25 INFO - 'MAIL': '/var/mail/cltbld', 21:29:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:29:25 INFO - 'MOZ_NO_REMOTE': '1', 21:29:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:29:25 INFO - 'NO_EM_RESTART': '1', 21:29:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:29:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:29:25 INFO - 'PWD': '/builds/slave/test', 21:29:25 INFO - 'SHELL': '/bin/bash', 21:29:25 INFO - 'SHLVL': '1', 21:29:25 INFO - 'TERM': 'linux', 21:29:25 INFO - 'TMOUT': '86400', 21:29:25 INFO - 'USER': 'cltbld', 21:29:25 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1485046988.551146-486559624', 21:29:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:29:25 INFO - '_': '/tools/buildbot/bin/python'} 21:29:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:29:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 21:29:25 INFO - Running setup.py (path:/tmp/pip-B4BoLX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 21:29:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 21:29:25 INFO - Running setup.py (path:/tmp/pip-pQmwUz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 21:29:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 21:29:25 INFO - Running setup.py (path:/tmp/pip-YcHl72-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 21:29:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 21:29:25 INFO - Running setup.py (path:/tmp/pip-bQtc4Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 21:29:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 21:29:25 INFO - Running setup.py (path:/tmp/pip-rqK5hM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 21:29:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 21:29:25 INFO - Running setup.py (path:/tmp/pip-AyyqXC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 21:29:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 21:29:25 INFO - Running setup.py (path:/tmp/pip-WuCfb4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 21:29:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 21:29:26 INFO - Running setup.py (path:/tmp/pip-kwwWR5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 21:29:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 21:29:26 INFO - Running setup.py (path:/tmp/pip-ROGu9B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 21:29:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 21:29:26 INFO - Running setup.py (path:/tmp/pip-UnUBLe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 21:29:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 21:29:26 INFO - Running setup.py (path:/tmp/pip-U_ZCAn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 21:29:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 21:29:26 INFO - Running setup.py (path:/tmp/pip-bDxTfG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 21:29:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 21:29:26 INFO - Running setup.py (path:/tmp/pip-CoCgvc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 21:29:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 21:29:26 INFO - Running setup.py (path:/tmp/pip-YElHik-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 21:29:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 21:29:26 INFO - Running setup.py (path:/tmp/pip-M9eQCe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 21:29:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 21:29:26 INFO - Running setup.py (path:/tmp/pip-q6f_nj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 21:29:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 21:29:26 INFO - Running setup.py (path:/tmp/pip-_Kthhu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 21:29:26 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 21:29:26 INFO - Running setup.py install for manifestparser 21:29:26 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 21:29:26 INFO - Running setup.py install for mozcrash 21:29:26 INFO - Running setup.py install for mozdebug 21:29:27 INFO - Running setup.py install for mozdevice 21:29:27 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 21:29:27 INFO - Installing dm script to /builds/slave/test/build/venv/bin 21:29:27 INFO - Running setup.py install for mozfile 21:29:27 INFO - Running setup.py install for mozhttpd 21:29:27 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 21:29:27 INFO - Running setup.py install for mozinfo 21:29:27 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 21:29:27 INFO - Running setup.py install for mozInstall 21:29:27 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 21:29:27 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 21:29:27 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 21:29:27 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 21:29:27 INFO - Running setup.py install for mozleak 21:29:27 INFO - Running setup.py install for mozlog 21:29:27 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 21:29:27 INFO - Running setup.py install for moznetwork 21:29:27 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 21:29:27 INFO - Running setup.py install for mozprocess 21:29:27 INFO - Running setup.py install for mozprofile 21:29:28 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 21:29:28 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 21:29:28 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 21:29:28 INFO - Running setup.py install for mozrunner 21:29:28 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 21:29:28 INFO - Running setup.py install for mozscreenshot 21:29:28 INFO - Running setup.py install for moztest 21:29:28 INFO - Running setup.py install for mozversion 21:29:28 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 21:29:28 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 21:29:28 INFO - Cleaning up... 21:29:28 INFO - Return code: 0 21:29:28 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:29:28 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')]} 21:29:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:29:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:29:28 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')]} 21:29:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:29:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:29:28 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 0x22831f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x244fa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25f4c70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25f23f0>, '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 0x25f2cf0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25f31a0>, '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': 'cbe409c6de289db6ac707de3000001d4-1485046988.551146-486559624', '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 21:29:28 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 21:29:28 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 21:29:28 INFO - Using env: {'DISPLAY': ':0', 21:29:28 INFO - 'HOME': '/home/cltbld', 21:29:28 INFO - 'LANG': 'en_US.UTF-8', 21:29:28 INFO - 'LANGUAGE': 'en_US:en', 21:29:28 INFO - 'LOGNAME': 'cltbld', 21:29:28 INFO - 'MAIL': '/var/mail/cltbld', 21:29:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:29:28 INFO - 'MOZ_NO_REMOTE': '1', 21:29:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:29:28 INFO - 'NO_EM_RESTART': '1', 21:29:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:29:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:29:28 INFO - 'PWD': '/builds/slave/test', 21:29:28 INFO - 'SHELL': '/bin/bash', 21:29:28 INFO - 'SHLVL': '1', 21:29:28 INFO - 'TERM': 'linux', 21:29:28 INFO - 'TMOUT': '86400', 21:29:28 INFO - 'USER': 'cltbld', 21:29:28 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1485046988.551146-486559624', 21:29:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:29:28 INFO - '_': '/tools/buildbot/bin/python'} 21:29:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:29:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 21:29:28 INFO - Running setup.py (path:/tmp/pip-aP0tHP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 21:29:28 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)) 21:29:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 21:29:28 INFO - Running setup.py (path:/tmp/pip-UTPSkR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 21:29:28 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)) 21:29:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 21:29:28 INFO - Running setup.py (path:/tmp/pip-NmVARJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 21:29:28 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)) 21:29:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 21:29:28 INFO - Running setup.py (path:/tmp/pip-JKgLhs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 21:29:29 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)) 21:29:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 21:29:29 INFO - Running setup.py (path:/tmp/pip-n_lz_L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 21:29:29 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)) 21:29:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 21:29:29 INFO - Running setup.py (path:/tmp/pip-PhXiXV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 21:29:29 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)) 21:29:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 21:29:29 INFO - Running setup.py (path:/tmp/pip-SKGvj_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 21:29:29 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)) 21:29:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 21:29:29 INFO - Running setup.py (path:/tmp/pip-TctXFq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 21:29:29 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)) 21:29:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 21:29:29 INFO - Running setup.py (path:/tmp/pip-kmlDC3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 21:29:29 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)) 21:29:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 21:29:29 INFO - Running setup.py (path:/tmp/pip-8xpwAx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 21:29:29 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)) 21:29:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 21:29:29 INFO - Running setup.py (path:/tmp/pip-g9_eEe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 21:29:29 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)) 21:29:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 21:29:29 INFO - Running setup.py (path:/tmp/pip-Buzku6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 21:29:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.24 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)) 21:29:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 21:29:29 INFO - Running setup.py (path:/tmp/pip-_Kry9Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 21:29:29 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)) 21:29:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 21:29:29 INFO - Running setup.py (path:/tmp/pip-olCMBr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 21:29:29 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)) 21:29:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 21:29:29 INFO - Running setup.py (path:/tmp/pip-Xam9io-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 21:29:29 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)) 21:29:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 21:29:29 INFO - Running setup.py (path:/tmp/pip-blyL3c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 21:29:29 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)) 21:29:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 21:29:29 INFO - Running setup.py (path:/tmp/pip-3iWA7R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 21:29:29 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)) 21:29:29 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)) 21:29:29 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)) 21:29:29 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)) 21:29:29 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)) 21:29:29 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)) 21:29:29 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 21:29:29 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 21:29:29 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 21:29:29 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 21:29:29 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 21:29:29 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 21:29:29 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 21:29:31 INFO - Downloading blessings-1.6.tar.gz 21:29:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 21:29:32 INFO - Installing collected packages: blessings 21:29:32 INFO - Running setup.py install for blessings 21:29:32 INFO - Successfully installed blessings 21:29:32 INFO - Cleaning up... 21:29:32 INFO - Return code: 0 21:29:32 INFO - Done creating virtualenv /builds/slave/test/build/venv. 21:29:32 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 21:29:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 21:29:32 INFO - Reading from file tmpfile_stdout 21:29:32 INFO - Current package versions: 21:29:32 INFO - argparse == 1.2.1 21:29:32 INFO - blessings == 1.6 21:29:32 INFO - blobuploader == 1.2.4 21:29:32 INFO - docopt == 0.6.1 21:29:32 INFO - functools32 == 3.2.3-2 21:29:32 INFO - jsonschema == 2.5.1 21:29:32 INFO - manifestparser == 1.1 21:29:32 INFO - mozInstall == 1.12 21:29:32 INFO - mozcrash == 1.0 21:29:32 INFO - mozdebug == 0.1 21:29:32 INFO - mozdevice == 0.49 21:29:32 INFO - mozfile == 1.2 21:29:32 INFO - mozhttpd == 0.7 21:29:32 INFO - mozinfo == 0.9 21:29:32 INFO - mozleak == 0.1 21:29:32 INFO - mozlog == 3.4 21:29:32 INFO - moznetwork == 0.27 21:29:32 INFO - mozprocess == 0.24 21:29:32 INFO - mozprofile == 0.28 21:29:32 INFO - mozrunner == 6.13 21:29:32 INFO - mozscreenshot == 0.1 21:29:32 INFO - mozsystemmonitor == 0.3 21:29:32 INFO - moztest == 0.8 21:29:32 INFO - mozversion == 1.4 21:29:32 INFO - psutil == 3.1.1 21:29:32 INFO - requests == 1.2.3 21:29:32 INFO - wsgiref == 0.1.2 21:29:32 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:29:32 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')]} 21:29:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:29:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:29:32 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')]} 21:29:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:29:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:29:32 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 0x22831f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x244fa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25f4c70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25f23f0>, '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 0x25f2cf0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25f31a0>, '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': 'cbe409c6de289db6ac707de3000001d4-1485046988.551146-486559624', '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 21:29:32 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 21:29:32 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 21:29:32 INFO - Using env: {'DISPLAY': ':0', 21:29:32 INFO - 'HOME': '/home/cltbld', 21:29:32 INFO - 'LANG': 'en_US.UTF-8', 21:29:32 INFO - 'LANGUAGE': 'en_US:en', 21:29:32 INFO - 'LOGNAME': 'cltbld', 21:29:32 INFO - 'MAIL': '/var/mail/cltbld', 21:29:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:29:32 INFO - 'MOZ_NO_REMOTE': '1', 21:29:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:29:32 INFO - 'NO_EM_RESTART': '1', 21:29:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:29:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:29:32 INFO - 'PWD': '/builds/slave/test', 21:29:32 INFO - 'SHELL': '/bin/bash', 21:29:32 INFO - 'SHLVL': '1', 21:29:32 INFO - 'TERM': 'linux', 21:29:32 INFO - 'TMOUT': '86400', 21:29:32 INFO - 'USER': 'cltbld', 21:29:32 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1485046988.551146-486559624', 21:29:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:29:32 INFO - '_': '/tools/buildbot/bin/python'} 21:29:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:29:32 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)) 21:29:32 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)) 21:29:32 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)) 21:29:32 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)) 21:29:32 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)) 21:29:32 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)) 21:29:32 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)) 21:29:32 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)) 21:29:32 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)) 21:29:32 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)) 21:29:32 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)) 21:29:32 INFO - Cleaning up... 21:29:32 INFO - Return code: 0 21:29:32 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 21:29:32 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')]} 21:29:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:29:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:29:32 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')]} 21:29:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:29:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:29:32 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 0x22831f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x244fa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25f4c70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25f23f0>, '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 0x25f2cf0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25f31a0>, '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': 'cbe409c6de289db6ac707de3000001d4-1485046988.551146-486559624', '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 21:29:32 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 21:29:32 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 21:29:32 INFO - Using env: {'DISPLAY': ':0', 21:29:32 INFO - 'HOME': '/home/cltbld', 21:29:32 INFO - 'LANG': 'en_US.UTF-8', 21:29:32 INFO - 'LANGUAGE': 'en_US:en', 21:29:32 INFO - 'LOGNAME': 'cltbld', 21:29:32 INFO - 'MAIL': '/var/mail/cltbld', 21:29:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:29:32 INFO - 'MOZ_NO_REMOTE': '1', 21:29:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:29:32 INFO - 'NO_EM_RESTART': '1', 21:29:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:29:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:29:32 INFO - 'PWD': '/builds/slave/test', 21:29:32 INFO - 'SHELL': '/bin/bash', 21:29:32 INFO - 'SHLVL': '1', 21:29:32 INFO - 'TERM': 'linux', 21:29:32 INFO - 'TMOUT': '86400', 21:29:32 INFO - 'USER': 'cltbld', 21:29:32 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1485046988.551146-486559624', 21:29:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:29:32 INFO - '_': '/tools/buildbot/bin/python'} 21:29:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:29:32 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 21:29:32 INFO - Cleaning up... 21:29:32 INFO - Return code: 0 21:29:32 INFO - Running post-action listener: _resource_record_post_action 21:29:32 INFO - Running post-action listener: _start_resource_monitoring 21:29:32 INFO - Starting resource monitoring. 21:29:32 INFO - [mozharness: 2017-01-22 05:29:32.975581Z] Finished create-virtualenv step (success) 21:29:32 INFO - [mozharness: 2017-01-22 05:29:32.976120Z] Running install step. 21:29:32 INFO - Running pre-action listener: _resource_record_pre_action 21:29:32 INFO - Running main action method: install 21:29:32 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 21:29:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 21:29:33 INFO - Reading from file tmpfile_stdout 21:29:33 INFO - Detecting whether we're running mozinstall >=1.0... 21:29:33 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 21:29:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 21:29:33 INFO - Reading from file tmpfile_stdout 21:29:33 INFO - Output received: 21:29:33 INFO - Usage: mozinstall [options] installer 21:29:33 INFO - Options: 21:29:33 INFO - -h, --help show this help message and exit 21:29:33 INFO - -d DEST, --destination=DEST 21:29:33 INFO - Directory to install application into. [default: 21:29:33 INFO - "/builds/slave/test"] 21:29:33 INFO - --app=APP Application being installed. [default: firefox] 21:29:33 INFO - mkdir: /builds/slave/test/build/application 21:29:33 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'] 21:29:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 21:29:50 INFO - Reading from file tmpfile_stdout 21:29:50 INFO - Output received: 21:29:50 INFO - /builds/slave/test/build/application/firefox/firefox 21:29:50 INFO - Running post-action listener: _resource_record_post_action 21:29:50 INFO - [mozharness: 2017-01-22 05:29:50.680155Z] Finished install step (success) 21:29:50 INFO - [mozharness: 2017-01-22 05:29:50.680385Z] Running run-tests step. 21:29:50 INFO - Running pre-action listener: _resource_record_pre_action 21:29:50 INFO - Running main action method: run_tests 21:29:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 21:29:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 21:29:50 INFO - Python 2.7.3 21:29:50 INFO - Return code: 0 21:29:50 INFO - grabbing minidump binary from tooltool 21:29:50 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')]} 21:29:50 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 0x25f23f0>, '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 0x25f2cf0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25f31a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 21:29:50 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 21:29:50 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 21:29:50 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 21:29:50 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 21:29:50 INFO - Return code: 0 21:29:50 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 21:29:50 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 21:29:50 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 21:29:50 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 21:29:50 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 21:29:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Graphics', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/RintsF4ISi2O_RCPw0ndYQ/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-054', '--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 21:29:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Graphics --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/RintsF4ISi2O_RCPw0ndYQ/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-054 --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 21:29:50 INFO - Using env: {'DISPLAY': ':0', 21:29:50 INFO - 'HOME': '/home/cltbld', 21:29:50 INFO - 'LANG': 'en_US.UTF-8', 21:29:50 INFO - 'LANGUAGE': 'en_US:en', 21:29:50 INFO - 'LOGNAME': 'cltbld', 21:29:50 INFO - 'MAIL': '/var/mail/cltbld', 21:29:50 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 21:29:50 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 21:29:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:29:50 INFO - 'MOZ_NO_REMOTE': '1', 21:29:50 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 21:29:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:29:50 INFO - 'NO_EM_RESTART': '1', 21:29:50 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:29:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:29:50 INFO - 'PWD': '/builds/slave/test', 21:29:50 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 21:29:50 INFO - 'SHELL': '/bin/bash', 21:29:50 INFO - 'SHLVL': '1', 21:29:50 INFO - 'TERM': 'linux', 21:29:50 INFO - 'TMOUT': '86400', 21:29:50 INFO - 'USER': 'cltbld', 21:29:50 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1485046988.551146-486559624', 21:29:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:29:50 INFO - '_': '/tools/buildbot/bin/python'} 21:29:50 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Graphics', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/RintsF4ISi2O_RCPw0ndYQ/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-054', '--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 21:29:50 INFO - mozversion application_buildid: 20170122042523 21:29:50 INFO - mozversion application_changeset: d295888faea067587708534300861dcba5a38928 21:29:50 INFO - mozversion application_display_name: Nightly 21:29:50 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 21:29:50 INFO - mozversion application_name: Firefox 21:29:50 INFO - mozversion application_remotingname: firefox 21:29:50 INFO - mozversion application_repository: https://hg.mozilla.org/projects/graphics 21:29:50 INFO - mozversion application_vendor: Mozilla 21:29:50 INFO - mozversion application_version: 53.0a1 21:29:50 INFO - mozversion platform_buildid: 20170122042523 21:29:50 INFO - mozversion platform_changeset: d295888faea067587708534300861dcba5a38928 21:29:50 INFO - mozversion platform_repository: https://hg.mozilla.org/projects/graphics 21:29:50 INFO - mozversion platform_version: 53.0a1 21:29:50 INFO - using testdate: 1485062990 21:29:50 INFO - actual date: 1485062990 21:29:50 INFO - starting webserver on 'localhost:37942' 21:29:50 INFO - SUITE-START | Running 2 tests 21:29:50 INFO - TEST-START | dromaeo_css 21:29:50 INFO - operating with platform_type : linux_ 21:29:50 INFO - Initialising browser for dromaeo_css test... 21:29:50 INFO - TEST-INFO | started process 9200 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp5Ud3oB/profile http://localhost:37942/getInfo.html) 21:29:56 INFO - PROCESS | 9200 | __metrics Screen width/height:1600/1200 21:29:56 INFO - PROCESS | 9200 | colorDepth:24 21:29:56 INFO - PROCESS | 9200 | Browser inner width/height: 1024/697 21:29:56 INFO - PROCESS | 9200 | __metrics 21:29:57 INFO - PROCESS | 9200 | JavaScript error: resource://app/modules/webrtcUI.jsm, line 66: NS_ERROR_XPC_NOT_ENOUGH_ARGS: Not enough arguments [nsIMessageListenerManager.removeMessageListener] 21:29:57 ERROR - PROCESS | 9200 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3269: TypeError: this.tabs is undefined 21:29:57 INFO - PROCESS | 9200 | console.error: 21:29:57 INFO - PROCESS | 9200 | Message: Error: Connection closed before committing the transaction. 21:29:57 INFO - PROCESS | 9200 | Stack: 21:29:57 INFO - PROCESS | 9200 | executeTransaction/promise resource://gre/modules/Promise-backend.js:917:23 21:29:57 INFO - PROCESS | 9200 | walkerLoop@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:801:7 21:29:57 INFO - PROCESS | 9200 | Promise*scheduleWalkerLoop@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:734:11 21:29:57 INFO - PROCESS | 9200 | schedulePromise@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:765:7 21:29:57 INFO - PROCESS | 9200 | completePromise@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:702:7 21:29:57 INFO - PROCESS | 9200 | TaskImpl_run@resource://gre/modules/Task.jsm:324:15 21:29:57 INFO - PROCESS | 9200 | observe@resource://gre/modules/AsyncShutdown.jsm:550:9 21:29:57 INFO - PROCESS | 9200 | addBlocker/moduleBlocker/<@resource://gre/components/nsAsyncShutdown.js:157:15 21:29:57 INFO - PROCESS | 9200 | Promise@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:385:5 21:29:57 INFO - PROCESS | 9200 | moduleBlocker@resource://gre/components/nsAsyncShutdown.js:153:29 21:29:57 INFO - PROCESS | 9200 | trigger@resource://gre/modules/AsyncShutdown.jsm:719:23 21:29:57 INFO - PROCESS | 9200 | _wait@resource://gre/modules/AsyncShutdown.jsm:866:7 21:29:57 INFO - PROCESS | 9200 | wait@resource://gre/modules/AsyncShutdown.jsm:850:28 21:29:57 INFO - PROCESS | 9200 | observe@resource://gre/modules/AsyncShutdown.jsm:533:17 21:29:57 INFO - PROCESS | 9200 | 21:29:58 INFO - TEST-INFO | 9200: exit 0 21:29:58 INFO - Browser initialized. 21:29:58 INFO - Running cycle 1/1 for dromaeo_css test... 21:29:58 INFO - TEST-INFO | started process 9323 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp5Ud3oB/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 21:30:10 INFO - PROCESS | 9323 | RSS: Main: 154435584 21:30:10 INFO - PROCESS | 9323 | 21:33:10 INFO - PROCESS | 9323 | Cycle 1(1): loaded http://localhost:37942/tests/dromaeo/cssquery-dojo.html (next: http://localhost:37942/tests/dromaeo/cssquery-ext.html) 21:33:11 INFO - PROCESS | 9323 | RSS: Main: 165826560 21:33:11 INFO - PROCESS | 9323 | 21:34:58 INFO - PROCESS | 9323 | ************************* 21:34:58 INFO - PROCESS | 9323 | A coding exception was thrown and uncaught in a Task. 21:34:58 INFO - PROCESS | 9323 | 21:34:58 ERROR - PROCESS | 9323 | Full message: TypeError: NetworkError when attempting to fetch resource. 21:34:58 INFO - PROCESS | 9323 | Full stack: 21:34:58 INFO - PROCESS | 9323 | ************************* 21:36:13 INFO - PROCESS | 9323 | Cycle 1(1): loaded http://localhost:37942/tests/dromaeo/cssquery-ext.html (next: http://localhost:37942/tests/dromaeo/cssquery-jquery.html) 21:36:14 INFO - PROCESS | 9323 | RSS: Main: 161337344 21:36:14 INFO - PROCESS | 9323 | 21:39:16 INFO - PROCESS | 9323 | Cycle 1(1): loaded http://localhost:37942/tests/dromaeo/cssquery-jquery.html (next: http://localhost:37942/tests/dromaeo/cssquery-mootools.html) 21:39:16 INFO - PROCESS | 9323 | RSS: Main: 167129088 21:39:16 INFO - PROCESS | 9323 | 21:42:18 INFO - PROCESS | 9323 | Cycle 1(1): loaded http://localhost:37942/tests/dromaeo/cssquery-mootools.html (next: http://localhost:37942/tests/dromaeo/cssquery-prototype.html) 21:42:19 INFO - PROCESS | 9323 | RSS: Main: 161599488 21:42:19 INFO - PROCESS | 9323 | 21:45:21 INFO - PROCESS | 9323 | Cycle 1(1): loaded http://localhost:37942/tests/dromaeo/cssquery-prototype.html (next: http://localhost:37942/tests/dromaeo/cssquery-yui.html) 21:45:22 INFO - PROCESS | 9323 | RSS: Main: 167723008 21:45:22 INFO - PROCESS | 9323 | 21:48:24 INFO - PROCESS | 9323 | Cycle 1(1): loaded http://localhost:37942/tests/dromaeo/cssquery-yui.html (next: http://localhost:37942/tests/dromaeo/cssquery-dojo.html) 21:48:25 INFO - PROCESS | 9323 | RSS: Main: 165572608 21:48:25 INFO - PROCESS | 9323 | 21:48:25 INFO - PROCESS | 9323 | __start_tp_report 21:48:25 INFO - PROCESS | 9323 | _x_x_mozilla_page_load 21:48:25 INFO - PROCESS | 9323 | _x_x_mozilla_page_load_details 21:48:25 INFO - PROCESS | 9323 | |i|pagename|runs| 21:48:25 INFO - PROCESS | 9323 | |0;dojo.html;3202.759793015524;3206.711395974362;3218.565493658357;3230.4992726127457;3242.789218700784;5228.686278823264;5364.114921038029;5409.296791417115;5420.214068959998;5427.782888684458;5309.389420216667;5311.336082989626;5368.677879327243;5387.19192121182;5441.455854414557;4697.06058788242;4788.569028787409;4791.784369703371;4818.879528011793;4890.046440944017;4521.095780843828;4854.247591623286;4900.289458028584;4900.754962251891;4921.975390123062;4691.695039822401;4727.290906364038;4755.191617425046;4859.73271470069;4866.732329721882;4672.953270467286;4725.834595789131;4730.101280756645;4771.6898401603785;4797.808087676489;4678.111158879802;4698.953010469886;4717.905641887143;4719.551642593948;4757.119932812441;5294.841154765363;5304.389995150568;5319.9202011969855;5328.413874473805;5340.385855626614;5765.048766953448;5816.272965879265;5844;5848.093545500455;5898.528117750612;5894.233749612566;5899.174115623773;5915.231019967419;5923.318818335903;5945.8810823783715;5364.6512976656395;5519.116941289455;5529.336479622471;5531.806386776443;5536.778528858841;5902.852428689317;5999.130126131687;6026.758929642765;6041.577089603774;6078.756849725962;5746.88506229873;5769;5787.594868359174;5791.102379131242;5796.3913789052385;5733.971330143323;5863.179154918314;5888.646681199141;5899.528037756969;5907;5737.196792449061;5742.7415766290615;5764.13537969308;5780.306363236438;5887.0580707086665;5843.474087332161;5854.648721076749;5858.355580886099;5863.091220860773;5867.911981320283;4567.497575266718;4570.81716731327;4572.862814115582;4575.496695363508;4612.331211974245;3977.2840888639744;4008.9198216035516;4029.6171863672903;4070.776107314126;4081.4898137732785;5592.3009623797025;5605.691686957257;5618.775248990077;5622.775088996476;5667.291588551431;5881.32990802347;5926.407359264039;5938.762449502058;5947.1376650385455;5953.613015154001;5312.893742125136;5410.026195284808;5520.66875987442;5561.972190139023;5618.887622247532;5120.155174396257;5126.820831208768;5134.152864777345;5151.665141765773;5171.405288391883;6158.322584515699;6229.719662615194;6243.7814676486105;6247.2815626202655;6249.062640603855;5727.5417966561745;5736.6558006519745;5759.740811663569;5945.583809133492;5962.940370596239;5976.551758618208;6033.758649653964;6064.120702498201;6108.75564977396;6114.113453549299;5697.088465845445;5743.942560574341;5750.482456578928;5755.050416681368;5757.856053598526;5707.486326230659;5765.308163020464;5766.4233576642;5834.066549352084;5840.94159058404;5592.245046918614;5605.691686957257;5617.269754931833;5679.403662615366;5726.914096288642;5669.234653321749;5679.74441150141;5680.68756218412;5683.5453163747625;5686.744096515749;5454.618176727591;5494.36814766291;5551.861868317066;5647.29408823897;5669.603127781016;5603.971980140073;5650.124230744241;5666.943330566642;5745.425457454221;5753.1370294456165;5508.366537848199;5528.7235638218735;5529.557635389078;5538.861528461821;5555.8888822224135 21:48:25 INFO - PROCESS | 9323 | |1;ext.html;553.2061491759325;573.936866944636;579.8202557207264;590.3329237961103;607.5989846701178;39396.21207575847;43596.12807743843;43636;43650.34524482127;43856;44281.557184428224;44652.77673611636;44966;44980.55019449804;45243.54756452434;8910.064443233465;9104.226140778042;9112.088791120868;10429.947850260776;10772.892271077268;10556.630517931873;10687.412192329419;10729.08802751767;10731.409772462512;10750.78498430031;10651.680449586525;10781.137508999262;10817.134629229682;10832.241743077988;10837.241393102486;10706.625268115618;10734.087602553793;10753.408562529057;10791.298565593212;10837.295575787548;10632.362058276529;10691.198160138021;10743.194260430499;10760.569577216902;10775.6228532001;40236.19527609461;40263;40467.39298910519;40558.797206014075;40607.7969610153;4120.568864370036;4143.958560414388;4203.222403855266;4231.280682284019;4246.617804397619;29949.101526954226;29969.70030299691;30819;31249.687503125133;31292.843535782402;4153.958460415418;4337.175936572041;4350.782460876943;4374.912501749947;4383.7150585212175;334834.99999999756;334928;335014.64985350077;335810;336549;55127;55917.44082559122;56019.15971260434;56209.71895140498;56519;58223.12665310024;58385;58452;58656.70671646614;58927.116093258635;15097.773533397009;15404.229788510755;15410.152441615595;15448.304826282843;15482;11568.76862462746;11957.162998590189;11974.940125299318;12185.268883866996;12204.755904881853;17686.823131768775;17892.373766918095;17989.280428782702;18031.72952405715;18132.63734725298;6966.442684585221;6974.476914231453;7182.604956727326;7265.200827908926;7312.1956584775635;934.3039435620507;937.9999999999864;942.6229508196776;958.4201558057414;979.1677074486772;30689.232769180504;30926.69073309283;31625;31861.362772744415;32271;1118.7930232906776;1119.6025410979148;1144.5250221158126;1149.2472430557998;1150.6375491720248;15931.80189505532;16467.752983705253;16865.747013794804;17104.572385690208;17154.828451715322;495305;499503;499702;500805;501344;64768;65453.67273163699;65684;65734;65781.34218657848;1396.2599822094305;1410.2384712255268;1414.1868425655289;1418.6524301546187;1438.719449707318;29739;30278.103609556612;31216.21959451032;31416.842915785273;32088.518672219467;53036.204456932406;54882;55022.44977550173;55109.448905510435;55109.724451377486;420871;422864;423248;424550;425346;27538.449231015667;28580.571291430228;28586.85706571454;28672.569911450926;28677.13968580946;48125;48422.5157748418;48883.75558122186;48952;49464.50535494599;39375.80312098421;39931.2013759729;40414.59585404109;41181;42140.157196856504;40339.1932161361;40485;41901.371479427224;42225.78887105668;42319.3652095225;40570.565766052954;40634.39048414217;40677.389839151845;41313;41637.167256654095;33953.49069764005;35941.82029089838;36034.94007139631;36207.275854482235;36355.45466818053;27239.31901702394;27331;27477.72522274752;27488.862555687094;27502.862485687445 21:48:25 INFO - PROCESS | 9323 | |2;jquery.html;375.98872033838995;385.1814893351628;428.66564080017577;435.7342021366966;442.3011641606261;18769.343072992448;20618.89690551547;20631.484212894684;21572.244971426004;22538.43653908653;21408.785912140913;21994.560108797814;22232.8888355558;22498.55002899941;22675.659865101996;6143.723532441039;6417.358264173568;6431.6784160792;6435.163428754278;6443.677816109176;6140.324564297946;6238.313785483616;6274.309825919146;6312.053192021188;6321.715522801485;6302.810915672537;6306.527010474209;6310.495160387181;6313.463355614778;6324.841878953017;6083.665398403086;6340;6358.586691865037;6378.93621063788;6380.425761681425;5262.8684282892855;5479.808206712786;6007.669578173199;6023.397660233985;6027.457528822427;14738.11571305725;14880.479183228535;14983.925080374529;15351.923240383838;25033.374165645822;2598.649182360395;2662.4142688608476;2680.2763253921526;2725.9454810903867;3030.7423868970945;10472.424016679079;10521.579136834594;10687.893121068768;11060.115190784718;11120.721981950435;1879.962400751991;1912.7035309527046;1960.2061165228106;1961.6174845905055;1963.518937860219;90934.5453272736;91105;91165.99999999933;92207;92462;11828.40857957116;11900.583479578174;11957.130288730816;12110;12902.870971290355;16743.665126697397;16868;16939.49181524556;16951.830481695026;16976.151192440328;7787.493812902257;7965.6017199139815;8030.638621262057;8160.3471722262075;8190.467619604707;7287.672054757549;7391.482596218213;7525;7600.695972161052;7607;5014.373203349582;5079.314292570456;5116.948830511647;5147.433782283946;5312.867178320495;2091.351680978901;2133.98933005334;2170.2295685031904;2201.3395981205895;2218.5895609312006;1063.7393838509615;1068.156156636264;1072.790805792863;1115.1636272795404;1122.663201039701;20321.593568128555;20394.184232630825;20643.58712825735;20649.483762906046;20685.89657051735;1079.3739631013993;1084.3331351218944;1097.067492631273;1103.713034610991;1121.394446998628;10410;11484.25352352111;11486.885131148749;11530.135239857043;11597.536098556133;544671;581808;627296;631652;642668;99699;102336;104363;104706;106917.46541267243;1008.6721815410021;1030.8814486334168;1047.2407504559285;1052.984205236922;1061.7345663584103;17229;17284.135793210542;17586.38447654326;18390.81609183891;18439.446816595522;41211.793941030104;42776.35835462533;47480.762596186796;47537.52462475331;48025.519744802106;59480;61260;61822;61848.381516184265;62506.37493625005;7900.367970562226;7963;8218.096009438837;8660;9231.676891308773;8384.119667435076;12903.225806451643;13105.27920964356;13429;14252.786208207093;11353.772924541629;12192.268463892195;12375.195612285173;12462;12473.812892806796;12140.878591213976;12366.62900112998;12384.071194660617;12386.876131238572;12701.031340142294;12527.248365098123;12627.87372126267;12646;12737.363131843556;12786.808197876853;9128.863067054132;9231.169194772503;9304.860427093734;9316.767080823034;9468.479233642216;11738.823917641072;12346.81479777786;12556.497740090294;12612.684682883002;13009.633988431457 21:48:25 INFO - PROCESS | 9323 | |3;mootools.html;1422.9217393043384;1435.3684378873295;1438.8992770506068;1442.4662874736337;1444.4511085787399;7819.843603127941;7900.565468899208;8197.385196110294;8259.21537453941;8302.377321700866;8297.875531867026;8459.196376344238;8497.107803680618;8522.74431767048;8526.70156544521;2326.0463210083867;2379.940501487468;2380.7619238076227;2381.071382160959;2383.4041489627593;2297.9885100574475;2302.2057390200353;2342.121704360865;2393.3298676370555;2396.496735685508;2330.242671131889;2350.2831636350907;2350.459394339303;2353.1999120299097;2356.728976167737;2172.196287373666;2206.4483879030245;2213.0815711479718;2215.2468160825315;2221.44463884029;2294.8967296471533;2299.724033116037;2305.0779688124717;2343.1798870395396;2367.419982104378;8251.504909705376;8277.586120694;8293.377996650275;8297.709580164727;8340.040895296997;5107.744612769384;5254.842354729364;5258.1849813279005;5265.605079619006;5267.999080174754;3212.8072315661134;3304.6364899860996;3320.5849268841393;3338.582677165354;3359.5128706337446;1266.803645434959;1293.2693028438903;1322.5701646964776;1355.1868878672817;1398.2798858587835;10861;11168.106551475781;11232.438378081064;11252.43737813106;11300.773984520263;4337.631301339358;4436.689431739747;4509.819607215741;4518.525554816697;4550.883839014874;8983.55082245885;9010.189082982562;9035.683751068813;9049.728508144766;9054.275657947348;5240.659357141773;5264.184051472028;5269.920951185735;5270.841874743764;5272.472752724773;4770.165221086296;4772.85767743545;4848.7090774553635;4901.705897646153;4928.605711543068;3682.705383569308;3740.9438858417147;3784.262068896594;3867.864624738177;3915.2169566086895;1116.2521110855585;1116.8771435142128;1133.3823066428815;1134.5688638317386;1135.239389608964;922.7739203895088;927.2767241551601;931.1573026411108;931.8695382646434;962.4802606592361;5360.088784906575;5500.862478438071;5509.146082357241;5560.221568980346;5650.519705824969;1018.0837246478081;1028.311031608824;1042.2131290875493;1047.2878442658912;1057.7831544533353;3752.399616061417;3769.5853456119803;3776.8866933992026;3834.9424758628643;3967.0082479380153;9753.317267791328;10012;10038.698839034842;10078.748031299276;10100.242481813893;8931.642734290686;9189.264858811279;9968.152707019839;9995;10055.69832905014;7697.653605587762;7854.567998760123;7860.646270917822;7864.2922137007945;7870.370370370357;5454.945450545444;5617.915731264116;5675.801346952837;5682.77268909239;5801.94198058014;9024.684136055206;9024.819503610022;9033.322500812334;9165.358424910191;9184.12750788674;8895.066018068268;9108.271338292789;9177.724668259963;9302.302327325342;9342.346035777431;7124.3944264736;7175.928240717735;7200.639968001684;7230.6384680764695;7309.561426314438;7004.229534751072;7568.3945284378215;7654.425918056279;7744.8451030980195;7746.767596972099;6333.303336633059;6703.731850725916;6892.827679308058;6907.723691052302;6936;6748.392644662004;6773.119494465885;6856.862862742618;6862.828429289308;6885.793426197222;6153.169322141453;6247.875042499034;6267.373262673696;6281.623102613858;6295.464885484785;4596.333531637961;4686.554777296152;5018.723970181675;5102.443754654866;5184.766685499086;4849.830255941025;4941.085899108676;4962.429320628174;5059.241113832807;5065.772040258271 21:48:25 INFO - PROCESS | 9323 | |4;prototype.html;363.578249230892;381.15193694030773;381.97326187166874;386.17166178547006;388.84640566976026;5427.878969592481;5451.754671039803;5500.312460942382;5519.6412233204865;5524.972375138123;5384.40771515134;5468.535174510172;5471.945280547194;5478.726063696819;5504.4495550444935;3946.4806049670797;4023.3763766616075;4048.3078752629613;4279.807408666602;4286.485621725397;3996.740211886233;4034.152827906143;4035.961839271164;4037.7577345359227;4059.025833799896;4024.396340548926;4030.8387664493384;4048.696347773914;4055.918881622366;4070.5929407059207;4004.899877503057;4060.390941358805;4064.6138616831354;4065.9796701016603;4073.735207211522;3520.7887526748477;3531.6644918732677;3532.5584301962253;3540.6459354064646;3561.4835848802036;5211.618920985942;5223.399309079428;5247.711375874325;5279.208118782213;5283.656562323436;4713.208980587389;4731.787069581877;4741.241401375763;4762.357081793948;4767.284907263904;5562.443755624446;5621.550275977953;5630.690312032836;5657.632253903483;5671.6880571568545;3917.8628747993685;3928.705347098979;3928.9803550982347;3929.4105884117325;3932.351162058257;5614.529606972919;5781.5952883298605;5821.388754180834;5898;5914.2902851657645;4112.979435102865;4118.91762164755;4124.690648201336;4128.298189307765;4148.651688201347;4160.625543701021;4178.310578754532;4180.832766689359;4182.452492577705;4182.456280683553;4661.766911654404;4711.175544279738;4781.613332133712;4782.6173906088125;4802.823308289491;5662.716864156776;5685.886282274331;5696.629719068247;5745.122042621214;5771.767810026315;1389.5136702154166;1396.615930619088;1397.3921344215298;1398.189050350794;1399.4052527675901;912.0605776050678;961.8364877970622;967.2020583018897;969.680005598151;977.8900947424582;5327.866803329948;5342.946570534323;5374.381946076252;5382.327209098863;5385.838424847261;5666;5690.5163061140265;5713.771449142071;5717.485426311652;5734.369219385864;5080.187170052774;5372.355317361941;5429.809956651498;5488.69812160335;5537.723113844291;3013.8794448222266;3017.788754787188;3027.7729170312314;3035.468792961223;3069.8618562164756;5664.716764161775;5915.911261331084;5957.940420595825;5959.46722642875;5978.611390259619;5737.827865164052;5746.913796293059;5770.336411312669;5791.507721843691;5796.840631873642;5870.853228669317;5933.736444955257;5937.376575459601;5941.821745347646;5959.791407300723;5542.612017158922;5612.663240205601;5636.464535869086;5826.533877289722;5864.912026319524;5802.709864506842;5848.912266315923;5857.150713146485;5879.676617786063;5892.2929248488745;5900.232969713909;6016.2479690038745;6048.909266361096;6068.241469816273;6148.354422785543;4291.699581029423;4352.978235108804;4368.235558777138;4378.277584198571;4382.627476664392;5724.856878578069;5848.181254624441;5945.878413832773;5947.494462970523;5965.313988891333;5683.8010669626365;5686.77252909879;5701.657900525982;5716.371199168171;5734.254546908875;5605.439456054362;5729.197912292199;5742.741576628978;5753.8561535961935;5760.6255593386295;5370.919436208382;5592.692401917933;5643.604947653625;5668.801591944262;5682.545396368363;5756.913646295393;5765.56758243125;5773.16289138081;5774.989376859117;5782.421757824184;5512.173174023768;5591.748371323219;5601.663900166003;5616.438356164351;5628.690422026828 21:48:25 INFO - PROCESS | 9323 | |5;yui.html;739.3161325773658;771.0986669309676;771.3559178086298;842.469244376043;882.4087861133042;15321;16470.752938705915;16483.50549483516;16681.916590417062;17602.735958960595;14302.856971430283;14508.709825803478;16866.578335541617;17104.82895171048;17292.394766183184;729.4310437858479;743.6727839750492;744.13680131048;746.3320328306163;746.7759672098376;715.8711431942248;749.5615065186872;751.2449987762319;755.1089714137344;764.4190415284396;773.1418125880268;778.9260020298062;779.9181085985975;780.6096951524238;784.3764207455058;774.8062984253909;776.2547953964173;776.9456138070337;778.696308439709;779.154617240295;571.6684323092596;571.8598943258886;572.0475408444934;572.1046562130252;572.6993328502527;15423.614409639737;15695.607609809733;15728.134952577604;15743.527694169194;15759.054456732632;14931.40274389034;15189.544313670607;15404.691906161926;15447.227638618137;15591.1424871632;12443.315617641027;12511.874881251162;12526.185797923106;12685.873141268561;12745.17156384832;3730.4031354983344;3798.810059497014;3815.2178803345246;3845.9230815383535;3862.6523612874976;75217.62391188009;75279.6236018822;75814;75991.6200419;77082;11523.135764817673;11531.88468115325;11844.940775296069;11900.702482437835;11932.463039163258;22420.215292464687;22459.32622021342;22502.887485562467;22681.546369072857;22707.09171633149;7608.804302193093;7694.692212311445;7806.804829879298;7926.48477848938;7933.087694915043;4419.315006174048;4520.4575450946095;4524.932126018112;4576.519465456146;4646.140464014168;3538.239278555123;3596.9820150899077;3629.528161339009;3673.8897833065053;3682.04266890605;559.5663360895338;563.5097465205298;565.7199686155298;571.794154104522;572.3503823160743;589.4400319696306;598.2014011294883;602.6594973839855;606.3542327421283;612.4360187694842;10025.398476091457;10091.142252908438;10333.018363255478;10358.585656573652;10378.117859981987;533.3386204572013;544.9536789372869;553.7369749369097;557.631962904481;563.5773170122408;5013.373328333958;5125.231215317732;5132.871678208075;5144.742762861842;5170.508801663836;77414.612926935;79948.20051799408;80439.59780201061;81606;82602.58698706469;67271.66364168147;67615.66192169007;68440.31559684439;68915.3108468919;69238.65380673064;53649;54163.72918135384;60426.69786651126;61165.38834611686;62533;9768.3112106188;10648.467576621293;10868.67393978182;11155.888441115485;11162.776744464903;41456.37815432831;41648;41899.58100418957;42763.14473710571;43131;51216.487835121174;51914.74042629914;52061;52997.20504192363;54478.18282725683;12537.749245014866;12775.297358645365;12776.383470417437;12806.807897881354;12946.611601651966;14633.34149963233;14740.631484212552;14877.925610372311;14899.47851825181;14922.776158357416;13775.793363099761;13782.173069615856;13994.300284985913;14033.929830350782;14053.156810591398;13415.396307166397;13489.932550337579;13615.25116118623;13719.314034298444;13821.792673110112;12840.357982100672;13130.474781009034;13205.075644704779;13305.46778128864;13510.729785404434;10628.468576571295;10716.73208169802;10756.408397538211;10875.347479151276;11020.944895275472;10972;11035.172362072715;11150.553977840795;11344.716382090513;11361.318320900773 21:48:25 INFO - PROCESS | 9323 | __end_tp_report 21:48:25 INFO - PROCESS | 9323 | __start_cc_report 21:48:25 INFO - PROCESS | 9323 | _x_x_mozilla_cycle_collect,303 21:48:25 INFO - PROCESS | 9323 | __end_cc_report 21:48:25 INFO - PROCESS | 9323 | __startTimestamp1485064105036__endTimestamp 21:48:25 INFO - PROCESS | 9323 | 21:48:25 INFO - PROCESS | 9323 | ------- Summary: start ------- 21:48:25 INFO - PROCESS | 9323 | Number of tests: 6 21:48:25 INFO - PROCESS | 9323 | 21:48:25 INFO - PROCESS | 9323 | [#0] dojo.html Cycles:165 Average:5399.53 Median:5617.27 stddev:633.64 (11.3%) stddev-sans-first:611.70 21:48:25 INFO - PROCESS | 9323 | Values: 3202.8 3206.7 3218.6 3230.5 3242.8 5228.7 5364.1 5409.3 5420.2 5427.8 5309.4 5311.3 5368.7 5387.2 5441.5 4697.1 4788.6 4791.8 4818.9 4890.0 4521.1 4854.2 4900.3 4900.8 4922.0 4691.7 4727.3 4755.2 4859.7 4866.7 4673.0 4725.8 4730.1 4771.7 4797.8 4678.1 4699.0 4717.9 4719.6 4757.1 5294.8 5304.4 5319.9 5328.4 5340.4 5765.0 5816.3 5844.0 5848.1 5898.5 5894.2 5899.2 5915.2 5923.3 5945.9 5364.7 5519.1 5529.3 5531.8 5536.8 5902.9 5999.1 6026.8 6041.6 6078.8 5746.9 5769.0 5787.6 5791.1 5796.4 5734.0 5863.2 5888.6 5899.5 5907.0 5737.2 5742.7 5764.1 5780.3 5887.1 5843.5 5854.6 5858.4 5863.1 5867.9 4567.5 4570.8 4572.9 4575.5 4612.3 3977.3 4008.9 4029.6 4070.8 4081.5 5592.3 5605.7 5618.8 5622.8 5667.3 5881.3 5926.4 5938.8 5947.1 5953.6 5312.9 5410.0 5520.7 5562.0 5618.9 5120.2 5126.8 5134.2 5151.7 5171.4 6158.3 6229.7 6243.8 6247.3 6249.1 5727.5 5736.7 5759.7 5945.6 5962.9 5976.6 6033.8 6064.1 6108.8 6114.1 5697.1 5743.9 5750.5 5755.1 5757.9 5707.5 5765.3 5766.4 5834.1 5840.9 5592.2 5605.7 5617.3 5679.4 5726.9 5669.2 5679.7 5680.7 5683.5 5686.7 5454.6 5494.4 5551.9 5647.3 5669.6 5604.0 5650.1 5666.9 5745.4 5753.1 5508.4 5528.7 5529.6 5538.9 5555.9 21:48:25 INFO - PROCESS | 9323 | 21:48:25 INFO - PROCESS | 9323 | [#1] ext.html Cycles:180 Average:58654.69 Median:40249.60 stddev:112281.37 (279.0%) stddev-sans-first:112511.60 21:48:25 INFO - PROCESS | 9323 | Values: 553.2 573.9 579.8 590.3 607.6 39396.2 43596.1 43636.0 43650.3 43856.0 44281.6 44652.8 44966.0 44980.6 45243.5 8910.1 9104.2 9112.1 10429.9 10772.9 10556.6 10687.4 10729.1 10731.4 10750.8 10651.7 10781.1 10817.1 10832.2 10837.2 10706.6 10734.1 10753.4 10791.3 10837.3 10632.4 10691.2 10743.2 10760.6 10775.6 40236.2 40263.0 40467.4 40558.8 40607.8 4120.6 4144.0 4203.2 4231.3 4246.6 29949.1 29969.7 30819.0 31249.7 31292.8 4154.0 4337.2 4350.8 4374.9 4383.7 334835.0 334928.0 335014.6 335810.0 336549.0 55127.0 55917.4 56019.2 56209.7 56519.0 58223.1 58385.0 58452.0 58656.7 58927.1 15097.8 15404.2 15410.2 15448.3 15482.0 11568.8 11957.2 11974.9 12185.3 12204.8 17686.8 17892.4 17989.3 18031.7 18132.6 6966.4 6974.5 7182.6 7265.2 7312.2 934.3 938.0 942.6 958.4 979.2 30689.2 30926.7 31625.0 31861.4 32271.0 1118.8 1119.6 1144.5 1149.2 1150.6 15931.8 16467.8 16865.7 17104.6 17154.8 495305.0 499503.0 499702.0 500805.0 501344.0 64768.0 65453.7 65684.0 65734.0 65781.3 1396.3 1410.2 1414.2 1418.7 1438.7 29739.0 30278.1 31216.2 31416.8 32088.5 53036.2 54882.0 55022.4 55109.4 55109.7 420871.0 422864.0 423248.0 424550.0 425346.0 27538.4 28580.6 28586.9 28672.6 28677.1 48125.0 48422.5 48883.8 48952.0 49464.5 39375.8 39931.2 40414.6 41181.0 42140.2 40339.2 40485.0 41901.4 42225.8 42319.4 40570.6 40634.4 40677.4 41313.0 41637.2 33953.5 35941.8 36034.9 36207.3 36355.5 27239.3 27331.0 27477.7 27488.9 27502.9 21:48:25 INFO - PROCESS | 9323 | 21:48:25 INFO - PROCESS | 9323 | [#2] jquery.html Cycles:180 Average:33303.51 Median:12097.95 stddev:99875.72 (825.6%) stddev-sans-first:100125.30 21:48:25 INFO - PROCESS | 9323 | Values: 376.0 385.2 428.7 435.7 442.3 18769.3 20618.9 20631.5 21572.2 22538.4 21408.8 21994.6 22232.9 22498.6 22675.7 6143.7 6417.4 6431.7 6435.2 6443.7 6140.3 6238.3 6274.3 6312.1 6321.7 6302.8 6306.5 6310.5 6313.5 6324.8 6083.7 6340.0 6358.6 6378.9 6380.4 5262.9 5479.8 6007.7 6023.4 6027.5 14738.1 14880.5 14983.9 15351.9 25033.4 2598.6 2662.4 2680.3 2725.9 3030.7 10472.4 10521.6 10687.9 11060.1 11120.7 1880.0 1912.7 1960.2 1961.6 1963.5 90934.5 91105.0 91166.0 92207.0 92462.0 11828.4 11900.6 11957.1 12110.0 12902.9 16743.7 16868.0 16939.5 16951.8 16976.2 7787.5 7965.6 8030.6 8160.3 8190.5 7287.7 7391.5 7525.0 7600.7 7607.0 5014.4 5079.3 5116.9 5147.4 5312.9 2091.4 2134.0 2170.2 2201.3 2218.6 1063.7 1068.2 1072.8 1115.2 1122.7 20321.6 20394.2 20643.6 20649.5 20685.9 1079.4 1084.3 1097.1 1103.7 1121.4 10410.0 11484.3 11486.9 11530.1 11597.5 544671.0 581808.0 627296.0 631652.0 642668.0 99699.0 102336.0 104363.0 104706.0 106917.5 1008.7 1030.9 1047.2 1053.0 1061.7 17229.0 17284.1 17586.4 18390.8 18439.4 41211.8 42776.4 47480.8 47537.5 48025.5 59480.0 61260.0 61822.0 61848.4 62506.4 7900.4 7963.0 8218.1 8660.0 9231.7 8384.1 12903.2 13105.3 13429.0 14252.8 11353.8 12192.3 12375.2 12462.0 12473.8 12140.9 12366.6 12384.1 12386.9 12701.0 12527.2 12627.9 12646.0 12737.4 12786.8 9128.9 9231.2 9304.9 9316.8 9468.5 11738.8 12346.8 12556.5 12612.7 13009.6 21:48:25 INFO - PROCESS | 9323 | 21:48:25 INFO - PROCESS | 9323 | [#3] mootools.html Cycles:180 Average:5404.84 Median:5212.71 stddev:2919.97 (56.0%) stddev-sans-first:2912.83 21:48:25 INFO - PROCESS | 9323 | Values: 1422.9 1435.4 1438.9 1442.5 1444.5 7819.8 7900.6 8197.4 8259.2 8302.4 8297.9 8459.2 8497.1 8522.7 8526.7 2326.0 2379.9 2380.8 2381.1 2383.4 2298.0 2302.2 2342.1 2393.3 2396.5 2330.2 2350.3 2350.5 2353.2 2356.7 2172.2 2206.4 2213.1 2215.2 2221.4 2294.9 2299.7 2305.1 2343.2 2367.4 8251.5 8277.6 8293.4 8297.7 8340.0 5107.7 5254.8 5258.2 5265.6 5268.0 3212.8 3304.6 3320.6 3338.6 3359.5 1266.8 1293.3 1322.6 1355.2 1398.3 10861.0 11168.1 11232.4 11252.4 11300.8 4337.6 4436.7 4509.8 4518.5 4550.9 8983.6 9010.2 9035.7 9049.7 9054.3 5240.7 5264.2 5269.9 5270.8 5272.5 4770.2 4772.9 4848.7 4901.7 4928.6 3682.7 3740.9 3784.3 3867.9 3915.2 1116.3 1116.9 1133.4 1134.6 1135.2 922.8 927.3 931.2 931.9 962.5 5360.1 5500.9 5509.1 5560.2 5650.5 1018.1 1028.3 1042.2 1047.3 1057.8 3752.4 3769.6 3776.9 3834.9 3967.0 9753.3 10012.0 10038.7 10078.7 10100.2 8931.6 9189.3 9968.2 9995.0 10055.7 7697.7 7854.6 7860.6 7864.3 7870.4 5454.9 5617.9 5675.8 5682.8 5801.9 9024.7 9024.8 9033.3 9165.4 9184.1 8895.1 9108.3 9177.7 9302.3 9342.3 7124.4 7175.9 7200.6 7230.6 7309.6 7004.2 7568.4 7654.4 7744.8 7746.8 6333.3 6703.7 6892.8 6907.7 6936.0 6748.4 6773.1 6856.9 6862.8 6885.8 6153.2 6247.9 6267.4 6281.6 6295.5 4596.3 4686.6 5018.7 5102.4 5184.8 4849.8 4941.1 4962.4 5059.2 5065.8 21:48:25 INFO - PROCESS | 9323 | 21:48:25 INFO - PROCESS | 9323 | [#4] prototype.html Cycles:180 Average:4746.30 Median:5494.51 stddev:1414.49 (25.7%) stddev-sans-first:1379.67 21:48:25 INFO - PROCESS | 9323 | Values: 363.6 381.2 382.0 386.2 388.8 5427.9 5451.8 5500.3 5519.6 5525.0 5384.4 5468.5 5471.9 5478.7 5504.4 3946.5 4023.4 4048.3 4279.8 4286.5 3996.7 4034.2 4036.0 4037.8 4059.0 4024.4 4030.8 4048.7 4055.9 4070.6 4004.9 4060.4 4064.6 4066.0 4073.7 3520.8 3531.7 3532.6 3540.6 3561.5 5211.6 5223.4 5247.7 5279.2 5283.7 4713.2 4731.8 4741.2 4762.4 4767.3 5562.4 5621.6 5630.7 5657.6 5671.7 3917.9 3928.7 3929.0 3929.4 3932.4 5614.5 5781.6 5821.4 5898.0 5914.3 4113.0 4118.9 4124.7 4128.3 4148.7 4160.6 4178.3 4180.8 4182.5 4182.5 4661.8 4711.2 4781.6 4782.6 4802.8 5662.7 5685.9 5696.6 5745.1 5771.8 1389.5 1396.6 1397.4 1398.2 1399.4 912.1 961.8 967.2 969.7 977.9 5327.9 5342.9 5374.4 5382.3 5385.8 5666.0 5690.5 5713.8 5717.5 5734.4 5080.2 5372.4 5429.8 5488.7 5537.7 3013.9 3017.8 3027.8 3035.5 3069.9 5664.7 5915.9 5957.9 5959.5 5978.6 5737.8 5746.9 5770.3 5791.5 5796.8 5870.9 5933.7 5937.4 5941.8 5959.8 5542.6 5612.7 5636.5 5826.5 5864.9 5802.7 5848.9 5857.2 5879.7 5892.3 5900.2 6016.2 6048.9 6068.2 6148.4 4291.7 4353.0 4368.2 4378.3 4382.6 5724.9 5848.2 5945.9 5947.5 5965.3 5683.8 5686.8 5701.7 5716.4 5734.3 5605.4 5729.2 5742.7 5753.9 5760.6 5370.9 5592.7 5643.6 5668.8 5682.5 5756.9 5765.6 5773.2 5775.0 5782.4 5512.2 5591.7 5601.7 5616.4 5628.7 21:48:25 INFO - PROCESS | 9323 | 21:48:25 INFO - PROCESS | 9323 | [#5] yui.html Cycles:180 Average:17509.55 Median:41773.79 stddev:21900.31 (52.4%) stddev-sans-first:21925.54 21:48:25 INFO - PROCESS | 9323 | Values: 739.3 771.1 771.4 842.5 882.4 15321.0 16470.8 16483.5 16681.9 17602.7 14302.9 14508.7 16866.6 17104.8 17292.4 729.4 743.7 744.1 746.3 746.8 715.9 749.6 751.2 755.1 764.4 773.1 778.9 779.9 780.6 784.4 774.8 776.3 776.9 778.7 779.2 571.7 571.9 572.0 572.1 572.7 15423.6 15695.6 15728.1 15743.5 15759.1 14931.4 15189.5 15404.7 15447.2 15591.1 12443.3 12511.9 12526.2 12685.9 12745.2 3730.4 3798.8 3815.2 3845.9 3862.7 75217.6 75279.6 75814.0 75991.6 77082.0 11523.1 11531.9 11844.9 11900.7 11932.5 22420.2 22459.3 22502.9 22681.5 22707.1 7608.8 7694.7 7806.8 7926.5 7933.1 4419.3 4520.5 4524.9 4576.5 4646.1 3538.2 3597.0 3629.5 3673.9 3682.0 559.6 563.5 565.7 571.8 572.4 589.4 598.2 602.7 606.4 612.4 10025.4 10091.1 10333.0 10358.6 10378.1 533.3 545.0 553.7 557.6 563.6 5013.4 5125.2 5132.9 5144.7 5170.5 77414.6 79948.2 80439.6 81606.0 82602.6 67271.7 67615.7 68440.3 68915.3 69238.7 53649.0 54163.7 60426.7 61165.4 62533.0 9768.3 10648.5 10868.7 11155.9 11162.8 41456.4 41648.0 41899.6 42763.1 43131.0 51216.5 51914.7 52061.0 52997.2 54478.2 12537.7 12775.3 12776.4 12806.8 12946.6 14633.3 14740.6 14877.9 14899.5 14922.8 13775.8 13782.2 13994.3 14033.9 14053.2 13415.4 13489.9 13615.3 13719.3 13821.8 12840.4 13130.5 13205.1 13305.5 13510.7 10628.5 10716.7 10756.4 10875.3 11020.9 10972.0 11035.2 11150.6 11344.7 11361.3 21:48:25 INFO - PROCESS | 9323 | -------- Summary: end -------- 21:48:25 INFO - PROCESS | 9323 | 21:48:25 INFO - TEST-INFO | 9323: exit 0 21:48:25 INFO - TEST-OK | dromaeo_css | took 1114856ms 21:48:25 INFO - TEST-START | kraken 21:48:25 INFO - operating with platform_type : linux_ 21:48:25 INFO - Initialising browser for kraken test... 21:48:25 INFO - TEST-INFO | started process 9671 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmprzLWRq/profile http://localhost:37942/getInfo.html) 21:48:30 INFO - PROCESS | 9671 | __metrics Screen width/height:1600/1200 21:48:30 INFO - PROCESS | 9671 | colorDepth:24 21:48:30 INFO - PROCESS | 9671 | Browser inner width/height: 1024/697 21:48:30 INFO - PROCESS | 9671 | __metrics 21:48:30 INFO - PROCESS | 9671 | JavaScript error: resource://app/modules/webrtcUI.jsm, line 66: NS_ERROR_XPC_NOT_ENOUGH_ARGS: Not enough arguments [nsIMessageListenerManager.removeMessageListener] 21:48:31 ERROR - PROCESS | 9671 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3269: TypeError: this.tabs is undefined 21:48:31 INFO - TEST-INFO | 9671: exit 0 21:48:31 INFO - Browser initialized. 21:48:31 INFO - Running cycle 1/1 for kraken test... 21:48:31 INFO - TEST-INFO | started process 9792 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmprzLWRq/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 21:48:43 INFO - PROCESS | 9792 | RSS: Main: 155074560 21:48:43 INFO - PROCESS | 9792 | 21:48:46 INFO - PROCESS | 9792 | Cycle 1(1): loaded http://localhost:37942/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:37942/tests/kraken/driver.html?testName=audio-beat-detection) 21:48:47 INFO - PROCESS | 9792 | RSS: Main: 162246656 21:48:47 INFO - PROCESS | 9792 | 21:48:49 INFO - PROCESS | 9792 | Cycle 1(1): loaded http://localhost:37942/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:37942/tests/kraken/driver.html?testName=audio-dft) 21:48:50 INFO - PROCESS | 9792 | RSS: Main: 160440320 21:48:50 INFO - PROCESS | 9792 | 21:48:53 INFO - PROCESS | 9792 | Cycle 1(1): loaded http://localhost:37942/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:37942/tests/kraken/driver.html?testName=audio-fft) 21:48:53 INFO - PROCESS | 9792 | RSS: Main: 157069312 21:48:53 INFO - PROCESS | 9792 | 21:48:55 INFO - PROCESS | 9792 | Cycle 1(1): loaded http://localhost:37942/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:37942/tests/kraken/driver.html?testName=audio-oscillator) 21:48:56 INFO - PROCESS | 9792 | RSS: Main: 158687232 21:48:56 INFO - PROCESS | 9792 | 21:48:58 INFO - PROCESS | 9792 | Cycle 1(1): loaded http://localhost:37942/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:37942/tests/kraken/driver.html?testName=imaging-gaussian-blur) 21:48:59 INFO - PROCESS | 9792 | RSS: Main: 158683136 21:48:59 INFO - PROCESS | 9792 | 21:49:02 INFO - PROCESS | 9792 | Cycle 1(1): loaded http://localhost:37942/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:37942/tests/kraken/driver.html?testName=imaging-darkroom) 21:49:02 INFO - PROCESS | 9792 | RSS: Main: 163139584 21:49:02 INFO - PROCESS | 9792 | 21:49:06 INFO - PROCESS | 9792 | Cycle 1(1): loaded http://localhost:37942/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:37942/tests/kraken/driver.html?testName=imaging-desaturate) 21:49:07 INFO - PROCESS | 9792 | RSS: Main: 162967552 21:49:07 INFO - PROCESS | 9792 | 21:49:09 INFO - PROCESS | 9792 | Cycle 1(1): loaded http://localhost:37942/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:37942/tests/kraken/driver.html?testName=json-parse-financial) 21:49:10 INFO - PROCESS | 9792 | RSS: Main: 162684928 21:49:10 INFO - PROCESS | 9792 | 21:49:12 INFO - PROCESS | 9792 | Cycle 1(1): loaded http://localhost:37942/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:37942/tests/kraken/driver.html?testName=json-stringify-tinderbox) 21:49:12 INFO - PROCESS | 9792 | RSS: Main: 162041856 21:49:12 INFO - PROCESS | 9792 | 21:49:14 INFO - PROCESS | 9792 | Cycle 1(1): loaded http://localhost:37942/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:37942/tests/kraken/driver.html?testName=stanford-crypto-aes) 21:49:15 INFO - PROCESS | 9792 | RSS: Main: 162365440 21:49:15 INFO - PROCESS | 9792 | 21:49:17 INFO - PROCESS | 9792 | Cycle 1(1): loaded http://localhost:37942/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:37942/tests/kraken/driver.html?testName=stanford-crypto-ccm) 21:49:18 INFO - PROCESS | 9792 | RSS: Main: 162144256 21:49:18 INFO - PROCESS | 9792 | 21:49:20 INFO - PROCESS | 9792 | Cycle 1(1): loaded http://localhost:37942/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:37942/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 21:49:21 INFO - PROCESS | 9792 | RSS: Main: 162299904 21:49:21 INFO - PROCESS | 9792 | 21:49:24 INFO - PROCESS | 9792 | Cycle 1(1): loaded http://localhost:37942/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:37942/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 21:49:24 INFO - PROCESS | 9792 | RSS: Main: 162418688 21:49:24 INFO - PROCESS | 9792 | 21:49:26 INFO - PROCESS | 9792 | Cycle 1(1): loaded http://localhost:37942/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:37942/tests/kraken/driver.html?testName=ai-astar) 21:49:26 INFO - PROCESS | 9792 | RSS: Main: 164225024 21:49:26 INFO - PROCESS | 9792 | 21:49:26 INFO - PROCESS | 9792 | __start_tp_report 21:49:26 INFO - PROCESS | 9792 | _x_x_mozilla_page_load 21:49:26 INFO - PROCESS | 9792 | _x_x_mozilla_page_load_details 21:49:26 INFO - PROCESS | 9792 | |i|pagename|runs| 21:49:26 INFO - PROCESS | 9792 | |0;ai-astar;106;111;113;111;112;113;114;113;113;111 21:49:26 INFO - PROCESS | 9792 | |1;audio-beat-detection;145;121;122;171;123;121;120;120;138;121 21:49:26 INFO - PROCESS | 9792 | |2;audio-dft;162;163;163;162;162;162;170;163;161;161 21:49:26 INFO - PROCESS | 9792 | |3;audio-fft;75;76;75;93;76;75;76;76;95;76 21:49:26 INFO - PROCESS | 9792 | |4;audio-oscillator;83;82;110;84;83;84;100;85;83;107 21:49:26 INFO - PROCESS | 9792 | |5;imaging-gaussian-blur;117;117;118;118;118;117;120;118;118;121 21:49:26 INFO - PROCESS | 9792 | |6;imaging-darkroom;149;149;148;148;149;150;148;148;149;149 21:49:26 INFO - PROCESS | 9792 | |7;imaging-desaturate;97;96;95;97;96;96;97;97;96;96 21:49:26 INFO - PROCESS | 9792 | |8;json-parse-financial;57;58;60;58;58;58;58;62;61;58 21:49:26 INFO - PROCESS | 9792 | |9;json-stringify-tinderbox;67;68;71;68;67;67;69;74;69;67 21:49:26 INFO - PROCESS | 9792 | |10;stanford-crypto-aes;83;86;86;83;82;83;86;92;89;91 21:49:26 INFO - PROCESS | 9792 | |11;stanford-crypto-ccm;130;136;131;129;138;135;129;134;172;136 21:49:26 INFO - PROCESS | 9792 | |12;stanford-crypto-pbkdf2;174;171;178;169;169;168;177;174;171;172 21:49:26 INFO - PROCESS | 9792 | |13;stanford-crypto-sha256-iterative;64;66;65;67;64;62;63;63;63;64 21:49:26 INFO - PROCESS | 9792 | __end_tp_report 21:49:26 INFO - PROCESS | 9792 | __start_cc_report 21:49:26 INFO - PROCESS | 9792 | _x_x_mozilla_cycle_collect,705 21:49:26 INFO - PROCESS | 9792 | __end_cc_report 21:49:26 INFO - PROCESS | 9792 | __startTimestamp1485064166880__endTimestamp 21:49:26 INFO - PROCESS | 9792 | 21:49:26 INFO - PROCESS | 9792 | ------- Summary: start ------- 21:49:26 INFO - PROCESS | 9792 | Number of tests: 14 21:49:26 INFO - PROCESS | 9792 | 21:49:26 INFO - PROCESS | 9792 | [#0] ai-astar Cycles:10 Average:111.70 Median:113.00 stddev:2.26 (2.0%) stddev-sans-first:1.12 21:49:26 INFO - PROCESS | 9792 | Values: 106.0 111.0 113.0 111.0 112.0 113.0 114.0 113.0 113.0 111.0 21:49:26 INFO - PROCESS | 9792 | 21:49:26 INFO - PROCESS | 9792 | [#1] audio-beat-detection Cycles:10 Average:130.20 Median:122.50 stddev:16.75 (13.7%) stddev-sans-first:16.89 21:49:26 INFO - PROCESS | 9792 | Values: 145.0 121.0 122.0 171.0 123.0 121.0 120.0 120.0 138.0 121.0 21:49:26 INFO - PROCESS | 9792 | 21:49:26 INFO - PROCESS | 9792 | [#2] audio-dft Cycles:10 Average:162.90 Median:162.50 stddev:2.60 (1.6%) stddev-sans-first:2.74 21:49:26 INFO - PROCESS | 9792 | Values: 162.0 163.0 163.0 162.0 162.0 162.0 170.0 163.0 161.0 161.0 21:49:26 INFO - PROCESS | 9792 | 21:49:26 INFO - PROCESS | 9792 | [#3] audio-fft Cycles:10 Average:79.30 Median:76.00 stddev:7.78 (10.2%) stddev-sans-first:8.09 21:49:26 INFO - PROCESS | 9792 | Values: 75.0 76.0 75.0 93.0 76.0 75.0 76.0 76.0 95.0 76.0 21:49:26 INFO - PROCESS | 9792 | 21:49:26 INFO - PROCESS | 9792 | [#4] audio-oscillator Cycles:10 Average:90.10 Median:83.00 stddev:11.04 (13.3%) stddev-sans-first:11.41 21:49:26 INFO - PROCESS | 9792 | Values: 83.0 82.0 110.0 84.0 83.0 84.0 100.0 85.0 83.0 107.0 21:49:26 INFO - PROCESS | 9792 | 21:49:26 INFO - PROCESS | 9792 | [#5] imaging-gaussian-blur Cycles:10 Average:118.20 Median:118.00 stddev:1.32 (1.1%) stddev-sans-first:1.32 21:49:26 INFO - PROCESS | 9792 | Values: 117.0 117.0 118.0 118.0 118.0 117.0 120.0 118.0 118.0 121.0 21:49:26 INFO - PROCESS | 9792 | 21:49:26 INFO - PROCESS | 9792 | [#6] imaging-darkroom Cycles:10 Average:148.70 Median:149.00 stddev:0.67 (0.5%) stddev-sans-first:0.71 21:49:26 INFO - PROCESS | 9792 | Values: 149.0 149.0 148.0 148.0 149.0 150.0 148.0 148.0 149.0 149.0 21:49:26 INFO - PROCESS | 9792 | 21:49:26 INFO - PROCESS | 9792 | [#7] imaging-desaturate Cycles:10 Average:96.30 Median:96.50 stddev:0.67 (0.7%) stddev-sans-first:0.67 21:49:26 INFO - PROCESS | 9792 | Values: 97.0 96.0 95.0 97.0 96.0 96.0 97.0 97.0 96.0 96.0 21:49:26 INFO - PROCESS | 9792 | 21:49:26 INFO - PROCESS | 9792 | [#8] json-parse-financial Cycles:10 Average:58.80 Median:58.00 stddev:1.62 (2.8%) stddev-sans-first:1.58 21:49:26 INFO - PROCESS | 9792 | Values: 57.0 58.0 60.0 58.0 58.0 58.0 58.0 62.0 61.0 58.0 21:49:26 INFO - PROCESS | 9792 | 21:49:26 INFO - PROCESS | 9792 | [#9] json-stringify-tinderbox Cycles:10 Average:68.70 Median:68.50 stddev:2.26 (3.3%) stddev-sans-first:2.32 21:49:26 INFO - PROCESS | 9792 | Values: 67.0 68.0 71.0 68.0 67.0 67.0 69.0 74.0 69.0 67.0 21:49:26 INFO - PROCESS | 9792 | 21:49:26 INFO - PROCESS | 9792 | [#10] stanford-crypto-aes Cycles:10 Average:86.10 Median:86.00 stddev:3.54 (4.1%) stddev-sans-first:3.57 21:49:26 INFO - PROCESS | 9792 | Values: 83.0 86.0 86.0 83.0 82.0 83.0 86.0 92.0 89.0 91.0 21:49:26 INFO - PROCESS | 9792 | 21:49:26 INFO - PROCESS | 9792 | [#11] stanford-crypto-ccm Cycles:10 Average:137.00 Median:135.50 stddev:12.71 (9.4%) stddev-sans-first:13.23 21:49:26 INFO - PROCESS | 9792 | Values: 130.0 136.0 131.0 129.0 138.0 135.0 129.0 134.0 172.0 136.0 21:49:26 INFO - PROCESS | 9792 | 21:49:26 INFO - PROCESS | 9792 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:172.30 Median:173.00 stddev:3.40 (2.0%) stddev-sans-first:3.55 21:49:26 INFO - PROCESS | 9792 | Values: 174.0 171.0 178.0 169.0 169.0 168.0 177.0 174.0 171.0 172.0 21:49:26 INFO - PROCESS | 9792 | 21:49:26 INFO - PROCESS | 9792 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.10 Median:64.00 stddev:1.52 (2.4%) stddev-sans-first:1.62 21:49:26 INFO - PROCESS | 9792 | Values: 64.0 66.0 65.0 67.0 64.0 62.0 63.0 63.0 63.0 64.0 21:49:26 INFO - PROCESS | 9792 | -------- Summary: end -------- 21:49:26 INFO - PROCESS | 9792 | 21:49:27 INFO - TEST-INFO | 9792: exit 0 21:49:27 INFO - TEST-OK | kraken | took 62116ms 21:49:27 INFO - SUITE-END | took 1176s 21:49:28 INFO - Completed test suite (00:19:37) 21:49:28 INFO - javascript benchmark 21:49:28 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7250.198023654945, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3202.759793015524, 3206.711395974362, 3218.565493658357, 3230.4992726127457, 3242.789218700784, 5228.686278823264, 5364.114921038029, 5409.296791417115, 5420.214068959998, 5427.782888684458, 5309.389420216667, 5311.336082989626, 5368.677879327243, 5387.19192121182, 5441.455854414557, 4697.06058788242, 4788.569028787409, 4791.784369703371, 4818.879528011793, 4890.046440944017, 4521.095780843828, 4854.247591623286, 4900.289458028584, 4900.754962251891, 4921.975390123062, 4691.695039822401, 4727.290906364038, 4755.191617425046, 4859.73271470069, 4866.732329721882, 4672.953270467286, 4725.834595789131, 4730.101280756645, 4771.6898401603785, 4797.808087676489, 4678.111158879802, 4698.953010469886, 4717.905641887143, 4719.551642593948, 4757.119932812441, 5294.841154765363, 5304.389995150568, 5319.9202011969855, 5328.413874473805, 5340.385855626614, 5765.048766953448, 5816.272965879265, 5844.0, 5848.093545500455, 5898.528117750612, 5894.233749612566, 5899.174115623773, 5915.231019967419, 5923.318818335903, 5945.8810823783715, 5364.6512976656395, 5519.116941289455, 5529.336479622471, 5531.806386776443, 5536.778528858841, 5902.852428689317, 5999.130126131687, 6026.758929642765, 6041.577089603774, 6078.756849725962, 5746.88506229873, 5769.0, 5787.594868359174, 5791.102379131242, 5796.3913789052385, 5733.971330143323, 5863.179154918314, 5888.646681199141, 5899.528037756969, 5907.0, 5737.196792449061, 5742.7415766290615, 5764.13537969308, 5780.306363236438, 5887.0580707086665, 5843.474087332161, 5854.648721076749, 5858.355580886099, 5863.091220860773, 5867.911981320283, 4567.497575266718, 4570.81716731327, 4572.862814115582, 4575.496695363508, 4612.331211974245, 3977.2840888639744, 4008.9198216035516, 4029.6171863672903, 4070.776107314126, 4081.4898137732785, 5592.3009623797025, 5605.691686957257, 5618.775248990077, 5622.775088996476, 5667.291588551431, 5881.32990802347, 5926.407359264039, 5938.762449502058, 5947.1376650385455, 5953.613015154001, 5312.893742125136, 5410.026195284808, 5520.66875987442, 5561.972190139023, 5618.887622247532, 5120.155174396257, 5126.820831208768, 5134.152864777345, 5151.665141765773, 5171.405288391883, 6158.322584515699, 6229.719662615194, 6243.7814676486105, 6247.2815626202655, 6249.062640603855, 5727.5417966561745, 5736.6558006519745, 5759.740811663569, 5945.583809133492, 5962.940370596239, 5976.551758618208, 6033.758649653964, 6064.120702498201, 6108.75564977396, 6114.113453549299, 5697.088465845445, 5743.942560574341, 5750.482456578928, 5755.050416681368, 5757.856053598526, 5707.486326230659, 5765.308163020464, 5766.4233576642, 5834.066549352084, 5840.94159058404, 5592.245046918614, 5605.691686957257, 5617.269754931833, 5679.403662615366, 5726.914096288642, 5669.234653321749, 5679.74441150141, 5680.68756218412, 5683.5453163747625, 5686.744096515749, 5454.618176727591, 5494.36814766291, 5551.861868317066, 5647.29408823897, 5669.603127781016, 5603.971980140073, 5650.124230744241, 5666.943330566642, 5745.425457454221, 5753.1370294456165, 5508.366537848199, 5528.7235638218735, 5529.557635389078, 5538.861528461821, 5555.8888822224135], "value": 5356.697736254675, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [553.2061491759325, 573.936866944636, 579.8202557207264, 590.3329237961103, 607.5989846701178, 39396.21207575847, 43596.12807743843, 43636.0, 43650.34524482127, 43856.0, 44281.557184428224, 44652.77673611636, 44966.0, 44980.55019449804, 45243.54756452434, 8910.064443233465, 9104.226140778042, 9112.088791120868, 10429.947850260776, 10772.892271077268, 10556.630517931873, 10687.412192329419, 10729.08802751767, 10731.409772462512, 10750.78498430031, 10651.680449586525, 10781.137508999262, 10817.134629229682, 10832.241743077988, 10837.241393102486, 10706.625268115618, 10734.087602553793, 10753.408562529057, 10791.298565593212, 10837.295575787548, 10632.362058276529, 10691.198160138021, 10743.194260430499, 10760.569577216902, 10775.6228532001, 40236.19527609461, 40263.0, 40467.39298910519, 40558.797206014075, 40607.7969610153, 4120.568864370036, 4143.958560414388, 4203.222403855266, 4231.280682284019, 4246.617804397619, 29949.101526954226, 29969.70030299691, 30819.0, 31249.687503125133, 31292.843535782402, 4153.958460415418, 4337.175936572041, 4350.782460876943, 4374.912501749947, 4383.7150585212175, 334834.99999999756, 334928.0, 335014.64985350077, 335810.0, 336549.0, 55127.0, 55917.44082559122, 56019.15971260434, 56209.71895140498, 56519.0, 58223.12665310024, 58385.0, 58452.0, 58656.70671646614, 58927.116093258635, 15097.773533397009, 15404.229788510755, 15410.152441615595, 15448.304826282843, 15482.0, 11568.76862462746, 11957.162998590189, 11974.940125299318, 12185.268883866996, 12204.755904881853, 17686.823131768775, 17892.373766918095, 17989.280428782702, 18031.72952405715, 18132.63734725298, 6966.442684585221, 6974.476914231453, 7182.604956727326, 7265.200827908926, 7312.1956584775635, 934.3039435620507, 937.9999999999864, 942.6229508196776, 958.4201558057414, 979.1677074486772, 30689.232769180504, 30926.69073309283, 31625.0, 31861.362772744415, 32271.0, 1118.7930232906776, 1119.6025410979148, 1144.5250221158126, 1149.2472430557998, 1150.6375491720248, 15931.80189505532, 16467.752983705253, 16865.747013794804, 17104.572385690208, 17154.828451715322, 495305.0, 499503.0, 499702.0, 500805.0, 501344.0, 64768.0, 65453.67273163699, 65684.0, 65734.0, 65781.34218657848, 1396.2599822094305, 1410.2384712255268, 1414.1868425655289, 1418.6524301546187, 1438.719449707318, 29739.0, 30278.103609556612, 31216.21959451032, 31416.842915785273, 32088.518672219467, 53036.204456932406, 54882.0, 55022.44977550173, 55109.448905510435, 55109.724451377486, 420871.0, 422864.0, 423248.0, 424550.0, 425346.0, 27538.449231015667, 28580.571291430228, 28586.85706571454, 28672.569911450926, 28677.13968580946, 48125.0, 48422.5157748418, 48883.75558122186, 48952.0, 49464.50535494599, 39375.80312098421, 39931.2013759729, 40414.59585404109, 41181.0, 42140.157196856504, 40339.1932161361, 40485.0, 41901.371479427224, 42225.78887105668, 42319.3652095225, 40570.565766052954, 40634.39048414217, 40677.389839151845, 41313.0, 41637.167256654095, 33953.49069764005, 35941.82029089838, 36034.94007139631, 36207.275854482235, 36355.45466818053, 27239.31901702394, 27331.0, 27477.72522274752, 27488.862555687094, 27502.862485687445], "value": 20428.223924244867, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [375.98872033838995, 385.1814893351628, 428.66564080017577, 435.7342021366966, 442.3011641606261, 18769.343072992448, 20618.89690551547, 20631.484212894684, 21572.244971426004, 22538.43653908653, 21408.785912140913, 21994.560108797814, 22232.8888355558, 22498.55002899941, 22675.659865101996, 6143.723532441039, 6417.358264173568, 6431.6784160792, 6435.163428754278, 6443.677816109176, 6140.324564297946, 6238.313785483616, 6274.309825919146, 6312.053192021188, 6321.715522801485, 6302.810915672537, 6306.527010474209, 6310.495160387181, 6313.463355614778, 6324.841878953017, 6083.665398403086, 6340.0, 6358.586691865037, 6378.93621063788, 6380.425761681425, 5262.8684282892855, 5479.808206712786, 6007.669578173199, 6023.397660233985, 6027.457528822427, 14738.11571305725, 14880.479183228535, 14983.925080374529, 15351.923240383838, 25033.374165645822, 2598.649182360395, 2662.4142688608476, 2680.2763253921526, 2725.9454810903867, 3030.7423868970945, 10472.424016679079, 10521.579136834594, 10687.893121068768, 11060.115190784718, 11120.721981950435, 1879.962400751991, 1912.7035309527046, 1960.2061165228106, 1961.6174845905055, 1963.518937860219, 90934.5453272736, 91105.0, 91165.99999999933, 92207.0, 92462.0, 11828.40857957116, 11900.583479578174, 11957.130288730816, 12110.0, 12902.870971290355, 16743.665126697397, 16868.0, 16939.49181524556, 16951.830481695026, 16976.151192440328, 7787.493812902257, 7965.6017199139815, 8030.638621262057, 8160.3471722262075, 8190.467619604707, 7287.672054757549, 7391.482596218213, 7525.0, 7600.695972161052, 7607.0, 5014.373203349582, 5079.314292570456, 5116.948830511647, 5147.433782283946, 5312.867178320495, 2091.351680978901, 2133.98933005334, 2170.2295685031904, 2201.3395981205895, 2218.5895609312006, 1063.7393838509615, 1068.156156636264, 1072.790805792863, 1115.1636272795404, 1122.663201039701, 20321.593568128555, 20394.184232630825, 20643.58712825735, 20649.483762906046, 20685.89657051735, 1079.3739631013993, 1084.3331351218944, 1097.067492631273, 1103.713034610991, 1121.394446998628, 10410.0, 11484.25352352111, 11486.885131148749, 11530.135239857043, 11597.536098556133, 544671.0, 581808.0, 627296.0, 631652.0, 642668.0, 99699.0, 102336.0, 104363.0, 104706.0, 106917.46541267243, 1008.6721815410021, 1030.8814486334168, 1047.2407504559285, 1052.984205236922, 1061.7345663584103, 17229.0, 17284.135793210542, 17586.38447654326, 18390.81609183891, 18439.446816595522, 41211.793941030104, 42776.35835462533, 47480.762596186796, 47537.52462475331, 48025.519744802106, 59480.0, 61260.0, 61822.0, 61848.381516184265, 62506.37493625005, 7900.367970562226, 7963.0, 8218.096009438837, 8660.0, 9231.676891308773, 8384.119667435076, 12903.225806451643, 13105.27920964356, 13429.0, 14252.786208207093, 11353.772924541629, 12192.268463892195, 12375.195612285173, 12462.0, 12473.812892806796, 12140.878591213976, 12366.62900112998, 12384.071194660617, 12386.876131238572, 12701.031340142294, 12527.248365098123, 12627.87372126267, 12646.0, 12737.363131843556, 12786.808197876853, 9128.863067054132, 9231.169194772503, 9304.860427093734, 9316.767080823034, 9468.479233642216, 11738.823917641072, 12346.81479777786, 12556.497740090294, 12612.684682883002, 13009.633988431457], "value": 9775.383388362421, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1422.9217393043384, 1435.3684378873295, 1438.8992770506068, 1442.4662874736337, 1444.4511085787399, 7819.843603127941, 7900.565468899208, 8197.385196110294, 8259.21537453941, 8302.377321700866, 8297.875531867026, 8459.196376344238, 8497.107803680618, 8522.74431767048, 8526.70156544521, 2326.0463210083867, 2379.940501487468, 2380.7619238076227, 2381.071382160959, 2383.4041489627593, 2297.9885100574475, 2302.2057390200353, 2342.121704360865, 2393.3298676370555, 2396.496735685508, 2330.242671131889, 2350.2831636350907, 2350.459394339303, 2353.1999120299097, 2356.728976167737, 2172.196287373666, 2206.4483879030245, 2213.0815711479718, 2215.2468160825315, 2221.44463884029, 2294.8967296471533, 2299.724033116037, 2305.0779688124717, 2343.1798870395396, 2367.419982104378, 8251.504909705376, 8277.586120694, 8293.377996650275, 8297.709580164727, 8340.040895296997, 5107.744612769384, 5254.842354729364, 5258.1849813279005, 5265.605079619006, 5267.999080174754, 3212.8072315661134, 3304.6364899860996, 3320.5849268841393, 3338.582677165354, 3359.5128706337446, 1266.803645434959, 1293.2693028438903, 1322.5701646964776, 1355.1868878672817, 1398.2798858587835, 10861.0, 11168.106551475781, 11232.438378081064, 11252.43737813106, 11300.773984520263, 4337.631301339358, 4436.689431739747, 4509.819607215741, 4518.525554816697, 4550.883839014874, 8983.55082245885, 9010.189082982562, 9035.683751068813, 9049.728508144766, 9054.275657947348, 5240.659357141773, 5264.184051472028, 5269.920951185735, 5270.841874743764, 5272.472752724773, 4770.165221086296, 4772.85767743545, 4848.7090774553635, 4901.705897646153, 4928.605711543068, 3682.705383569308, 3740.9438858417147, 3784.262068896594, 3867.864624738177, 3915.2169566086895, 1116.2521110855585, 1116.8771435142128, 1133.3823066428815, 1134.5688638317386, 1135.239389608964, 922.7739203895088, 927.2767241551601, 931.1573026411108, 931.8695382646434, 962.4802606592361, 5360.088784906575, 5500.862478438071, 5509.146082357241, 5560.221568980346, 5650.519705824969, 1018.0837246478081, 1028.311031608824, 1042.2131290875493, 1047.2878442658912, 1057.7831544533353, 3752.399616061417, 3769.5853456119803, 3776.8866933992026, 3834.9424758628643, 3967.0082479380153, 9753.317267791328, 10012.0, 10038.698839034842, 10078.748031299276, 10100.242481813893, 8931.642734290686, 9189.264858811279, 9968.152707019839, 9995.0, 10055.69832905014, 7697.653605587762, 7854.567998760123, 7860.646270917822, 7864.2922137007945, 7870.370370370357, 5454.945450545444, 5617.915731264116, 5675.801346952837, 5682.77268909239, 5801.94198058014, 9024.684136055206, 9024.819503610022, 9033.322500812334, 9165.358424910191, 9184.12750788674, 8895.066018068268, 9108.271338292789, 9177.724668259963, 9302.302327325342, 9342.346035777431, 7124.3944264736, 7175.928240717735, 7200.639968001684, 7230.6384680764695, 7309.561426314438, 7004.229534751072, 7568.3945284378215, 7654.425918056279, 7744.8451030980195, 7746.767596972099, 6333.303336633059, 6703.731850725916, 6892.827679308058, 6907.723691052302, 6936.0, 6748.392644662004, 6773.119494465885, 6856.862862742618, 6862.828429289308, 6885.793426197222, 6153.169322141453, 6247.875042499034, 6267.373262673696, 6281.623102613858, 6295.464885484785, 4596.333531637961, 4686.554777296152, 5018.723970181675, 5102.443754654866, 5184.766685499086, 4849.830255941025, 4941.085899108676, 4962.429320628174, 5059.241113832807, 5065.772040258271], "value": 4419.982449699823, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [363.578249230892, 381.15193694030773, 381.97326187166874, 386.17166178547006, 388.84640566976026, 5427.878969592481, 5451.754671039803, 5500.312460942382, 5519.6412233204865, 5524.972375138123, 5384.40771515134, 5468.535174510172, 5471.945280547194, 5478.726063696819, 5504.4495550444935, 3946.4806049670797, 4023.3763766616075, 4048.3078752629613, 4279.807408666602, 4286.485621725397, 3996.740211886233, 4034.152827906143, 4035.961839271164, 4037.7577345359227, 4059.025833799896, 4024.396340548926, 4030.8387664493384, 4048.696347773914, 4055.918881622366, 4070.5929407059207, 4004.899877503057, 4060.390941358805, 4064.6138616831354, 4065.9796701016603, 4073.735207211522, 3520.7887526748477, 3531.6644918732677, 3532.5584301962253, 3540.6459354064646, 3561.4835848802036, 5211.618920985942, 5223.399309079428, 5247.711375874325, 5279.208118782213, 5283.656562323436, 4713.208980587389, 4731.787069581877, 4741.241401375763, 4762.357081793948, 4767.284907263904, 5562.443755624446, 5621.550275977953, 5630.690312032836, 5657.632253903483, 5671.6880571568545, 3917.8628747993685, 3928.705347098979, 3928.9803550982347, 3929.4105884117325, 3932.351162058257, 5614.529606972919, 5781.5952883298605, 5821.388754180834, 5898.0, 5914.2902851657645, 4112.979435102865, 4118.91762164755, 4124.690648201336, 4128.298189307765, 4148.651688201347, 4160.625543701021, 4178.310578754532, 4180.832766689359, 4182.452492577705, 4182.456280683553, 4661.766911654404, 4711.175544279738, 4781.613332133712, 4782.6173906088125, 4802.823308289491, 5662.716864156776, 5685.886282274331, 5696.629719068247, 5745.122042621214, 5771.767810026315, 1389.5136702154166, 1396.615930619088, 1397.3921344215298, 1398.189050350794, 1399.4052527675901, 912.0605776050678, 961.8364877970622, 967.2020583018897, 969.680005598151, 977.8900947424582, 5327.866803329948, 5342.946570534323, 5374.381946076252, 5382.327209098863, 5385.838424847261, 5666.0, 5690.5163061140265, 5713.771449142071, 5717.485426311652, 5734.369219385864, 5080.187170052774, 5372.355317361941, 5429.809956651498, 5488.69812160335, 5537.723113844291, 3013.8794448222266, 3017.788754787188, 3027.7729170312314, 3035.468792961223, 3069.8618562164756, 5664.716764161775, 5915.911261331084, 5957.940420595825, 5959.46722642875, 5978.611390259619, 5737.827865164052, 5746.913796293059, 5770.336411312669, 5791.507721843691, 5796.840631873642, 5870.853228669317, 5933.736444955257, 5937.376575459601, 5941.821745347646, 5959.791407300723, 5542.612017158922, 5612.663240205601, 5636.464535869086, 5826.533877289722, 5864.912026319524, 5802.709864506842, 5848.912266315923, 5857.150713146485, 5879.676617786063, 5892.2929248488745, 5900.232969713909, 6016.2479690038745, 6048.909266361096, 6068.241469816273, 6148.354422785543, 4291.699581029423, 4352.978235108804, 4368.235558777138, 4378.277584198571, 4382.627476664392, 5724.856878578069, 5848.181254624441, 5945.878413832773, 5947.494462970523, 5965.313988891333, 5683.8010669626365, 5686.77252909879, 5701.657900525982, 5716.371199168171, 5734.254546908875, 5605.439456054362, 5729.197912292199, 5742.741576628978, 5753.8561535961935, 5760.6255593386295, 5370.919436208382, 5592.692401917933, 5643.604947653625, 5668.801591944262, 5682.545396368363, 5756.913646295393, 5765.56758243125, 5773.16289138081, 5774.989376859117, 5782.421757824184, 5512.173174023768, 5591.748371323219, 5601.663900166003, 5616.438356164351, 5628.690422026828], "value": 4306.256216207504, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [739.3161325773658, 771.0986669309676, 771.3559178086298, 842.469244376043, 882.4087861133042, 15321.0, 16470.752938705915, 16483.50549483516, 16681.916590417062, 17602.735958960595, 14302.856971430283, 14508.709825803478, 16866.578335541617, 17104.82895171048, 17292.394766183184, 729.4310437858479, 743.6727839750492, 744.13680131048, 746.3320328306163, 746.7759672098376, 715.8711431942248, 749.5615065186872, 751.2449987762319, 755.1089714137344, 764.4190415284396, 773.1418125880268, 778.9260020298062, 779.9181085985975, 780.6096951524238, 784.3764207455058, 774.8062984253909, 776.2547953964173, 776.9456138070337, 778.696308439709, 779.154617240295, 571.6684323092596, 571.8598943258886, 572.0475408444934, 572.1046562130252, 572.6993328502527, 15423.614409639737, 15695.607609809733, 15728.134952577604, 15743.527694169194, 15759.054456732632, 14931.40274389034, 15189.544313670607, 15404.691906161926, 15447.227638618137, 15591.1424871632, 12443.315617641027, 12511.874881251162, 12526.185797923106, 12685.873141268561, 12745.17156384832, 3730.4031354983344, 3798.810059497014, 3815.2178803345246, 3845.9230815383535, 3862.6523612874976, 75217.62391188009, 75279.6236018822, 75814.0, 75991.6200419, 77082.0, 11523.135764817673, 11531.88468115325, 11844.940775296069, 11900.702482437835, 11932.463039163258, 22420.215292464687, 22459.32622021342, 22502.887485562467, 22681.546369072857, 22707.09171633149, 7608.804302193093, 7694.692212311445, 7806.804829879298, 7926.48477848938, 7933.087694915043, 4419.315006174048, 4520.4575450946095, 4524.932126018112, 4576.519465456146, 4646.140464014168, 3538.239278555123, 3596.9820150899077, 3629.528161339009, 3673.8897833065053, 3682.04266890605, 559.5663360895338, 563.5097465205298, 565.7199686155298, 571.794154104522, 572.3503823160743, 589.4400319696306, 598.2014011294883, 602.6594973839855, 606.3542327421283, 612.4360187694842, 10025.398476091457, 10091.142252908438, 10333.018363255478, 10358.585656573652, 10378.117859981987, 533.3386204572013, 544.9536789372869, 553.7369749369097, 557.631962904481, 563.5773170122408, 5013.373328333958, 5125.231215317732, 5132.871678208075, 5144.742762861842, 5170.508801663836, 77414.612926935, 79948.20051799408, 80439.59780201061, 81606.0, 82602.58698706469, 67271.66364168147, 67615.66192169007, 68440.31559684439, 68915.3108468919, 69238.65380673064, 53649.0, 54163.72918135384, 60426.69786651126, 61165.38834611686, 62533.0, 9768.3112106188, 10648.467576621293, 10868.67393978182, 11155.888441115485, 11162.776744464903, 41456.37815432831, 41648.0, 41899.58100418957, 42763.14473710571, 43131.0, 51216.487835121174, 51914.74042629914, 52061.0, 52997.20504192363, 54478.18282725683, 12537.749245014866, 12775.297358645365, 12776.383470417437, 12806.807897881354, 12946.611601651966, 14633.34149963233, 14740.631484212552, 14877.925610372311, 14899.47851825181, 14922.776158357416, 13775.793363099761, 13782.173069615856, 13994.300284985913, 14033.929830350782, 14053.156810591398, 13415.396307166397, 13489.932550337579, 13615.25116118623, 13719.314034298444, 13821.792673110112, 12840.357982100672, 13130.474781009034, 13205.075644704779, 13305.46778128864, 13510.729785404434, 10628.468576571295, 10716.73208169802, 10756.408397538211, 10875.347479151276, 11020.944895275472, 10972.0, 11035.172362072715, 11150.553977840795, 11344.716382090513, 11361.318320900773], "value": 7132.962036556733, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1524.3999999999996, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [106.0, 111.0, 113.0, 111.0, 112.0, 113.0, 114.0, 113.0, 113.0, 111.0], "value": 111.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 121.0, 122.0, 171.0, 123.0, 121.0, 120.0, 120.0, 138.0, 121.0], "value": 130.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 163.0, 163.0, 162.0, 162.0, 162.0, 170.0, 163.0, 161.0, 161.0], "value": 162.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 75.0, 93.0, 76.0, 75.0, 76.0, 76.0, 95.0, 76.0], "value": 79.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 82.0, 110.0, 84.0, 83.0, 84.0, 100.0, 85.0, 83.0, 107.0], "value": 90.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 118.0, 118.0, 118.0, 117.0, 120.0, 118.0, 118.0, 121.0], "value": 118.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 149.0, 148.0, 148.0, 149.0, 150.0, 148.0, 148.0, 149.0, 149.0], "value": 148.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [97.0, 96.0, 95.0, 97.0, 96.0, 96.0, 97.0, 97.0, 96.0, 96.0], "value": 96.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 58.0, 60.0, 58.0, 58.0, 58.0, 58.0, 62.0, 61.0, 58.0], "value": 58.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 68.0, 71.0, 68.0, 67.0, 67.0, 69.0, 74.0, 69.0, 67.0], "value": 68.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 86.0, 86.0, 83.0, 82.0, 83.0, 86.0, 92.0, 89.0, 91.0], "value": 86.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [130.0, 136.0, 131.0, 129.0, 138.0, 135.0, 129.0, 134.0, 172.0, 136.0], "value": 137.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [174.0, 171.0, 178.0, 169.0, 169.0, 168.0, 177.0, 174.0, 171.0, 172.0], "value": 172.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 66.0, 65.0, 67.0, 64.0, 62.0, 63.0, 63.0, 63.0, 64.0], "value": 64.1, "unit": "score"}]}]} 21:49:28 INFO - Return code: 0 21:49:28 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 21:49:28 ERROR - # TBPL SUCCESS # 21:49:28 INFO - Running post-action listener: _resource_record_post_action 21:49:28 INFO - [mozharness: 2017-01-22 05:49:28.177325Z] Finished run-tests step (success) 21:49:28 INFO - Running post-run listener: _resource_record_post_run 21:49:28 INFO - Total resource usage - Wall time: 1195s; CPU: 13.0%; Read bytes: 352256; Write bytes: 411660288; Read time: 152; Write time: 328548 21:49:28 INFO - TinderboxPrint: CPU usage
13.4% 21:49:28 INFO - TinderboxPrint: I/O read bytes / time
352,256 / 152 21:49:28 INFO - TinderboxPrint: I/O write bytes / time
411,660,288 / 328,548 21:49:28 INFO - TinderboxPrint: CPU idle
8,257.8 (86.6%) 21:49:28 INFO - TinderboxPrint: CPU user
1,216.1 (12.8%) 21:49:28 INFO - TinderboxPrint: Swap in / out
0 / 0 21:49:28 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 105766912; Read time: 0; Write time: 113164 21:49:28 INFO - run-tests - Wall time: 1177s; CPU: 13.0%; Read bytes: 352256; Write bytes: 294375424; Read time: 152; Write time: 213240 21:49:28 INFO - Running post-run listener: _upload_blobber_files 21:49:28 INFO - Blob upload gear active. 21:49:28 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 21:49:28 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 21:49:28 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', 'Graphics', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 21:49:28 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 Graphics -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 21:49:29 INFO - (blobuploader) - INFO - Open directory for files ... 21:49:29 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 21:49:29 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:49:29 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:49:33 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 21:49:33 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:49:33 INFO - (blobuploader) - INFO - Done attempting. 21:49:33 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 21:49:33 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:49:33 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:49:34 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 21:49:34 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:49:34 INFO - (blobuploader) - INFO - Done attempting. 21:49:34 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 21:49:34 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:49:34 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:49:34 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 21:49:34 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:49:34 INFO - (blobuploader) - INFO - Done attempting. 21:49:34 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 21:49:34 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:49:34 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:49:35 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 21:49:35 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:49:35 INFO - (blobuploader) - INFO - Done attempting. 21:49:35 INFO - (blobuploader) - INFO - Iteration through files over. 21:49:35 INFO - Return code: 0 21:49:35 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 21:49:35 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 21:49:35 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/2b30c2c66dd252f635402566b4ef46fecf4bb0db26a3d4bbc0b11be8302d3c6e9f8c36e5c221a4b5d0ad92ac7d3ae6b75f4b47dbc48497ad1eaf7c57cb8270ed", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/3393c4916457fa42bd3a32e6c6fa0cbe2d78c1770ec9314580b7051b705fd2e0550813204509c011f74c3ae1d88dc4f763b306c837b2713b997dbe46dd36c71b", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/523317d99c1ee7ffbffe5b173ac1153819cff918219e9afc31eafce4e980fb700e7cb44f28d026542da0a1c3679053769123a58ef0091c7ebca5208e2df68650", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/b1fa68f77e43213adbe677687832086144eefced5397c239a0933b553fe7e9358442ee97c5cf654617c1a874c7f65b92a43bb3a7edb3b8f083709b99c0aa13ef"} 21:49:35 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 21:49:35 INFO - Writing to file /builds/slave/test/properties/blobber_files 21:49:35 INFO - Contents: 21:49:35 INFO - blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/2b30c2c66dd252f635402566b4ef46fecf4bb0db26a3d4bbc0b11be8302d3c6e9f8c36e5c221a4b5d0ad92ac7d3ae6b75f4b47dbc48497ad1eaf7c57cb8270ed", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/3393c4916457fa42bd3a32e6c6fa0cbe2d78c1770ec9314580b7051b705fd2e0550813204509c011f74c3ae1d88dc4f763b306c837b2713b997dbe46dd36c71b", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/523317d99c1ee7ffbffe5b173ac1153819cff918219e9afc31eafce4e980fb700e7cb44f28d026542da0a1c3679053769123a58ef0091c7ebca5208e2df68650", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/b1fa68f77e43213adbe677687832086144eefced5397c239a0933b553fe7e9358442ee97c5cf654617c1a874c7f65b92a43bb3a7edb3b8f083709b99c0aa13ef"} 21:49:35 INFO - Running post-run listener: copy_logs_to_upload_dir 21:49:35 INFO - Copying logs to upload dir... 21:49:35 INFO - mkdir: /builds/slave/test/build/upload/logs 21:49:35 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1240.691554 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 40 secs) (at 2017-01-21 21:49:35.358468) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-21 21:49:35.366156) ========= 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=cbe409c6de289db6ac707de3000001d4-1485046988.551146-486559624 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/2b30c2c66dd252f635402566b4ef46fecf4bb0db26a3d4bbc0b11be8302d3c6e9f8c36e5c221a4b5d0ad92ac7d3ae6b75f4b47dbc48497ad1eaf7c57cb8270ed", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/3393c4916457fa42bd3a32e6c6fa0cbe2d78c1770ec9314580b7051b705fd2e0550813204509c011f74c3ae1d88dc4f763b306c837b2713b997dbe46dd36c71b", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/523317d99c1ee7ffbffe5b173ac1153819cff918219e9afc31eafce4e980fb700e7cb44f28d026542da0a1c3679053769123a58ef0091c7ebca5208e2df68650", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/b1fa68f77e43213adbe677687832086144eefced5397c239a0933b553fe7e9358442ee97c5cf654617c1a874c7f65b92a43bb3a7edb3b8f083709b99c0aa13ef"} build_url:https://queue.taskcluster.net/v1/task/RintsF4ISi2O_RCPw0ndYQ/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011403 build_url: 'https://queue.taskcluster.net/v1/task/RintsF4ISi2O_RCPw0ndYQ/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/2b30c2c66dd252f635402566b4ef46fecf4bb0db26a3d4bbc0b11be8302d3c6e9f8c36e5c221a4b5d0ad92ac7d3ae6b75f4b47dbc48497ad1eaf7c57cb8270ed", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/3393c4916457fa42bd3a32e6c6fa0cbe2d78c1770ec9314580b7051b705fd2e0550813204509c011f74c3ae1d88dc4f763b306c837b2713b997dbe46dd36c71b", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/523317d99c1ee7ffbffe5b173ac1153819cff918219e9afc31eafce4e980fb700e7cb44f28d026542da0a1c3679053769123a58ef0091c7ebca5208e2df68650", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/b1fa68f77e43213adbe677687832086144eefced5397c239a0933b553fe7e9358442ee97c5cf654617c1a874c7f65b92a43bb3a7edb3b8f083709b99c0aa13ef"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-21 21:49:35.397232) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-21 21:49:35.397658) ========= 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=cbe409c6de289db6ac707de3000001d4-1485046988.551146-486559624 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004508 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-21 21:49:35.481033) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-21 21:49:35.481423) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-21 21:49:35.481814) ========= ========= Total master_lag: 0.19 =========