builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-040 starttime: 1486397528.65 results: success (0) revision: 4f8f9621e75b23ba8f2546cc081df6981f46b13d ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-02-06 08:12:08.652159) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-02-06 08:12:08.652647) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-02-06 08:12:08.652950) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-02-06 08:12:08.665588) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-06 08:12:08.665895) ========= 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=9e0dfe3369c33a1556e63f89000001d8-1486397528.248384-154576822 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-02-06 08:12:08-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 45.9M=0s 2017-02-06 08:12:09 (45.9 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.141558 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-06 08:12:08.818759) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-06 08:12:08.819111) ========= 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=9e0dfe3369c33a1556e63f89000001d8-1486397528.248384-154576822 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014179 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-06 08:12:08.868513) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-06 08:12:08.868871) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 4f8f9621e75b23ba8f2546cc081df6981f46b13d --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 4f8f9621e75b23ba8f2546cc081df6981f46b13d --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=9e0dfe3369c33a1556e63f89000001d8-1486397528.248384-154576822 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-02-06 08:12:09,233 truncating revision to first 12 chars 2017-02-06 08:12:09,233 Setting DEBUG logging. 2017-02-06 08:12:09,233 attempt 1/10 2017-02-06 08:12:09,234 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/4f8f9621e75b?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-02-06 08:12:09,639 unpacking tar archive at: mozilla-aurora-4f8f9621e75b/testing/mozharness/ program finished with exit code 0 elapsedTime=0.710120 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-06 08:12:09.591766) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-06 08:12:09.592085) ========= script_repo_revision: 4f8f9621e75b23ba8f2546cc081df6981f46b13d ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-06 08:12:09.592459) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-06 08:12:09.592735) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-06 08:12:09.601810) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 34 secs) (at 2017-02-06 08:12:09.602133) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=9e0dfe3369c33a1556e63f89000001d8-1486397528.248384-154576822 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 08:12:10 INFO - MultiFileLogger online at 20170206 08:12:10 in /builds/slave/test 08:12:10 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 08:12:10 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:12:10 INFO - {'append_to_log': False, 08:12:10 INFO - 'base_work_dir': '/builds/slave/test', 08:12:10 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 08:12:10 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:12:10 INFO - 'branch': 'Mozilla-Aurora', 08:12:10 INFO - 'buildbot_json_path': 'buildprops.json', 08:12:10 INFO - 'config_files': ('talos/linux_config.py',), 08:12:10 INFO - 'default_actions': ('clobber', 08:12:10 INFO - 'read-buildbot-config', 08:12:10 INFO - 'download-and-extract', 08:12:10 INFO - 'populate-webroot', 08:12:10 INFO - 'create-virtualenv', 08:12:10 INFO - 'install', 08:12:10 INFO - 'run-tests'), 08:12:10 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:12:10 INFO - 'download_minidump_stackwalk': True, 08:12:10 INFO - 'download_symbols': 'ondemand', 08:12:10 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:12:10 INFO - 'tooltool.py': '/tools/tooltool.py', 08:12:10 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:12:10 INFO - '/tools/misc-python/virtualenv.py')}, 08:12:10 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:12:10 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:12:10 INFO - 'installer_path': 'installer.exe', 08:12:10 INFO - 'log_level': 'info', 08:12:10 INFO - 'log_name': 'talos', 08:12:10 INFO - 'log_to_console': True, 08:12:10 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 08:12:10 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 08:12:10 INFO - 'opt_config_files': (), 08:12:10 INFO - 'pip_index': False, 08:12:10 INFO - 'sps_profile': False, 08:12:10 INFO - 'sps_profile_interval': 0, 08:12:10 INFO - 'suite': 'dromaeojs-e10s', 08:12:10 INFO - 'system_bits': '32', 08:12:10 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:12:10 INFO - 'title': 'talos-linux64-ix-040', 08:12:10 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:12:10 INFO - 'use_talos_json': True, 08:12:10 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:12:10 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:12:10 INFO - 'work_dir': 'build'} 08:12:10 INFO - [mozharness: 2017-02-06 16:12:10.066713Z] Running clobber step. 08:12:10 INFO - Running pre-action listener: _resource_record_pre_action 08:12:10 INFO - Running main action method: clobber 08:12:10 INFO - rmtree: /builds/slave/test/build 08:12:10 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:12:10 INFO - Running post-action listener: _resource_record_post_action 08:12:10 INFO - [mozharness: 2017-02-06 16:12:10.536346Z] Finished clobber step (success) 08:12:10 INFO - [mozharness: 2017-02-06 16:12:10.536447Z] Running read-buildbot-config step. 08:12:10 INFO - Running pre-action listener: _resource_record_pre_action 08:12:10 INFO - Running main action method: read_buildbot_config 08:12:10 INFO - Using buildbot properties: 08:12:10 INFO - { 08:12:10 INFO - "project": "", 08:12:10 INFO - "product": "firefox", 08:12:10 INFO - "who": "cbook@mozilla.com", 08:12:10 INFO - "installer_path": "public/build/target.tar.bz2", 08:12:10 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s", 08:12:10 INFO - "repository": "https://hg.mozilla.org/releases/mozilla-aurora/", 08:12:10 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs-e10s", 08:12:10 INFO - "stage_platform": "linux64-pgo", 08:12:10 INFO - "basedir": "/builds/slave/test", 08:12:10 INFO - "buildnumber": 849, 08:12:10 INFO - "platform": "ubuntu64_hw", 08:12:10 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 08:12:10 INFO - "slavebuilddir": "test", 08:12:10 INFO - "taskId": "ZNQSWk31RUCy2O06FcMMzQ", 08:12:10 INFO - "branch": "mozilla-aurora", 08:12:10 INFO - "script_repo_revision": "production", 08:12:10 INFO - "revision": "4f8f9621e75b23ba8f2546cc081df6981f46b13d", 08:12:10 INFO - "slavename": "talos-linux64-ix-040", 08:12:10 INFO - "repo_path": "releases/mozilla-aurora" 08:12:10 INFO - } 08:12:10 INFO - Finding installer, test and symbols from parent task. 08:12:10 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ZNQSWk31RUCy2O06FcMMzQ'}, attempt #1 08:12:11 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ZNQSWk31RUCy2O06FcMMzQ'}, attempt #1 08:12:11 INFO - Task dependencies: FdOqssVsSPi1119XfS4ZPA 08:12:11 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/FdOqssVsSPi1119XfS4ZPA'}, attempt #1 08:12:11 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/FdOqssVsSPi1119XfS4ZPA/artifacts/public/build/target.tar.bz2 08:12:11 INFO - Set test_url: https://queue.taskcluster.net/v1/task/FdOqssVsSPi1119XfS4ZPA/artifacts/public/build/test_packages.json 08:12:11 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/FdOqssVsSPi1119XfS4ZPA/artifacts/public/build/target.crashreporter-symbols.zip 08:12:11 INFO - Running post-action listener: _resource_record_post_action 08:12:11 INFO - [mozharness: 2017-02-06 16:12:11.998949Z] Finished read-buildbot-config step (success) 08:12:11 INFO - [mozharness: 2017-02-06 16:12:11.999167Z] Running download-and-extract step. 08:12:11 INFO - Running pre-action listener: _resource_record_pre_action 08:12:11 INFO - Running main action method: download_and_extract 08:12:11 INFO - mkdir: /builds/slave/test/build/tests 08:12:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:12:12 INFO - trying https://queue.taskcluster.net/v1/task/FdOqssVsSPi1119XfS4ZPA/artifacts/public/build/target.test_packages.json 08:12:12 INFO - Downloading https://queue.taskcluster.net/v1/task/FdOqssVsSPi1119XfS4ZPA/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 08:12:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/FdOqssVsSPi1119XfS4ZPA/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 08:12:12 INFO - Downloaded 896 bytes. 08:12:12 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 08:12:12 INFO - Using the following test package requirements: 08:12:12 INFO - {u'common': [u'target.common.tests.zip'], 08:12:12 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 08:12:12 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 08:12:12 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 08:12:12 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 08:12:12 INFO - u'mozbase': [u'target.common.tests.zip'], 08:12:12 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 08:12:12 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 08:12:12 INFO - u'web-platform': [u'target.common.tests.zip', 08:12:12 INFO - u'target.web-platform.tests.zip'], 08:12:12 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 08:12:12 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 08:12:12 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/FdOqssVsSPi1119XfS4ZPA/artifacts/public/build/target.common.tests.zip 08:12:12 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/FdOqssVsSPi1119XfS4ZPA/artifacts/public/build/target.common.tests.zip'}, attempt #1 08:12:12 INFO - Fetch https://queue.taskcluster.net/v1/task/FdOqssVsSPi1119XfS4ZPA/artifacts/public/build/target.common.tests.zip into memory 08:12:13 INFO - Expected file size: 21854839 08:12:13 INFO - Obtained file size: 21854839 08:12:17 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 08:12:17 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/FdOqssVsSPi1119XfS4ZPA/artifacts/public/build/target.common.tests.zip 08:12:17 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/FdOqssVsSPi1119XfS4ZPA/artifacts/public/build/target.common.tests.zip'}, attempt #1 08:12:17 INFO - Fetch https://queue.taskcluster.net/v1/task/FdOqssVsSPi1119XfS4ZPA/artifacts/public/build/target.common.tests.zip into memory 08:12:18 INFO - Expected file size: 21854839 08:12:18 INFO - Obtained file size: 21854839 08:12:22 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/FdOqssVsSPi1119XfS4ZPA/artifacts/public/build/target.talos.tests.zip 08:12:22 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/FdOqssVsSPi1119XfS4ZPA/artifacts/public/build/target.talos.tests.zip'}, attempt #1 08:12:22 INFO - Fetch https://queue.taskcluster.net/v1/task/FdOqssVsSPi1119XfS4ZPA/artifacts/public/build/target.talos.tests.zip into memory 08:12:23 INFO - Expected file size: 14403485 08:12:23 INFO - Obtained file size: 14403485 08:12:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:12:23 INFO - trying https://queue.taskcluster.net/v1/task/FdOqssVsSPi1119XfS4ZPA/artifacts/public/build/target.tar.bz2 08:12:23 INFO - Downloading https://queue.taskcluster.net/v1/task/FdOqssVsSPi1119XfS4ZPA/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 08:12:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/FdOqssVsSPi1119XfS4ZPA/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 08:12:24 INFO - Downloaded 66124420 bytes. 08:12:24 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/FdOqssVsSPi1119XfS4ZPA/artifacts/public/build/target.tar.bz2 08:12:24 INFO - mkdir: /builds/slave/test/properties 08:12:24 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:12:24 INFO - Writing to file /builds/slave/test/properties/build_url 08:12:24 INFO - Contents: 08:12:24 INFO - build_url:https://queue.taskcluster.net/v1/task/FdOqssVsSPi1119XfS4ZPA/artifacts/public/build/target.tar.bz2 08:12:24 INFO - Running post-action listener: _resource_record_post_action 08:12:24 INFO - Running post-action listener: set_extra_try_arguments 08:12:24 INFO - [mozharness: 2017-02-06 16:12:24.574948Z] Finished download-and-extract step (success) 08:12:24 INFO - [mozharness: 2017-02-06 16:12:24.575046Z] Running populate-webroot step. 08:12:24 INFO - Running pre-action listener: _resource_record_pre_action 08:12:24 INFO - Running main action method: populate_webroot 08:12:24 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:12:24 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:12:24 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:12:24 INFO - '--tppagecycles', 08:12:24 INFO - '7'], 08:12:24 INFO - 'tests': ['tsvgm']}}, 08:12:24 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 08:12:24 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:12:24 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 08:12:24 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 08:12:24 INFO - 'tests': ['dromaeo_css', 'kraken']}, 08:12:24 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 08:12:24 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 08:12:24 INFO - 'talos_options': ['--disable-e10s'], 08:12:24 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:12:24 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 08:12:24 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:12:24 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 08:12:24 INFO - 'talos_options': ['--disable-e10s'], 08:12:24 INFO - 'tests': ['damp', 'tps']}, 08:12:24 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 08:12:24 INFO - 'tests': ['damp', 'tps']}, 08:12:24 INFO - 'g3': {'talos_options': ['--disable-e10s'], 08:12:24 INFO - 'tests': ['dromaeo_dom']}, 08:12:24 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:12:24 INFO - 'g4': {'talos_options': ['--disable-e10s'], 08:12:24 INFO - 'tests': ['basic_compositor_video']}, 08:12:24 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 08:12:24 INFO - 'other': {'talos_options': ['--disable-e10s'], 08:12:24 INFO - 'tests': ['a11yr', 08:12:24 INFO - 'ts_paint', 08:12:24 INFO - 'tpaint', 08:12:24 INFO - 'sessionrestore', 08:12:24 INFO - 'sessionrestore_no_auto_restore', 08:12:24 INFO - 'tabpaint']}, 08:12:24 INFO - 'other-e10s': {'tests': ['a11yr', 08:12:24 INFO - 'ts_paint', 08:12:24 INFO - 'tpaint', 08:12:24 INFO - 'sessionrestore', 08:12:24 INFO - 'sessionrestore_no_auto_restore', 08:12:24 INFO - 'tabpaint']}, 08:12:24 INFO - 'other-e10s_l64': {'tests': ['a11yr', 08:12:24 INFO - 'ts_paint', 08:12:24 INFO - 'tpaint', 08:12:24 INFO - 'sessionrestore', 08:12:24 INFO - 'sessionrestore_no_auto_restore', 08:12:24 INFO - 'tabpaint']}, 08:12:24 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 08:12:24 INFO - 'ts_paint', 08:12:24 INFO - 'tpaint', 08:12:24 INFO - 'sessionrestore', 08:12:24 INFO - 'sessionrestore_no_auto_restore', 08:12:24 INFO - 'tabpaint']}, 08:12:24 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 08:12:24 INFO - 'tests': ['a11yr', 08:12:24 INFO - 'ts_paint', 08:12:24 INFO - 'tpaint', 08:12:24 INFO - 'sessionrestore', 08:12:24 INFO - 'sessionrestore_no_auto_restore', 08:12:24 INFO - 'tabpaint']}, 08:12:24 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 08:12:24 INFO - 'tests': ['a11yr', 08:12:24 INFO - 'ts_paint', 08:12:24 INFO - 'tpaint', 08:12:24 INFO - 'sessionrestore', 08:12:24 INFO - 'sessionrestore_no_auto_restore', 08:12:24 INFO - 'tabpaint']}, 08:12:24 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 08:12:24 INFO - 'tests': ['tsvgx', 08:12:24 INFO - 'tsvgr_opacity', 08:12:24 INFO - 'tart', 08:12:24 INFO - 'tscrollx', 08:12:24 INFO - 'cart', 08:12:24 INFO - 'tsvg_static']}, 08:12:24 INFO - 'svgr-e10s': {'tests': ['tsvgx', 08:12:24 INFO - 'tsvgr_opacity', 08:12:24 INFO - 'tart', 08:12:24 INFO - 'tscrollx', 08:12:24 INFO - 'cart', 08:12:24 INFO - 'tsvg_static']}, 08:12:24 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 08:12:24 INFO - 'talos_options': ['--disable-e10s'], 08:12:24 INFO - 'tests': ['tp5o']}, 08:12:24 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 08:12:24 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 08:12:24 INFO - 'talos_options': ['--disable-e10s', 08:12:24 INFO - '--xperf_path', 08:12:24 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:12:24 INFO - 'tests': ['tp5n']}, 08:12:24 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 08:12:24 INFO - 'talos_options': ['--xperf_path', 08:12:24 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:12:24 INFO - 'tests': ['tp5n']}}, 08:12:24 INFO - 'talos.zip': {'path': '', 08:12:24 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:12:24 INFO - Running post-action listener: _resource_record_post_action 08:12:24 INFO - [mozharness: 2017-02-06 16:12:24.588167Z] Finished populate-webroot step (success) 08:12:24 INFO - [mozharness: 2017-02-06 16:12:24.588258Z] Running create-virtualenv step. 08:12:24 INFO - Running pre-action listener: _resource_record_pre_action 08:12:24 INFO - Running main action method: create_virtualenv 08:12:24 INFO - Creating virtualenv /builds/slave/test/build/venv 08:12:24 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 08:12:24 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:12:24 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:12:24 INFO - Using real prefix '/usr' 08:12:24 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:12:25 INFO - Installing distribute.............................................................................................................................................................................................done. 08:12:27 INFO - Installing pip.................done. 08:12:27 INFO - Return code: 0 08:12:27 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 08:12:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 08:12:27 INFO - Reading from file tmpfile_stdout 08:12:27 INFO - Output received: 08:12:27 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) 08:12:27 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:12:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:12:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:12:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:12:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:12:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:12:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:12:27 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 0xa271f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xb38a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd99480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd96820>, '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 0xd97520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd979b0>, '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': '9e0dfe3369c33a1556e63f89000001d8-1486397528.248384-154576822', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:12:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 08:12:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 08:12:27 INFO - Using env: {'DISPLAY': ':0', 08:12:27 INFO - 'HOME': '/home/cltbld', 08:12:27 INFO - 'LANG': 'en_US.UTF-8', 08:12:27 INFO - 'LANGUAGE': 'en_US:en', 08:12:27 INFO - 'LOGNAME': 'cltbld', 08:12:27 INFO - 'MAIL': '/var/mail/cltbld', 08:12:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:12:27 INFO - 'MOZ_NO_REMOTE': '1', 08:12:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:12:27 INFO - 'NO_EM_RESTART': '1', 08:12:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:12:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:12:27 INFO - 'PWD': '/builds/slave/test', 08:12:27 INFO - 'SHELL': '/bin/bash', 08:12:27 INFO - 'SHLVL': '1', 08:12:27 INFO - 'TERM': 'linux', 08:12:27 INFO - 'TMOUT': '86400', 08:12:27 INFO - 'USER': 'cltbld', 08:12:27 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1486397528.248384-154576822', 08:12:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:12:27 INFO - '_': '/tools/buildbot/bin/python'} 08:12:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:12:27 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 08:12:27 INFO - Cleaning up... 08:12:27 INFO - Return code: 0 08:12:27 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 08:12:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:12:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:12:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:12:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:12:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:12:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:12:27 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 0xa271f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xb38a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd99480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd96820>, '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 0xd97520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd979b0>, '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': '9e0dfe3369c33a1556e63f89000001d8-1486397528.248384-154576822', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:12:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 08:12:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 08:12:27 INFO - Using env: {'DISPLAY': ':0', 08:12:27 INFO - 'HOME': '/home/cltbld', 08:12:27 INFO - 'LANG': 'en_US.UTF-8', 08:12:27 INFO - 'LANGUAGE': 'en_US:en', 08:12:27 INFO - 'LOGNAME': 'cltbld', 08:12:27 INFO - 'MAIL': '/var/mail/cltbld', 08:12:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:12:27 INFO - 'MOZ_NO_REMOTE': '1', 08:12:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:12:27 INFO - 'NO_EM_RESTART': '1', 08:12:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:12:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:12:27 INFO - 'PWD': '/builds/slave/test', 08:12:27 INFO - 'SHELL': '/bin/bash', 08:12:27 INFO - 'SHLVL': '1', 08:12:27 INFO - 'TERM': 'linux', 08:12:27 INFO - 'TMOUT': '86400', 08:12:27 INFO - 'USER': 'cltbld', 08:12:27 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1486397528.248384-154576822', 08:12:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:12:27 INFO - '_': '/tools/buildbot/bin/python'} 08:12:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:12:27 INFO - Downloading/unpacking psutil>=3.1.1 08:12:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:12:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:12:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:12:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:12:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:12:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:12:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:12:29 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:12:29 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:12:29 INFO - Installing collected packages: psutil 08:12:29 INFO - Running setup.py install for psutil 08:12:29 INFO - building 'psutil._psutil_linux' extension 08:12:29 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 08:12:30 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 08:12:30 INFO - building 'psutil._psutil_posix' extension 08:12:30 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 08:12:30 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 08:12:30 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:12:30 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:12:30 INFO - Successfully installed psutil 08:12:30 INFO - Cleaning up... 08:12:30 INFO - Return code: 0 08:12:30 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 08:12:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:12:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:12:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:12:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:12:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:12:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:12:30 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 0xa271f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xb38a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd99480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd96820>, '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 0xd97520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd979b0>, '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': '9e0dfe3369c33a1556e63f89000001d8-1486397528.248384-154576822', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:12:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 08:12:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 08:12:30 INFO - Using env: {'DISPLAY': ':0', 08:12:30 INFO - 'HOME': '/home/cltbld', 08:12:30 INFO - 'LANG': 'en_US.UTF-8', 08:12:30 INFO - 'LANGUAGE': 'en_US:en', 08:12:30 INFO - 'LOGNAME': 'cltbld', 08:12:30 INFO - 'MAIL': '/var/mail/cltbld', 08:12:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:12:30 INFO - 'MOZ_NO_REMOTE': '1', 08:12:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:12:30 INFO - 'NO_EM_RESTART': '1', 08:12:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:12:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:12:30 INFO - 'PWD': '/builds/slave/test', 08:12:30 INFO - 'SHELL': '/bin/bash', 08:12:30 INFO - 'SHLVL': '1', 08:12:30 INFO - 'TERM': 'linux', 08:12:30 INFO - 'TMOUT': '86400', 08:12:30 INFO - 'USER': 'cltbld', 08:12:30 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1486397528.248384-154576822', 08:12:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:12:30 INFO - '_': '/tools/buildbot/bin/python'} 08:12:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:12:30 INFO - Downloading/unpacking mozsystemmonitor==0.3 08:12:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:12:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:12:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:12:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:12:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:12:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:12:32 INFO - Downloading mozsystemmonitor-0.3.tar.gz 08:12:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:12:32 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 08:12:32 INFO - Installing collected packages: mozsystemmonitor 08:12:32 INFO - Running setup.py install for mozsystemmonitor 08:12:32 INFO - Successfully installed mozsystemmonitor 08:12:32 INFO - Cleaning up... 08:12:32 INFO - Return code: 0 08:12:32 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 08:12: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')]} 08:12:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:12:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:12: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')]} 08:12:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:12:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:12: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==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xa271f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xb38a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd99480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd96820>, '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 0xd97520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd979b0>, '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': '9e0dfe3369c33a1556e63f89000001d8-1486397528.248384-154576822', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:12: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==2.5.1'] in /builds/slave/test/build 08:12: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==2.5.1 08:12:32 INFO - Using env: {'DISPLAY': ':0', 08:12:32 INFO - 'HOME': '/home/cltbld', 08:12:32 INFO - 'LANG': 'en_US.UTF-8', 08:12:32 INFO - 'LANGUAGE': 'en_US:en', 08:12:32 INFO - 'LOGNAME': 'cltbld', 08:12:32 INFO - 'MAIL': '/var/mail/cltbld', 08:12:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:12:32 INFO - 'MOZ_NO_REMOTE': '1', 08:12:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:12:32 INFO - 'NO_EM_RESTART': '1', 08:12:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:12:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:12:32 INFO - 'PWD': '/builds/slave/test', 08:12:32 INFO - 'SHELL': '/bin/bash', 08:12:32 INFO - 'SHLVL': '1', 08:12:32 INFO - 'TERM': 'linux', 08:12:32 INFO - 'TMOUT': '86400', 08:12:32 INFO - 'USER': 'cltbld', 08:12:32 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1486397528.248384-154576822', 08:12:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:12:32 INFO - '_': '/tools/buildbot/bin/python'} 08:12:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:12:33 INFO - Downloading/unpacking jsonschema==2.5.1 08:12:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:12:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:12:33 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:12:33 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:12:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:12:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:12:35 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:12:35 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 08:12:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:12:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:12:35 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:12:35 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:12:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:12:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:12:35 INFO - Downloading functools32-3.2.3-2.tar.gz 08:12:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 08:12:35 INFO - warning: no files found matching '*.txt' 08:12:35 INFO - no previously-included directories found matching 'build' 08:12:35 INFO - no previously-included directories found matching 'dist' 08:12:35 INFO - no previously-included directories found matching '.git*' 08:12:35 INFO - Installing collected packages: jsonschema, functools32 08:12:35 INFO - Running setup.py install for functools32 08:12:35 INFO - warning: no files found matching '*.txt' 08:12:35 INFO - no previously-included directories found matching 'build' 08:12:35 INFO - no previously-included directories found matching 'dist' 08:12:35 INFO - no previously-included directories found matching '.git*' 08:12:35 INFO - Successfully installed jsonschema functools32 08:12:35 INFO - Cleaning up... 08:12:35 INFO - Return code: 0 08:12:35 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 08:12:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:12:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:12:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:12:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:12:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:12:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:12:35 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 0xa271f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xb38a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd99480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd96820>, '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 0xd97520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd979b0>, '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': '9e0dfe3369c33a1556e63f89000001d8-1486397528.248384-154576822', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:12:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 08:12:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 08:12:35 INFO - Using env: {'DISPLAY': ':0', 08:12:35 INFO - 'HOME': '/home/cltbld', 08:12:35 INFO - 'LANG': 'en_US.UTF-8', 08:12:35 INFO - 'LANGUAGE': 'en_US:en', 08:12:35 INFO - 'LOGNAME': 'cltbld', 08:12:35 INFO - 'MAIL': '/var/mail/cltbld', 08:12:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:12:35 INFO - 'MOZ_NO_REMOTE': '1', 08:12:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:12:35 INFO - 'NO_EM_RESTART': '1', 08:12:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:12:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:12:35 INFO - 'PWD': '/builds/slave/test', 08:12:35 INFO - 'SHELL': '/bin/bash', 08:12:35 INFO - 'SHLVL': '1', 08:12:35 INFO - 'TERM': 'linux', 08:12:35 INFO - 'TMOUT': '86400', 08:12:35 INFO - 'USER': 'cltbld', 08:12:35 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1486397528.248384-154576822', 08:12:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:12:35 INFO - '_': '/tools/buildbot/bin/python'} 08:12:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:12:35 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 08:12:35 INFO - Cleaning up... 08:12:35 INFO - Return code: 0 08:12:35 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:12:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:12:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:12:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:12:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:12:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:12:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:12:35 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 0xa271f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xb38a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd99480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd96820>, '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 0xd97520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd979b0>, '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': '9e0dfe3369c33a1556e63f89000001d8-1486397528.248384-154576822', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:12:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 08:12:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 08:12:35 INFO - Using env: {'DISPLAY': ':0', 08:12:35 INFO - 'HOME': '/home/cltbld', 08:12:35 INFO - 'LANG': 'en_US.UTF-8', 08:12:35 INFO - 'LANGUAGE': 'en_US:en', 08:12:35 INFO - 'LOGNAME': 'cltbld', 08:12:35 INFO - 'MAIL': '/var/mail/cltbld', 08:12:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:12:35 INFO - 'MOZ_NO_REMOTE': '1', 08:12:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:12:35 INFO - 'NO_EM_RESTART': '1', 08:12:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:12:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:12:35 INFO - 'PWD': '/builds/slave/test', 08:12:35 INFO - 'SHELL': '/bin/bash', 08:12:35 INFO - 'SHLVL': '1', 08:12:35 INFO - 'TERM': 'linux', 08:12:35 INFO - 'TMOUT': '86400', 08:12:35 INFO - 'USER': 'cltbld', 08:12:35 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1486397528.248384-154576822', 08:12:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:12:35 INFO - '_': '/tools/buildbot/bin/python'} 08:12:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:12:36 INFO - Downloading/unpacking blobuploader==1.2.4 08:12:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:12:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:12:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:12:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:12:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:12:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:12:38 INFO - Downloading blobuploader-1.2.4.tar.gz 08:12:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:12:38 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:12:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:12:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:12:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:12:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:12:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:12:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:12:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:12:38 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:12:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:12:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:12:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:12:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:12:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:12:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:12:38 INFO - Downloading docopt-0.6.1.tar.gz 08:12:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:12:38 INFO - Installing collected packages: blobuploader, requests, docopt 08:12:38 INFO - Running setup.py install for blobuploader 08:12:38 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:12:38 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:12:38 INFO - Running setup.py install for requests 08:12:39 INFO - Running setup.py install for docopt 08:12:39 INFO - Successfully installed blobuploader requests docopt 08:12:39 INFO - Cleaning up... 08:12:39 INFO - Return code: 0 08:12:39 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:12:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:12:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:12:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:12:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:12:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:12:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:12:39 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 0xa271f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xb38a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd99480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd96820>, '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 0xd97520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd979b0>, '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': '9e0dfe3369c33a1556e63f89000001d8-1486397528.248384-154576822', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:12:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 08:12:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 08:12:39 INFO - Using env: {'DISPLAY': ':0', 08:12:39 INFO - 'HOME': '/home/cltbld', 08:12:39 INFO - 'LANG': 'en_US.UTF-8', 08:12:39 INFO - 'LANGUAGE': 'en_US:en', 08:12:39 INFO - 'LOGNAME': 'cltbld', 08:12:39 INFO - 'MAIL': '/var/mail/cltbld', 08:12:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:12:39 INFO - 'MOZ_NO_REMOTE': '1', 08:12:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:12:39 INFO - 'NO_EM_RESTART': '1', 08:12:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:12:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:12:39 INFO - 'PWD': '/builds/slave/test', 08:12:39 INFO - 'SHELL': '/bin/bash', 08:12:39 INFO - 'SHLVL': '1', 08:12:39 INFO - 'TERM': 'linux', 08:12:39 INFO - 'TMOUT': '86400', 08:12:39 INFO - 'USER': 'cltbld', 08:12:39 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1486397528.248384-154576822', 08:12:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:12:39 INFO - '_': '/tools/buildbot/bin/python'} 08:12:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:12:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:12:39 INFO - Running setup.py (path:/tmp/pip-uxOv_o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:12:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:12:39 INFO - Running setup.py (path:/tmp/pip-nwZTHy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:12:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:12:39 INFO - Running setup.py (path:/tmp/pip-erEP1k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:12:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:12:39 INFO - Running setup.py (path:/tmp/pip-rYtipa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:12:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:12:39 INFO - Running setup.py (path:/tmp/pip-glMroc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:12:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:12:40 INFO - Running setup.py (path:/tmp/pip-Ub8Qht-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:12:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:12:40 INFO - Running setup.py (path:/tmp/pip-3E27kj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:12:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:12:40 INFO - Running setup.py (path:/tmp/pip-Gu0yaj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:12:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:12:40 INFO - Running setup.py (path:/tmp/pip-41x9n8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:12:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:12:40 INFO - Running setup.py (path:/tmp/pip-MHDDeb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:12:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:12:40 INFO - Running setup.py (path:/tmp/pip-L5Dawp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:12:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:12:40 INFO - Running setup.py (path:/tmp/pip-dt7cGG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:12:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:12:40 INFO - Running setup.py (path:/tmp/pip-tTS7dl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:12:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:12:40 INFO - Running setup.py (path:/tmp/pip-AfTrd_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:12:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:12:40 INFO - Running setup.py (path:/tmp/pip-f6fZ9d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:12:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:12:40 INFO - Running setup.py (path:/tmp/pip-XMgtw6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:12:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:12:40 INFO - Running setup.py (path:/tmp/pip-CxJwUo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:12:40 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:12:40 INFO - Running setup.py install for manifestparser 08:12:41 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:12:41 INFO - Running setup.py install for mozcrash 08:12:41 INFO - Running setup.py install for mozdebug 08:12:41 INFO - Running setup.py install for mozdevice 08:12:41 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 08:12:41 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:12:41 INFO - Running setup.py install for mozfile 08:12:41 INFO - Running setup.py install for mozhttpd 08:12:41 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:12:41 INFO - Running setup.py install for mozinfo 08:12:41 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:12:41 INFO - Running setup.py install for mozInstall 08:12:41 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:12:41 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:12:41 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:12:41 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:12:41 INFO - Running setup.py install for mozleak 08:12:41 INFO - Running setup.py install for mozlog 08:12:41 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:12:41 INFO - Running setup.py install for moznetwork 08:12:42 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:12:42 INFO - Running setup.py install for mozprocess 08:12:42 INFO - Running setup.py install for mozprofile 08:12:42 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:12:42 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:12:42 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:12:42 INFO - Running setup.py install for mozrunner 08:12:42 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:12:42 INFO - Running setup.py install for mozscreenshot 08:12:42 INFO - Running setup.py install for moztest 08:12:42 INFO - Running setup.py install for mozversion 08:12:42 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:12:42 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:12:42 INFO - Cleaning up... 08:12:42 INFO - Return code: 0 08:12:42 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:12:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:12:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:12:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:12:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:12:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:12:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:12:42 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 0xa271f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xb38a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd99480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd96820>, '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 0xd97520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd979b0>, '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': '9e0dfe3369c33a1556e63f89000001d8-1486397528.248384-154576822', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:12:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 08:12:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 08:12:42 INFO - Using env: {'DISPLAY': ':0', 08:12:42 INFO - 'HOME': '/home/cltbld', 08:12:42 INFO - 'LANG': 'en_US.UTF-8', 08:12:42 INFO - 'LANGUAGE': 'en_US:en', 08:12:42 INFO - 'LOGNAME': 'cltbld', 08:12:42 INFO - 'MAIL': '/var/mail/cltbld', 08:12:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:12:42 INFO - 'MOZ_NO_REMOTE': '1', 08:12:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:12:42 INFO - 'NO_EM_RESTART': '1', 08:12:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:12:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:12:42 INFO - 'PWD': '/builds/slave/test', 08:12:42 INFO - 'SHELL': '/bin/bash', 08:12:42 INFO - 'SHLVL': '1', 08:12:42 INFO - 'TERM': 'linux', 08:12:42 INFO - 'TMOUT': '86400', 08:12:42 INFO - 'USER': 'cltbld', 08:12:42 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1486397528.248384-154576822', 08:12:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:12:42 INFO - '_': '/tools/buildbot/bin/python'} 08:12:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:12:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:12:43 INFO - Running setup.py (path:/tmp/pip-JgLVu3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:12:43 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 08:12:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:12:43 INFO - Running setup.py (path:/tmp/pip-z_cHeZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:12:43 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)) 08:12:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:12:43 INFO - Running setup.py (path:/tmp/pip-5ZhDwb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:12:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 08:12:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:12:43 INFO - Running setup.py (path:/tmp/pip-Tj29wV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:12:43 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)) 08:12:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:12:43 INFO - Running setup.py (path:/tmp/pip-uPep5V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:12:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 08:12:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:12:43 INFO - Running setup.py (path:/tmp/pip-QXjyz2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:12:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 08:12:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:12:43 INFO - Running setup.py (path:/tmp/pip-u6pWtz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:12:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 08:12:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:12:43 INFO - Running setup.py (path:/tmp/pip-zVK6O8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:12:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 08:12:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:12:43 INFO - Running setup.py (path:/tmp/pip-tug9Ea-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:12:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 08:12:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:12:43 INFO - Running setup.py (path:/tmp/pip-PP6j4g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:12:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:12:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:12:43 INFO - Running setup.py (path:/tmp/pip-4162jf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:12:43 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 08:12:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:12:43 INFO - Running setup.py (path:/tmp/pip-uWVwiJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:12:43 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)) 08:12:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:12:43 INFO - Running setup.py (path:/tmp/pip-Y_5AX5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:12:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 08:12:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:12:43 INFO - Running setup.py (path:/tmp/pip-bpyosc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:12:44 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)) 08:12:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:12:44 INFO - Running setup.py (path:/tmp/pip-gvwVp3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:12:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 08:12:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:12:44 INFO - Running setup.py (path:/tmp/pip-6oCRme-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:12:44 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)) 08:12:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:12:44 INFO - Running setup.py (path:/tmp/pip-nIyErw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:12:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 08:12:44 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)) 08:12:44 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)) 08:12:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 08:12:44 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)) 08:12:44 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)) 08:12:44 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:12:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:12:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:12:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:12:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:12:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:12:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:12:46 INFO - Downloading blessings-1.6.tar.gz 08:12:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:12:46 INFO - Installing collected packages: blessings 08:12:46 INFO - Running setup.py install for blessings 08:12:46 INFO - Successfully installed blessings 08:12:46 INFO - Cleaning up... 08:12:46 INFO - Return code: 0 08:12:46 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:12:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:12:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:12:46 INFO - Reading from file tmpfile_stdout 08:12:46 INFO - Current package versions: 08:12:46 INFO - argparse == 1.2.1 08:12:46 INFO - blessings == 1.6 08:12:46 INFO - blobuploader == 1.2.4 08:12:46 INFO - docopt == 0.6.1 08:12:46 INFO - functools32 == 3.2.3-2 08:12:46 INFO - jsonschema == 2.5.1 08:12:46 INFO - manifestparser == 1.1 08:12:46 INFO - mozInstall == 1.12 08:12:46 INFO - mozcrash == 1.0 08:12:46 INFO - mozdebug == 0.1 08:12:46 INFO - mozdevice == 0.49 08:12:46 INFO - mozfile == 1.2 08:12:46 INFO - mozhttpd == 0.7 08:12:46 INFO - mozinfo == 0.9 08:12:46 INFO - mozleak == 0.1 08:12:46 INFO - mozlog == 3.4 08:12:46 INFO - moznetwork == 0.27 08:12:46 INFO - mozprocess == 0.24 08:12:46 INFO - mozprofile == 0.28 08:12:46 INFO - mozrunner == 6.13 08:12:46 INFO - mozscreenshot == 0.1 08:12:46 INFO - mozsystemmonitor == 0.3 08:12:46 INFO - moztest == 0.8 08:12:46 INFO - mozversion == 1.4 08:12:46 INFO - psutil == 3.1.1 08:12:46 INFO - requests == 1.2.3 08:12:46 INFO - wsgiref == 0.1.2 08:12:46 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:12:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:12:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:12:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:12:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:12:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:12:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:12:46 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 0xa271f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xb38a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd99480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd96820>, '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 0xd97520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd979b0>, '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': '9e0dfe3369c33a1556e63f89000001d8-1486397528.248384-154576822', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:12:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 08:12:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 08:12:46 INFO - Using env: {'DISPLAY': ':0', 08:12:46 INFO - 'HOME': '/home/cltbld', 08:12:46 INFO - 'LANG': 'en_US.UTF-8', 08:12:46 INFO - 'LANGUAGE': 'en_US:en', 08:12:46 INFO - 'LOGNAME': 'cltbld', 08:12:46 INFO - 'MAIL': '/var/mail/cltbld', 08:12:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:12:46 INFO - 'MOZ_NO_REMOTE': '1', 08:12:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:12:46 INFO - 'NO_EM_RESTART': '1', 08:12:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:12:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:12:46 INFO - 'PWD': '/builds/slave/test', 08:12:46 INFO - 'SHELL': '/bin/bash', 08:12:46 INFO - 'SHLVL': '1', 08:12:46 INFO - 'TERM': 'linux', 08:12:46 INFO - 'TMOUT': '86400', 08:12:46 INFO - 'USER': 'cltbld', 08:12:46 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1486397528.248384-154576822', 08:12:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:12:46 INFO - '_': '/tools/buildbot/bin/python'} 08:12:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:12:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 08:12:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 08:12:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 08:12:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 08:12:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 08:12:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 08:12:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 08:12:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 08:12:46 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 08:12:46 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 08:12:46 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 08:12:46 INFO - Cleaning up... 08:12:46 INFO - Return code: 0 08:12:46 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 08:12:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:12:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:12:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:12:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:12:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:12:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:12:46 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xa271f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xb38a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd99480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd96820>, '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 0xd97520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd979b0>, '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': '9e0dfe3369c33a1556e63f89000001d8-1486397528.248384-154576822', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:12:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 08:12:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 08:12:46 INFO - Using env: {'DISPLAY': ':0', 08:12:46 INFO - 'HOME': '/home/cltbld', 08:12:46 INFO - 'LANG': 'en_US.UTF-8', 08:12:46 INFO - 'LANGUAGE': 'en_US:en', 08:12:46 INFO - 'LOGNAME': 'cltbld', 08:12:46 INFO - 'MAIL': '/var/mail/cltbld', 08:12:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:12:46 INFO - 'MOZ_NO_REMOTE': '1', 08:12:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:12:46 INFO - 'NO_EM_RESTART': '1', 08:12:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:12:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:12:46 INFO - 'PWD': '/builds/slave/test', 08:12:46 INFO - 'SHELL': '/bin/bash', 08:12:46 INFO - 'SHLVL': '1', 08:12:46 INFO - 'TERM': 'linux', 08:12:46 INFO - 'TMOUT': '86400', 08:12:46 INFO - 'USER': 'cltbld', 08:12:46 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1486397528.248384-154576822', 08:12:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:12:46 INFO - '_': '/tools/buildbot/bin/python'} 08:12:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:12:47 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 08:12:47 INFO - Cleaning up... 08:12:47 INFO - Return code: 0 08:12:47 INFO - Running post-action listener: _resource_record_post_action 08:12:47 INFO - Running post-action listener: _start_resource_monitoring 08:12:47 INFO - Starting resource monitoring. 08:12:47 INFO - [mozharness: 2017-02-06 16:12:47.202287Z] Finished create-virtualenv step (success) 08:12:47 INFO - [mozharness: 2017-02-06 16:12:47.202791Z] Running install step. 08:12:47 INFO - Running pre-action listener: _resource_record_pre_action 08:12:47 INFO - Running main action method: install 08:12:47 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:12:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:12:47 INFO - Reading from file tmpfile_stdout 08:12:47 INFO - Detecting whether we're running mozinstall >=1.0... 08:12:47 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:12:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:12:47 INFO - Reading from file tmpfile_stdout 08:12:47 INFO - Output received: 08:12:47 INFO - Usage: mozinstall [options] installer 08:12:47 INFO - Options: 08:12:47 INFO - -h, --help show this help message and exit 08:12:47 INFO - -d DEST, --destination=DEST 08:12:47 INFO - Directory to install application into. [default: 08:12:47 INFO - "/builds/slave/test"] 08:12:47 INFO - --app=APP Application being installed. [default: firefox] 08:12:47 INFO - mkdir: /builds/slave/test/build/application 08:12:47 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'] 08:12:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 08:13:04 INFO - Reading from file tmpfile_stdout 08:13:04 INFO - Output received: 08:13:04 INFO - /builds/slave/test/build/application/firefox/firefox 08:13:04 INFO - Running post-action listener: _resource_record_post_action 08:13:04 INFO - [mozharness: 2017-02-06 16:13:04.213146Z] Finished install step (success) 08:13:04 INFO - [mozharness: 2017-02-06 16:13:04.213392Z] Running run-tests step. 08:13:04 INFO - Running pre-action listener: _resource_record_pre_action 08:13:04 INFO - Running main action method: run_tests 08:13:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:13:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:13:04 INFO - Python 2.7.3 08:13:04 INFO - Return code: 0 08:13:04 INFO - grabbing minidump binary from tooltool 08:13:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:13:04 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 0xd96820>, '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 0xd97520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd979b0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:13:04 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 08:13:04 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 08:13:04 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 08:13:04 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:13:04 INFO - Return code: 0 08:13:04 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 08:13:04 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:13:04 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:13:04 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 08:13:04 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:13:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/FdOqssVsSPi1119XfS4ZPA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-040', '--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 08:13:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/FdOqssVsSPi1119XfS4ZPA/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-040 --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 08:13:04 INFO - Using env: {'DISPLAY': ':0', 08:13:04 INFO - 'HOME': '/home/cltbld', 08:13:04 INFO - 'LANG': 'en_US.UTF-8', 08:13:04 INFO - 'LANGUAGE': 'en_US:en', 08:13:04 INFO - 'LOGNAME': 'cltbld', 08:13:04 INFO - 'MAIL': '/var/mail/cltbld', 08:13:04 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:13:04 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 08:13:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:13:04 INFO - 'MOZ_NO_REMOTE': '1', 08:13:04 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:13:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:13:04 INFO - 'NO_EM_RESTART': '1', 08:13:04 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:13:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:13:04 INFO - 'PWD': '/builds/slave/test', 08:13:04 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:13:04 INFO - 'SHELL': '/bin/bash', 08:13:04 INFO - 'SHLVL': '1', 08:13:04 INFO - 'TERM': 'linux', 08:13:04 INFO - 'TMOUT': '86400', 08:13:04 INFO - 'USER': 'cltbld', 08:13:04 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1486397528.248384-154576822', 08:13:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:13:04 INFO - '_': '/tools/buildbot/bin/python'} 08:13:04 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/FdOqssVsSPi1119XfS4ZPA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-040', '--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 08:13:04 INFO - mozversion application_buildid: 20170206150903 08:13:04 INFO - mozversion application_changeset: 4f8f9621e75b23ba8f2546cc081df6981f46b13d 08:13:04 INFO - mozversion application_display_name: FirefoxDeveloperEdition 08:13:04 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:13:04 INFO - mozversion application_name: Firefox 08:13:04 INFO - mozversion application_remotingname: firefox-dev 08:13:04 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 08:13:04 INFO - mozversion application_vendor: Mozilla 08:13:04 INFO - mozversion application_version: 53.0a2 08:13:04 INFO - mozversion platform_buildid: 20170206150903 08:13:04 INFO - mozversion platform_changeset: 4f8f9621e75b23ba8f2546cc081df6981f46b13d 08:13:04 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 08:13:04 INFO - mozversion platform_version: 53.0a2 08:13:04 INFO - using testdate: 1486397584 08:13:04 INFO - actual date: 1486397584 08:13:04 INFO - starting webserver on 'localhost:43131' 08:13:04 INFO - SUITE-START | Running 2 tests 08:13:04 INFO - TEST-START | dromaeo_css 08:13:04 INFO - operating with platform_type : linux_ 08:13:04 INFO - Initialising browser for dromaeo_css test... 08:13:04 INFO - TEST-INFO | started process 15900 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpJoHAIA/profile http://localhost:43131/getInfo.html) 08:13:09 INFO - PROCESS | 15900 | __metrics Screen width/height:1600/1200 08:13:09 INFO - PROCESS | 15900 | colorDepth:24 08:13:09 INFO - PROCESS | 15900 | Browser inner width/height: 1024/697 08:13:09 INFO - PROCESS | 15900 | __metrics 08:13:09 INFO - PROCESS | 15900 | 1486397589490 addons.xpi WARN Exception running bootstrap method shutdown on shield-recipe-client@mozilla.org: ReferenceError: LogManager is not defined (resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/firefox/browser/features/shield-recipe-client@mozilla.org.xpi!/bootstrap.js:65:3) JS Stack trace: this.shutdown@resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/firefox/browser/features/shield-recipe-client@bootstrap.js:65:3 < callBootstrapMethod@XPIProvider.jsm:4903:11 < observe@XPIProvider.jsm:2884:15 < permitUnload@remote-browser.xml:353:13 < CanCloseWindow@browser.js:6277:36 < canClose@browser.js:5143:12 < forceQuit@jar:file:///tmp/tmpJoHAIA/profile/extensions/talos-powers@TalosPowersService.js:238:7 < whenDone@jar:file:///tmp/tmpJoHAIA/profile/extensions/talos-powers@TalosPowersService.js:223:9 < promise callback*forceQuit@jar:file:///tmp/tmpJoHAIA/profile/extensions/talos-powers@TalosPowersService.js:225:7 < receiveMessage@jar:file:///tmp/tmpJoHAIA/profile/extensions/talos-powers@TalosPowersService.js:55:9 08:13:09 ERROR - PROCESS | 15900 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3280: TypeError: this.tabs is undefined 08:13:10 INFO - TEST-INFO | 15900: exit 0 08:13:10 INFO - Browser initialized. 08:13:10 INFO - Running cycle 1/1 for dromaeo_css test... 08:13:10 INFO - TEST-INFO | started process 16030 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpJoHAIA/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:13:22 INFO - PROCESS | 16030 | RSS: Main: 144322560 08:13:22 INFO - PROCESS | 16030 | 08:16:21 INFO - PROCESS | 16030 | Cycle 1(1): loaded http://localhost:43131/tests/dromaeo/cssquery-dojo.html (next: http://localhost:43131/tests/dromaeo/cssquery-ext.html) 08:16:22 INFO - PROCESS | 16030 | RSS: Main: 152731648 08:16:22 INFO - PROCESS | 16030 | 08:18:10 INFO - PROCESS | 16030 | ************************* 08:18:10 INFO - PROCESS | 16030 | A coding exception was thrown and uncaught in a Task. 08:18:10 INFO - PROCESS | 16030 | 08:18:10 ERROR - PROCESS | 16030 | Full message: TypeError: NetworkError when attempting to fetch resource. 08:18:10 INFO - PROCESS | 16030 | Full stack: 08:18:10 INFO - PROCESS | 16030 | ************************* 08:19:24 INFO - PROCESS | 16030 | Cycle 1(1): loaded http://localhost:43131/tests/dromaeo/cssquery-ext.html (next: http://localhost:43131/tests/dromaeo/cssquery-jquery.html) 08:19:25 INFO - PROCESS | 16030 | RSS: Main: 150196224 08:19:25 INFO - PROCESS | 16030 | 08:22:27 INFO - PROCESS | 16030 | Cycle 1(1): loaded http://localhost:43131/tests/dromaeo/cssquery-jquery.html (next: http://localhost:43131/tests/dromaeo/cssquery-mootools.html) 08:22:27 INFO - PROCESS | 16030 | RSS: Main: 153034752 08:22:27 INFO - PROCESS | 16030 | 08:25:29 INFO - PROCESS | 16030 | Cycle 1(1): loaded http://localhost:43131/tests/dromaeo/cssquery-mootools.html (next: http://localhost:43131/tests/dromaeo/cssquery-prototype.html) 08:25:30 INFO - PROCESS | 16030 | RSS: Main: 149426176 08:25:30 INFO - PROCESS | 16030 | 08:28:32 INFO - PROCESS | 16030 | Cycle 1(1): loaded http://localhost:43131/tests/dromaeo/cssquery-prototype.html (next: http://localhost:43131/tests/dromaeo/cssquery-yui.html) 08:28:33 INFO - PROCESS | 16030 | RSS: Main: 152838144 08:28:33 INFO - PROCESS | 16030 | 08:31:35 INFO - PROCESS | 16030 | Cycle 1(1): loaded http://localhost:43131/tests/dromaeo/cssquery-yui.html (next: http://localhost:43131/tests/dromaeo/cssquery-dojo.html) 08:31:35 INFO - PROCESS | 16030 | RSS: Main: 155762688 08:31:35 INFO - PROCESS | 16030 | 08:31:35 INFO - PROCESS | 16030 | __start_tp_report 08:31:35 INFO - PROCESS | 16030 | _x_x_mozilla_page_load 08:31:35 INFO - PROCESS | 16030 | _x_x_mozilla_page_load_details 08:31:35 INFO - PROCESS | 16030 | |i|pagename|runs| 08:31:35 INFO - PROCESS | 16030 | |0;dojo.html;3247.9837600811998;3251.1872031992;3267.1505408593757;3287.654796246394;3288.309455014447;5504.724763761811;5568.443155684429;5568.554515638749;5582;5588.217649529059;5549.445055494449;5613.326400831896;5625.943740562593;5627.324721033471;5663.575231857617;5080.974595127029;5116.462771408986;5165.509276618715;5185.196294574328;5216.3218781558535;5133.153029750087;5168.48315168482;5172.741362931857;5180.922286165711;5182.792688292483;4911.410630724318;4923.483034281403;5159.045576568328;5163.81926632568;5192.091384007784;4966.106100901854;4990.800367985276;4995.825146119886;5041.899162016776;5102.38771347437;4955.058538877602;4975.502449755032;5028.472010438888;5044.142495775727;5078.339815823956;5382.2464854920345;5430.782768689248;5439.646422982533;5509.118541033416;5535.114381698909;5802.506786923117;5833.183354330397;5847.8538036549;5900.734466948955;5977.910331345033;5943.970280148572;5973.432523910222;5976.103584462322;5980.491658209057;5995.040793473024;5530.253415788898;5531.0873705838485;5537.252470916455;5546.667199968015;5563.499285064364;5820.35976042635;5843.035899076604;6001.819945401558;6030.065339872327;6053.092036194518;5827.504662103684;5884.676342801187;5893.823185304448;5908.911366329508;5929.407059294036;5927.644341339534;5967.1347654589845;5979.880402392015;5983.670898100646;5986.491148252448;5767.134929760569;5814.854628634233;5924.585279030426;5957.6127551709;5966.463018328284;5967.254093238345;5969.820905372846;5970.940290597126;5975.19334889793;6002.339742628307;4577.153226653079;4583.289590113538;4585.060062687141;4586.931196032062;4617.630589552828;3968.1270120573427;3978.3634618460906;4040.8585699500377;4070.531888832822;4082.6325630692786;5806.21616081832;5807.82576522705;5865.237519122486;5901.262342207224;5907.497862681635;5962.493188078975;5979.970100149471;6002.879942401128;6027.517798576104;6045;5633.183188437735;5698.629589076697;5698.6580805151825;5758.654480731169;5824.621399609012;5038.874028149326;5040.042391945519;5049.26785616091;5060.089183946851;5067.442581316052;6181;6184.81445556634;6187.133801267826;6188.4739797116845;6190.257169139642;5859.794907178229;5866.911996319973;5890.882182356243;5914.02418600926;5922.585419020799;6121.635889161074;6139.093519790236;6179.227596550431;6188.44304012623;6202.4417802398;5786.247787787561;5862.530997520274;5894;5897.203877476657;5921.5558833086825;5928.584999050197;5992.820215393545;5993.400659933972;6003.129546215687;6007.459328660441;5713.7428815704225;5782.595218334676;5784.797532086357;5840.970795145997;5846.590738648254;5771.68255745938;5850.2102216200265;5880.852978675567;5891.793787217427;5891.882162356815;5802.506786923159;5855.151003104611;5856.502197313276;5859.736311866061;5869.207656966255;5724.3703192647945;5847.181394604844;5850.970745146247;5878.3239927407185;5882.411758824083;5628.240187574625;5661.631993920382;5700.173474846207;5719.599628026164;5738.512226460798 08:31:35 INFO - PROCESS | 16030 | |1;ext.html;545.0934199437163;603.5443240353533;609.6159419565673;697.6720941157657;707.8179440334641;45486.54513454864;46538.53461465384;50312;50372;50486.747566262165;51611;52631.47368526314;52715.472845271535;52797.2080418794;52798.73600632001;9305.813883722338;10728.73178170548;11128.721781955475;11146.108311335074;11429.485673144729;10929.071028962548;10982.725431864188;10994.945025274863;11015.118790496781;11050.392228427434;11183.664490065312;11192.888071119267;11210.103191744682;11229.550817967312;11241.887581124207;11083.168762342817;11110.500027498781;11164;11174.27367221128;11179.552817887316;10944.850790667024;11072.335659860353;11098.112151027899;11110;11115.166362522843;43425.78287108576;44168.779156104014;44210.55789442096;44262.778686106365;44274.55725442737;4146.523149837747;4172.937405938914;4199.538050814408;4224.4930608327195;4306.655467562588;32582.837085814655;32665.836670816494;32676.183095422566;33058.4185602291;33285.334293314;4527.750973696446;4667.509911459316;4692.741899195543;4816.349792778;4820.734859582722;385148;386182;388369;388560;388922;62980;63263.36736632667;63345.683271583344;63491.682541587;63611.68194159092;66371.66814165899;66442.66778666076;66607.66696166585;66694.33305666881;66722.66638666873;17804.643907121786;18231.08844557767;19216.903915480332;19787.802121978595;19789.703154452694;14765.483208087666;15088.396464141531;15187.392504299925;15593.688126237412;15650.139242341553;19997.800021999883;20194.29319973794;20255.898720506597;20384.388468345973;20430;7256.7822965311125;7402.148752893486;7591.164971853092;7595.3164215220895;7672.769816905502;986.4820968991337;993.735578624216;1018.4398580780542;1024.7438140464883;1035.0736091198485;33379.666203337656;33684;33918;34168.5536090256;34308.65691343055;1082.9404382759024;1181.303031211572;1195.9820602690966;1201.195199216527;1215.9270443773225;15907.125108118933;17280.22238999248;17987.550311242325;18239.544011399823;18317.3588924387;565604;574084;575421;577000;577657;63157;63788.36211637917;64036.35963640397;64128;64180;1558.2158428599191;1572.5989872582418;1578.3213218316234;1589.682063587287;1613.0241204071367;32155.839220803748;32230.516542252353;32482.51276230811;32804.50793238151;33199.66800331966;53797;54373.45626543684;54723.17915231355;54862.72568637131;55201.72399138139;496170;496846;498840;499324;499861;29583;29630;30019.849900750356;30712.846435768573;32169;48240.517594825;48455.51544484651;48708;48883.75558122329;49986.25020624766;40387;41067.794661026506;41649.58350416457;42431.36352954646;42689.78655106829;40293;40709.389359159046;41640;42257.57742422536;42390.36414453724;39958.200835982534;40505.39241911432;40904.79547602243;40991;44504.55495445004;35277.82361088178;36246.63753362433;36667.26665466622;36831.263374732895;37008.44487332746;28380.290492737848;28401.715982839905;28581.857090714413;28717.28206794847;28742 08:31:35 INFO - PROCESS | 16030 | |2;jquery.html;424.56906240166217;432.3860118631544;437.4444455541462;441.562852775752;450.1402321565808;20245.39263822086;21625.243116490925;22125.114995400185;22193.334199974026;22466.663000055014;21986.340409787692;22579.54840903185;22712.318630441114;22841.54316913665;22962.31113066611;6056.152138700574;6196.4113409226275;6227.43953044226;6267.404596563342;6269.4044065813905;5998.130271110686;6153.323134455206;6169.167162433081;6215.937840621581;6220.377962203788;6068.3324834268415;6111.174991376151;6117.755289788403;6133.202683651141;6148.538859585527;5960.701964901759;6113.663748493831;6140.35526269742;6143.447089761943;6158.230221222348;5477.890442191174;5486.862828429281;5500.50495455411;5540.864122854846;5541;25700.10049648272;25765;25988;26138.6079208812;26430.339241518923;2724.087430710714;2781.0683421053973;2810.985945070282;2833.759130473912;2843.7156284371604;11177.776444471065;15729.213539322987;16106.275217615235;16508.25712842925;16876.915615421967;2053.4968932611605;2056.8663036902553;2058.073866759964;2068.88621125838;2073.637113505146;95400.52299738457;96229.51885240599;96641;96788.51605741926;98512;11379.943100284445;11523.539058437736;11720.765584688259;11825.88174118265;11834.76330473403;16136.515904522883;16143.434979775651;16145.838541614668;16148.515544533682;16150.03099814015;9124.17882390588;9296.30277729173;9363.719088427359;9398.624055037859;9563.139317461462;9333.57998890038;9396.389234699722;9431.170648805331;9442.480663563432;9601.711948641552;7159;7468.253174682488;7480.5885676287235;7483.925160748323;7505.573940951202;2032.7904896586508;2036.256766280297;2084.9478763030743;2088.561402105575;2113.8203252723383;1179.204037274836;1185.9881401185878;1187.1333926233897;1208.9395530223453;1214.3442541027746;20750.169993200103;21196.364109076752;21555.137794488044;22404.55190896173;23031.07875684954;1006.864073350103;1019.1184625299063;1024.2164743970868;1032.566322144686;1041.286718597763;11339;11593.710157245967;11633.360165190827;11675.007624352025;11819.645410637695;685316;710370;722656;728291;748220;102350;122488;122783;124888;127895.36052319678;1184.3782014442315;1186.5550418593027;1224.3633310678576;1224.5652793258444;1229.5327775445273;18066.90966545159;18256.269749210413;18384.448466546026;18423;18601.627967440305;47655.76172119117;48522.27216591824;48854;49130.75434622804;50094.24858627051;65407;67661;68056.319436805;68358;68768;8134.308583770446;8317.168283171635;8336.666533338841;8358.87461688063;9399;10291.639792607222;13983.440662373798;14035.719285614436;14256.073355231876;14431.85568144305;11370.772584548427;11495.770084598094;11649.941750291195;11776.764464710486;11836.82244766312;11553.075753939833;11692.766144676889;12077.758444830879;12566.308853012806;12666.303353315656;12271.509139634672;12282.754344912873;12354.567590134302;12488.313142776871;12506.624801255977;8211.83576328482;8555.187257210555;8747.518886461306;8853.114688531095;8882.0673829247;8475.49147051179;10391.324563903323;10958.616448424267;11073.667789966314;11209.271397359145 08:31:35 INFO - PROCESS | 16030 | |3;mootools.html;1455.3814628782766;1505.4279373837944;1509.7584386498156;1511.5012046024813;1525.916074615896;8436.325093992482;8677.479351238915;9056.184943355096;9133.817323653522;9169.762082118912;9098.13567711068;9261.444313341204;9265.444073355586;9267.907320926788;9281.953590232057;2394.892229849661;2419.842710223839;2427.0291883246755;2430.7812296893276;2437.110454684045;2433.1483980606736;2461.4461746107163;2465.161844972709;2473.752624737521;2479.814013948952;2392.456865321866;2393.066703985447;2417.3231495181376;2423.4062654649633;2424.599941009731;2349;2353.5881220786296;2375.228050883461;2375.5723969685364;2380.940476488084;2293.3005433342823;2295.896684649178;2338.088145623208;2347.3779448446176;2356.7289761677457;9213;9216.585253663601;9256.305777066747;9257.768555786091;9284.025177356416;5470.890582188374;5544.77820887164;5571.247881535981;5583.637063590894;5606.943930560724;3400.1499625093725;3402.9659703403145;3462.774919630216;3499.5100685903994;3543.3799085159994;1441.617971237623;1508.630385555535;1583.6911802198576;2270.1373478078226;2274.6701728249313;12213.084018698544;12291.139620226499;12338.074644401706;12341.629751107392;12341.93829030858;4422.270325396338;4644.419447569054;4715.056988602225;4748.0978614063215;4783.808647654125;9988.101070903653;10029.598816047277;10070.496475176358;10081.798364032678;10114.645987390553;5517.44825517445;5537.8061767837935;5550.72246387679;5574.721263936787;5581.581381396411;4992.650514463952;5120.974395128001;5122.257272695439;5182.170852663556;5235.528802407802;3863.130795570974;3993.7803420812133;4003.499562554681;4064.573219811877;4084.591540845892;1215.805471124616;1220.5117952818944;1229.551213806954;1230.6923269182705;1242.1118899986552;981.7202097402206;1009.0817356205818;1009.4195837393528;1016.598443614768;1021.3973755484151;5863.970680146572;5873.911891321633;5915.497182739516;6039.063945088518;6060.303065147476;633.832034510855;654.8722999015241;659.1102012283475;662.9933700663028;664.4319107163305;3879.4568760373572;3938.487996560486;3982.482277303932;4097.631213190827;4207.095474473003;10104.949475252724;10400.427976461368;10477.47612619366;10496.26526143178;10498.107660848913;10214.285000050073;10317.123044541298;10399.688009359732;10419.739506512398;10436.686899393031;7930.206979302024;8124.350051995826;8210.220029097227;8211.917880821355;8232.794180145544;5793.36273009977;5819.883602328015;5920.703964801656;5923.851903702442;5956.672383018976;9440.763980900258;9492.477913714536;9547.140757331874;9549.713508594754;9657.372270802376;9482.336236463658;9487.098725621056;9593.376430532273;9643.566039528378;9672.516374181403;7089.432845372461;7288.96355518219;7885;8097.514149151069;8137.064237612751;8888.111188881061;8966.417182883091;8967.10328967098;8967.282617390463;8970.686025989058;7202.855942881009;7327.963360183165;7366.742164024234;7522.887156692764;7530.661120249492;7109.893351599627;7112.431005519443;7133.464990125865;7167.784966451015;7177.102862142232;6290.968545157428;6382.329855365306;6390.7763228286785;6394.0408938659575;6398.13625160616;5004.224345226496;5046.6719663221775;5057.165567681292;5059.443461219336;5208.166693329201;5011.348524691767;5037.546620804145;5149.2276158576515;5157.6647517911215;5177.0940085485645 08:31:35 INFO - PROCESS | 16030 | |4;prototype.html;404.14724930396875;408.10624731837277;413.94618699569054;424.5966331984615;424.9341352090426;5154.458781827911;5301.496357846008;5464.754086066127;5532.723363831808;5534.363548191954;5256.316678831756;5429.131338985763;5431.538319242859;5436.320459942507;5455.863603409907;4406.713563618355;4409.536998615139;4410.603045725884;4412.87471694719;4432.844850430236;4309.978450107745;4376.452943382077;4382.189294980439;4387.956120438803;4443.400375864686;4373.671974601918;4382.5398333175035;4387.363832244323;4404.383386325901;4416.690831641787;4374.715643483163;4390.517043125285;4395.7911574316995;4398.03243286478;4435.977820110878;3902.278078555448;4022.592092767537;4038.29329867275;4038.5557588665224;4039;5294.947050529522;5320.52115309624;5324.946750532484;5336.30628018359;5348.8127915523155;4969.4036715594;4990.451050384455;4993.575546078588;5007.32401125847;5015.27278544609;5444.849284532627;5653.293338332708;5654.575906807006;5663.830085097454;5746.885062298772;4354.281543545343;4358.7166834156;4377.518472967971;4378.715383500063;4406.757628330441;5968.641881487125;5988;5988.221531200959;5992.550558708114;6002.259344790005;4394.791432356128;4477.552244775497;4503.144402563503;4519.954800451954;4542.523035081335;4538.387317712132;4539.6368290536675;4556.840510582114;4556.931646025312;4592.15045216636;5005.724685142352;5042.193249080129;5065.745743144339;5069.645124841226;5077.425997940651;5738.368779434259;5755.22304488897;5839.649621022752;5849.12827895078;5906.143609176731;1433.8566143385788;1441.6395901024744;1444.978325325121;1451.361400983564;1455.548779878241;992.5682328187262;1014.9441780701984;1018.221060888421;1030.8402197659375;1033.3696445168441;5462.672239665632;5470.452954704498;5534.363548191929;5534.540911930044;5567.276254086943;5669.744861481243;5692.459216374438;5705.5435565154685;5769.567282453832;5771.249737534094;5345.102488616563;5367.5169234769055;5371.435999220103;5419.647722897999;5516.9448305516435;2976.821390716564;3000;3028.712272334125;3029.469842777505;3044.254157731326;5655.575831812631;5866.624017273011;5888.116782482576;5889.764409423575;5958.672273025025;5820.330661973842;5826.796062137805;5849.532037436995;5881.3530511643685;5881.382949486121;5966.761329546856;5974.312954010257;5978.1929439525975;6016.488598469179;6075.605085669506;5558.388577256418;5623.325200975909;5658.745356458887;5671.610455438444;5765.799981010412;5592.51798273466;5605.990921634145;5610.382857885547;5633.802816901389;5682.488576028178;5682.14767784819;5870.735816888165;5874.206982057368;6012.248468941382;6027.397260273938;4084.652804511531;4141.618569322592;4144.191882582988;4146.875593732193;4171.416001759695;5690.601657884074;5716;5721.256236689203;5733.569982251432;5881.117832325185;5665.773369065191;5682.772689092555;5726.570507211893;5729.770809167587;5732.799352022659;5705.546614955609;5739.684317362418;5748.45389687979;5751.769929202785;5790.904004476034;5542.445755424425;5696.344920334214;5708.65748055118;5720.914186287126;5734.913976290442;5743.368229494836;5776.451237132465;5794.449527294901;5805.651660900359;5853.443922827325;5462.617616766788;5578.525825304732;5676.211993222122;5676.262085928968;5751.367349591458 08:31:35 INFO - PROCESS | 16030 | |5;yui.html;800.1988071570573;807.2694211738378;824.0523398092193;911.84498635232;939.887213534376;16379.918100409495;17563.73654395185;17885.7317140243;17966.5508362291;18154.09229538521;15725.292361843716;16048;16161.272742726576;16357.509274721777;16484.67030659389;826.4627991805314;840.9789755256106;841.4656692999928;844.543946269017;848.6987119572556;817.2318021060214;840.8780726794611;845.3913182508614;858.0561382479254;858.3948316436928;887.7425546591513;893.5442924108719;897.2687259883174;898.9056149104348;903.5346796399859;890.447922288179;895.9238464730506;896.5203616065373;901.432097778402;903.2006674093409;652.2759736692268;659.3867703036175;660.1418156396666;661.256086902235;662.4038365471115;17322.91338543312;17535.912320438445;17745.11274436273;17773.46679599614;17890.642187156183;16139.596510087342;16363.509094727176;16402.26189821461;16468.176591170395;16765.24556394965;13499.190048597018;13519.526816561372;13680.863191368058;13733.725325493535;13739.106958047694;4028.133951200506;4041.4139949707424;4047.9797601011805;4079.4696689430184;4096.201240758053;55612;66449.33876653074;67621.32378676199;68776.3122368775;82233;12285.877141228651;12411.441485133191;12641.810372844231;12784.424700888483;13147.53983610569;21890.562188756456;22950.540989180125;22951.31146065621;23314;23585.174518891756;8531.189536993976;8590.65637374498;8921.420107692978;8961.327900407496;8968.865467018;4798.520147985174;4971.105201063771;4981.252812078144;5030.597552195815;5053.065182941167;3762.9435558466644;3815.7901315427916;3853.479780229633;3866.8066596670055;3871.6902647788675;698.8462538241579;704.383664293743;707.4234498883394;707.8761216787042;715.5849607227796;644.7002144003061;645.8998855177455;665.8035879415584;668.5721138471382;671.684308375063;11130.640292341985;11268.830967535494;11309.264897781617;11425.428728563538;11575.652730418102;687.3229868579446;693.8334799648048;717.6878058044767;719.7732714195116;722.9277072292729;5360.624756267024;5381.165919282517;5486.1770734389365;5490.368607610096;5504.91742623861;65502;79674;83990;84114;87652.5617371909;74083.62958185174;74457.62771186109;75599.24400756032;76293;76568.61715691385;56143;62254.37745622576;62984.37015629877;64265.35734642594;64824.67587662126;10185;10374.27380083387;10443.164546836388;10538.156947444339;10605.840912386166;46324;47023.52976470192;47283.527164727915;47463.762681186374;47857;56023.439765603456;56838;57507.42492575021;57560;58454.70772646109;12645.430955606837;12650.873491264969;12739.171953822972;12797.424115914993;12888.806667899802;13004.739905202032;13010.154339967872;13109.803352949904;13311.33443327849;13427.798583021067;13247.933760331136;13316.800247996482;13352.799708004193;13476.124051936593;13753.656158596115;13074.673133171747;13341.933290333487;13344.199348039148;13468.730625387241;13565.93217033948;13522.101714132314;13600.93199533996;13699.589012329647;13750.037497375088;13762.174269543859;10464.424456654957;10607.151427885905;10619.628313009007;11003.284786488852;11061.834072488758;10837.945810270898;10988.945055274673;11044.613438529614;11076.612318568812;11100.389478578756 08:31:35 INFO - PROCESS | 16030 | __end_tp_report 08:31:35 INFO - PROCESS | 16030 | __start_cc_report 08:31:35 INFO - PROCESS | 16030 | _x_x_mozilla_cycle_collect,319 08:31:35 INFO - PROCESS | 16030 | __end_cc_report 08:31:35 INFO - PROCESS | 16030 | __startTimestamp1486398695520__endTimestamp 08:31:35 INFO - PROCESS | 16030 | 08:31:35 INFO - PROCESS | 16030 | ------- Summary: start ------- 08:31:35 INFO - PROCESS | 16030 | Number of tests: 6 08:31:35 INFO - PROCESS | 16030 | 08:31:35 INFO - PROCESS | 16030 | [#0] dojo.html Cycles:165 Average:5538.51 Median:5802.51 stddev:624.05 (10.8%) stddev-sans-first:599.53 08:31:35 INFO - PROCESS | 16030 | Values: 3248.0 3251.2 3267.2 3287.7 3288.3 5504.7 5568.4 5568.6 5582.0 5588.2 5549.4 5613.3 5625.9 5627.3 5663.6 5081.0 5116.5 5165.5 5185.2 5216.3 5133.2 5168.5 5172.7 5180.9 5182.8 4911.4 4923.5 5159.0 5163.8 5192.1 4966.1 4990.8 4995.8 5041.9 5102.4 4955.1 4975.5 5028.5 5044.1 5078.3 5382.2 5430.8 5439.6 5509.1 5535.1 5802.5 5833.2 5847.9 5900.7 5977.9 5944.0 5973.4 5976.1 5980.5 5995.0 5530.3 5531.1 5537.3 5546.7 5563.5 5820.4 5843.0 6001.8 6030.1 6053.1 5827.5 5884.7 5893.8 5908.9 5929.4 5927.6 5967.1 5979.9 5983.7 5986.5 5767.1 5814.9 5924.6 5957.6 5966.5 5967.3 5969.8 5970.9 5975.2 6002.3 4577.2 4583.3 4585.1 4586.9 4617.6 3968.1 3978.4 4040.9 4070.5 4082.6 5806.2 5807.8 5865.2 5901.3 5907.5 5962.5 5980.0 6002.9 6027.5 6045.0 5633.2 5698.6 5698.7 5758.7 5824.6 5038.9 5040.0 5049.3 5060.1 5067.4 6181.0 6184.8 6187.1 6188.5 6190.3 5859.8 5866.9 5890.9 5914.0 5922.6 6121.6 6139.1 6179.2 6188.4 6202.4 5786.2 5862.5 5894.0 5897.2 5921.6 5928.6 5992.8 5993.4 6003.1 6007.5 5713.7 5782.6 5784.8 5841.0 5846.6 5771.7 5850.2 5880.9 5891.8 5891.9 5802.5 5855.2 5856.5 5859.7 5869.2 5724.4 5847.2 5851.0 5878.3 5882.4 5628.2 5661.6 5700.2 5719.6 5738.5 08:31:35 INFO - PROCESS | 16030 | 08:31:35 INFO - PROCESS | 16030 | [#1] ext.html Cycles:180 Average:65811.77 Median:388741.00 stddev:130571.30 (33.6%) stddev-sans-first:130845.63 08:31:35 INFO - PROCESS | 16030 | Values: 545.1 603.5 609.6 697.7 707.8 45486.5 46538.5 50312.0 50372.0 50486.7 51611.0 52631.5 52715.5 52797.2 52798.7 9305.8 10728.7 11128.7 11146.1 11429.5 10929.1 10982.7 10994.9 11015.1 11050.4 11183.7 11192.9 11210.1 11229.6 11241.9 11083.2 11110.5 11164.0 11174.3 11179.6 10944.9 11072.3 11098.1 11110.0 11115.2 43425.8 44168.8 44210.6 44262.8 44274.6 4146.5 4172.9 4199.5 4224.5 4306.7 32582.8 32665.8 32676.2 33058.4 33285.3 4527.8 4667.5 4692.7 4816.3 4820.7 385148.0 386182.0 388369.0 388560.0 388922.0 62980.0 63263.4 63345.7 63491.7 63611.7 66371.7 66442.7 66607.7 66694.3 66722.7 17804.6 18231.1 19216.9 19787.8 19789.7 14765.5 15088.4 15187.4 15593.7 15650.1 19997.8 20194.3 20255.9 20384.4 20430.0 7256.8 7402.1 7591.2 7595.3 7672.8 986.5 993.7 1018.4 1024.7 1035.1 33379.7 33684.0 33918.0 34168.6 34308.7 1082.9 1181.3 1196.0 1201.2 1215.9 15907.1 17280.2 17987.6 18239.5 18317.4 565604.0 574084.0 575421.0 577000.0 577657.0 63157.0 63788.4 64036.4 64128.0 64180.0 1558.2 1572.6 1578.3 1589.7 1613.0 32155.8 32230.5 32482.5 32804.5 33199.7 53797.0 54373.5 54723.2 54862.7 55201.7 496170.0 496846.0 498840.0 499324.0 499861.0 29583.0 29630.0 30019.8 30712.8 32169.0 48240.5 48455.5 48708.0 48883.8 49986.3 40387.0 41067.8 41649.6 42431.4 42689.8 40293.0 40709.4 41640.0 42257.6 42390.4 39958.2 40505.4 40904.8 40991.0 44504.6 35277.8 36246.6 36667.3 36831.3 37008.4 28380.3 28401.7 28581.9 28717.3 28742.0 08:31:35 INFO - PROCESS | 16030 | 08:31:35 INFO - PROCESS | 16030 | [#2] jquery.html Cycles:180 Average:37823.27 Median:22776.93 stddev:118324.09 (519.5%) stddev-sans-first:118622.70 08:31:35 INFO - PROCESS | 16030 | Values: 424.6 432.4 437.4 441.6 450.1 20245.4 21625.2 22125.1 22193.3 22466.7 21986.3 22579.5 22712.3 22841.5 22962.3 6056.2 6196.4 6227.4 6267.4 6269.4 5998.1 6153.3 6169.2 6215.9 6220.4 6068.3 6111.2 6117.8 6133.2 6148.5 5960.7 6113.7 6140.4 6143.4 6158.2 5477.9 5486.9 5500.5 5540.9 5541.0 25700.1 25765.0 25988.0 26138.6 26430.3 2724.1 2781.1 2811.0 2833.8 2843.7 11177.8 15729.2 16106.3 16508.3 16876.9 2053.5 2056.9 2058.1 2068.9 2073.6 95400.5 96229.5 96641.0 96788.5 98512.0 11379.9 11523.5 11720.8 11825.9 11834.8 16136.5 16143.4 16145.8 16148.5 16150.0 9124.2 9296.3 9363.7 9398.6 9563.1 9333.6 9396.4 9431.2 9442.5 9601.7 7159.0 7468.3 7480.6 7483.9 7505.6 2032.8 2036.3 2084.9 2088.6 2113.8 1179.2 1186.0 1187.1 1208.9 1214.3 20750.2 21196.4 21555.1 22404.6 23031.1 1006.9 1019.1 1024.2 1032.6 1041.3 11339.0 11593.7 11633.4 11675.0 11819.6 685316.0 710370.0 722656.0 728291.0 748220.0 102350.0 122488.0 122783.0 124888.0 127895.4 1184.4 1186.6 1224.4 1224.6 1229.5 18066.9 18256.3 18384.4 18423.0 18601.6 47655.8 48522.3 48854.0 49130.8 50094.2 65407.0 67661.0 68056.3 68358.0 68768.0 8134.3 8317.2 8336.7 8358.9 9399.0 10291.6 13983.4 14035.7 14256.1 14431.9 11370.8 11495.8 11649.9 11776.8 11836.8 11553.1 11692.8 12077.8 12566.3 12666.3 12271.5 12282.8 12354.6 12488.3 12506.6 8211.8 8555.2 8747.5 8853.1 8882.1 8475.5 10391.3 10958.6 11073.7 11209.3 08:31:35 INFO - PROCESS | 16030 | 08:31:35 INFO - PROCESS | 16030 | [#3] mootools.html Cycles:180 Average:5774.88 Median:5121.62 stddev:3194.66 (62.4%) stddev-sans-first:3187.13 08:31:35 INFO - PROCESS | 16030 | Values: 1455.4 1505.4 1509.8 1511.5 1525.9 8436.3 8677.5 9056.2 9133.8 9169.8 9098.1 9261.4 9265.4 9267.9 9282.0 2394.9 2419.8 2427.0 2430.8 2437.1 2433.1 2461.4 2465.2 2473.8 2479.8 2392.5 2393.1 2417.3 2423.4 2424.6 2349.0 2353.6 2375.2 2375.6 2380.9 2293.3 2295.9 2338.1 2347.4 2356.7 9213.0 9216.6 9256.3 9257.8 9284.0 5470.9 5544.8 5571.2 5583.6 5606.9 3400.1 3403.0 3462.8 3499.5 3543.4 1441.6 1508.6 1583.7 2270.1 2274.7 12213.1 12291.1 12338.1 12341.6 12341.9 4422.3 4644.4 4715.1 4748.1 4783.8 9988.1 10029.6 10070.5 10081.8 10114.6 5517.4 5537.8 5550.7 5574.7 5581.6 4992.7 5121.0 5122.3 5182.2 5235.5 3863.1 3993.8 4003.5 4064.6 4084.6 1215.8 1220.5 1229.6 1230.7 1242.1 981.7 1009.1 1009.4 1016.6 1021.4 5864.0 5873.9 5915.5 6039.1 6060.3 633.8 654.9 659.1 663.0 664.4 3879.5 3938.5 3982.5 4097.6 4207.1 10104.9 10400.4 10477.5 10496.3 10498.1 10214.3 10317.1 10399.7 10419.7 10436.7 7930.2 8124.4 8210.2 8211.9 8232.8 5793.4 5819.9 5920.7 5923.9 5956.7 9440.8 9492.5 9547.1 9549.7 9657.4 9482.3 9487.1 9593.4 9643.6 9672.5 7089.4 7289.0 7885.0 8097.5 8137.1 8888.1 8966.4 8967.1 8967.3 8970.7 7202.9 7328.0 7366.7 7522.9 7530.7 7109.9 7112.4 7133.5 7167.8 7177.1 6291.0 6382.3 6390.8 6394.0 6398.1 5004.2 5046.7 5057.2 5059.4 5208.2 5011.3 5037.5 5149.2 5157.7 5177.1 08:31:35 INFO - PROCESS | 16030 | 08:31:35 INFO - PROCESS | 16030 | [#4] prototype.html Cycles:180 Average:4846.77 Median:5459.24 stddev:1371.69 (25.1%) stddev-sans-first:1334.39 08:31:35 INFO - PROCESS | 16030 | Values: 404.1 408.1 413.9 424.6 424.9 5154.5 5301.5 5464.8 5532.7 5534.4 5256.3 5429.1 5431.5 5436.3 5455.9 4406.7 4409.5 4410.6 4412.9 4432.8 4310.0 4376.5 4382.2 4388.0 4443.4 4373.7 4382.5 4387.4 4404.4 4416.7 4374.7 4390.5 4395.8 4398.0 4436.0 3902.3 4022.6 4038.3 4038.6 4039.0 5294.9 5320.5 5324.9 5336.3 5348.8 4969.4 4990.5 4993.6 5007.3 5015.3 5444.8 5653.3 5654.6 5663.8 5746.9 4354.3 4358.7 4377.5 4378.7 4406.8 5968.6 5988.0 5988.2 5992.6 6002.3 4394.8 4477.6 4503.1 4520.0 4542.5 4538.4 4539.6 4556.8 4556.9 4592.2 5005.7 5042.2 5065.7 5069.6 5077.4 5738.4 5755.2 5839.6 5849.1 5906.1 1433.9 1441.6 1445.0 1451.4 1455.5 992.6 1014.9 1018.2 1030.8 1033.4 5462.7 5470.5 5534.4 5534.5 5567.3 5669.7 5692.5 5705.5 5769.6 5771.2 5345.1 5367.5 5371.4 5419.6 5516.9 2976.8 3000.0 3028.7 3029.5 3044.3 5655.6 5866.6 5888.1 5889.8 5958.7 5820.3 5826.8 5849.5 5881.4 5881.4 5966.8 5974.3 5978.2 6016.5 6075.6 5558.4 5623.3 5658.7 5671.6 5765.8 5592.5 5606.0 5610.4 5633.8 5682.5 5682.1 5870.7 5874.2 6012.2 6027.4 4084.7 4141.6 4144.2 4146.9 4171.4 5690.6 5716.0 5721.3 5733.6 5881.1 5665.8 5682.8 5726.6 5729.8 5732.8 5705.5 5739.7 5748.5 5751.8 5790.9 5542.4 5696.3 5708.7 5720.9 5734.9 5743.4 5776.5 5794.4 5805.7 5853.4 5462.6 5578.5 5676.2 5676.3 5751.4 08:31:35 INFO - PROCESS | 16030 | 08:31:35 INFO - PROCESS | 16030 | [#5] yui.html Cycles:180 Average:18094.80 Median:46673.76 stddev:22440.05 (48.1%) stddev-sans-first:22465.42 08:31:35 INFO - PROCESS | 16030 | Values: 800.2 807.3 824.1 911.8 939.9 16379.9 17563.7 17885.7 17966.6 18154.1 15725.3 16048.0 16161.3 16357.5 16484.7 826.5 841.0 841.5 844.5 848.7 817.2 840.9 845.4 858.1 858.4 887.7 893.5 897.3 898.9 903.5 890.4 895.9 896.5 901.4 903.2 652.3 659.4 660.1 661.3 662.4 17322.9 17535.9 17745.1 17773.5 17890.6 16139.6 16363.5 16402.3 16468.2 16765.2 13499.2 13519.5 13680.9 13733.7 13739.1 4028.1 4041.4 4048.0 4079.5 4096.2 55612.0 66449.3 67621.3 68776.3 82233.0 12285.9 12411.4 12641.8 12784.4 13147.5 21890.6 22950.5 22951.3 23314.0 23585.2 8531.2 8590.7 8921.4 8961.3 8968.9 4798.5 4971.1 4981.3 5030.6 5053.1 3762.9 3815.8 3853.5 3866.8 3871.7 698.8 704.4 707.4 707.9 715.6 644.7 645.9 665.8 668.6 671.7 11130.6 11268.8 11309.3 11425.4 11575.7 687.3 693.8 717.7 719.8 722.9 5360.6 5381.2 5486.2 5490.4 5504.9 65502.0 79674.0 83990.0 84114.0 87652.6 74083.6 74457.6 75599.2 76293.0 76568.6 56143.0 62254.4 62984.4 64265.4 64824.7 10185.0 10374.3 10443.2 10538.2 10605.8 46324.0 47023.5 47283.5 47463.8 47857.0 56023.4 56838.0 57507.4 57560.0 58454.7 12645.4 12650.9 12739.2 12797.4 12888.8 13004.7 13010.2 13109.8 13311.3 13427.8 13247.9 13316.8 13352.8 13476.1 13753.7 13074.7 13341.9 13344.2 13468.7 13565.9 13522.1 13600.9 13699.6 13750.0 13762.2 10464.4 10607.2 10619.6 11003.3 11061.8 10837.9 10988.9 11044.6 11076.6 11100.4 08:31:35 INFO - PROCESS | 16030 | -------- Summary: end -------- 08:31:35 INFO - PROCESS | 16030 | 08:31:36 INFO - TEST-INFO | 16030: exit 0 08:31:36 INFO - TEST-OK | dromaeo_css | took 1111809ms 08:31:36 INFO - TEST-START | kraken 08:31:36 INFO - operating with platform_type : linux_ 08:31:36 INFO - Initialising browser for kraken test... 08:31:36 INFO - TEST-INFO | started process 16402 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpEV3jNQ/profile http://localhost:43131/getInfo.html) 08:31:40 INFO - PROCESS | 16402 | __metrics Screen width/height:1600/1200 08:31:40 INFO - PROCESS | 16402 | colorDepth:24 08:31:40 INFO - PROCESS | 16402 | Browser inner width/height: 1024/697 08:31:40 INFO - PROCESS | 16402 | __metrics 08:31:41 INFO - PROCESS | 16402 | 1486398701165 addons.xpi WARN Exception running bootstrap method shutdown on shield-recipe-client@mozilla.org: ReferenceError: LogManager is not defined (resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/firefox/browser/features/shield-recipe-client@mozilla.org.xpi!/bootstrap.js:65:3) JS Stack trace: this.shutdown@resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/firefox/browser/features/shield-recipe-client@bootstrap.js:65:3 < callBootstrapMethod@XPIProvider.jsm:4903:11 < observe@XPIProvider.jsm:2884:15 < permitUnload@remote-browser.xml:353:13 < CanCloseWindow@browser.js:6277:36 < canClose@browser.js:5143:12 < forceQuit@jar:file:///tmp/tmpEV3jNQ/profile/extensions/talos-powers@TalosPowersService.js:238:7 < whenDone@jar:file:///tmp/tmpEV3jNQ/profile/extensions/talos-powers@TalosPowersService.js:223:9 < promise callback*forceQuit@jar:file:///tmp/tmpEV3jNQ/profile/extensions/talos-powers@TalosPowersService.js:225:7 < receiveMessage@jar:file:///tmp/tmpEV3jNQ/profile/extensions/talos-powers@TalosPowersService.js:55:9 08:31:41 ERROR - PROCESS | 16402 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3280: TypeError: this.tabs is undefined 08:31:42 INFO - TEST-INFO | 16402: exit 0 08:31:42 INFO - Browser initialized. 08:31:42 INFO - Running cycle 1/1 for kraken test... 08:31:42 INFO - TEST-INFO | started process 16530 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpEV3jNQ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:31:53 INFO - PROCESS | 16530 | RSS: Main: 144887808 08:31:53 INFO - PROCESS | 16530 | 08:31:56 INFO - PROCESS | 16530 | Cycle 1(1): loaded http://localhost:43131/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:43131/tests/kraken/driver.html?testName=audio-beat-detection) 08:31:57 INFO - PROCESS | 16530 | RSS: Main: 151597056 08:31:57 INFO - PROCESS | 16530 | 08:31:59 INFO - PROCESS | 16530 | Cycle 1(1): loaded http://localhost:43131/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:43131/tests/kraken/driver.html?testName=audio-dft) 08:32:00 INFO - PROCESS | 16530 | RSS: Main: 150765568 08:32:00 INFO - PROCESS | 16530 | 08:32:03 INFO - PROCESS | 16530 | Cycle 1(1): loaded http://localhost:43131/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:43131/tests/kraken/driver.html?testName=audio-fft) 08:32:03 INFO - PROCESS | 16530 | RSS: Main: 150650880 08:32:03 INFO - PROCESS | 16530 | 08:32:06 INFO - PROCESS | 16530 | Cycle 1(1): loaded http://localhost:43131/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:43131/tests/kraken/driver.html?testName=audio-oscillator) 08:32:06 INFO - PROCESS | 16530 | RSS: Main: 150261760 08:32:06 INFO - PROCESS | 16530 | 08:32:08 INFO - PROCESS | 16530 | Cycle 1(1): loaded http://localhost:43131/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:43131/tests/kraken/driver.html?testName=imaging-gaussian-blur) 08:32:09 INFO - PROCESS | 16530 | RSS: Main: 150409216 08:32:09 INFO - PROCESS | 16530 | 08:32:12 INFO - PROCESS | 16530 | Cycle 1(1): loaded http://localhost:43131/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:43131/tests/kraken/driver.html?testName=imaging-darkroom) 08:32:12 INFO - PROCESS | 16530 | RSS: Main: 153518080 08:32:12 INFO - PROCESS | 16530 | 08:32:16 INFO - PROCESS | 16530 | Cycle 1(1): loaded http://localhost:43131/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:43131/tests/kraken/driver.html?testName=imaging-desaturate) 08:32:16 INFO - PROCESS | 16530 | RSS: Main: 154116096 08:32:16 INFO - PROCESS | 16530 | 08:32:19 INFO - PROCESS | 16530 | Cycle 1(1): loaded http://localhost:43131/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:43131/tests/kraken/driver.html?testName=json-parse-financial) 08:32:20 INFO - PROCESS | 16530 | RSS: Main: 153088000 08:32:20 INFO - PROCESS | 16530 | 08:32:21 INFO - PROCESS | 16530 | Cycle 1(1): loaded http://localhost:43131/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:43131/tests/kraken/driver.html?testName=json-stringify-tinderbox) 08:32:22 INFO - PROCESS | 16530 | RSS: Main: 152989696 08:32:22 INFO - PROCESS | 16530 | 08:32:24 INFO - PROCESS | 16530 | Cycle 1(1): loaded http://localhost:43131/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:43131/tests/kraken/driver.html?testName=stanford-crypto-aes) 08:32:25 INFO - PROCESS | 16530 | RSS: Main: 152326144 08:32:25 INFO - PROCESS | 16530 | 08:32:27 INFO - PROCESS | 16530 | Cycle 1(1): loaded http://localhost:43131/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:43131/tests/kraken/driver.html?testName=stanford-crypto-ccm) 08:32:27 INFO - PROCESS | 16530 | RSS: Main: 152887296 08:32:27 INFO - PROCESS | 16530 | 08:32:30 INFO - PROCESS | 16530 | Cycle 1(1): loaded http://localhost:43131/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:43131/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 08:32:30 INFO - PROCESS | 16530 | RSS: Main: 153067520 08:32:30 INFO - PROCESS | 16530 | 08:32:33 INFO - PROCESS | 16530 | Cycle 1(1): loaded http://localhost:43131/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:43131/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 08:32:34 INFO - PROCESS | 16530 | RSS: Main: 153374720 08:32:34 INFO - PROCESS | 16530 | 08:32:35 INFO - PROCESS | 16530 | Cycle 1(1): loaded http://localhost:43131/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:43131/tests/kraken/driver.html?testName=ai-astar) 08:32:36 INFO - PROCESS | 16530 | RSS: Main: 155115520 08:32:36 INFO - PROCESS | 16530 | 08:32:36 INFO - PROCESS | 16530 | __start_tp_report 08:32:36 INFO - PROCESS | 16530 | _x_x_mozilla_page_load 08:32:36 INFO - PROCESS | 16530 | _x_x_mozilla_page_load_details 08:32:36 INFO - PROCESS | 16530 | |i|pagename|runs| 08:32:36 INFO - PROCESS | 16530 | |0;ai-astar;104;112;113;112;112;113;111;113;112;112 08:32:36 INFO - PROCESS | 16530 | |1;audio-beat-detection;149;117;121;159;121;119;118;120;137;124 08:32:36 INFO - PROCESS | 16530 | |2;audio-dft;162;163;165;162;161;163;163;164;162;160 08:32:36 INFO - PROCESS | 16530 | |3;audio-fft;75;76;76;108;76;75;76;75;91;76 08:32:36 INFO - PROCESS | 16530 | |4;audio-oscillator;82;87;105;86;86;85;93;87;84;102 08:32:36 INFO - PROCESS | 16530 | |5;imaging-gaussian-blur;119;118;117;118;118;118;118;118;118;117 08:32:36 INFO - PROCESS | 16530 | |6;imaging-darkroom;148;148;147;149;148;148;147;149;148;148 08:32:36 INFO - PROCESS | 16530 | |7;imaging-desaturate;95;96;96;97;96;96;96;96;96;96 08:32:36 INFO - PROCESS | 16530 | |8;json-parse-financial;53;54;54;53;56;54;60;54;54;57 08:32:36 INFO - PROCESS | 16530 | |9;json-stringify-tinderbox;65;67;66;65;65;65;67;64;64;65 08:32:36 INFO - PROCESS | 16530 | |10;stanford-crypto-aes;77;80;76;89;75;77;76;76;76;78 08:32:36 INFO - PROCESS | 16530 | |11;stanford-crypto-ccm;129;130;124;126;128;120;131;121;157;120 08:32:36 INFO - PROCESS | 16530 | |12;stanford-crypto-pbkdf2;156;155;162;158;156;159;158;155;160;154 08:32:36 INFO - PROCESS | 16530 | |13;stanford-crypto-sha256-iterative;63;61;64;67;63;63;60;60;59;60 08:32:36 INFO - PROCESS | 16530 | __end_tp_report 08:32:36 INFO - PROCESS | 16530 | __start_cc_report 08:32:36 INFO - PROCESS | 16530 | _x_x_mozilla_cycle_collect,708 08:32:36 INFO - PROCESS | 16530 | __end_cc_report 08:32:36 INFO - PROCESS | 16530 | __startTimestamp1486398756182__endTimestamp 08:32:36 INFO - PROCESS | 16530 | 08:32:36 INFO - PROCESS | 16530 | ------- Summary: start ------- 08:32:36 INFO - PROCESS | 16530 | Number of tests: 14 08:32:36 INFO - PROCESS | 16530 | 08:32:36 INFO - PROCESS | 16530 | [#0] ai-astar Cycles:10 Average:111.40 Median:112.00 stddev:2.67 (2.4%) stddev-sans-first:0.67 08:32:36 INFO - PROCESS | 16530 | Values: 104.0 112.0 113.0 112.0 112.0 113.0 111.0 113.0 112.0 112.0 08:32:36 INFO - PROCESS | 16530 | 08:32:36 INFO - PROCESS | 16530 | [#1] audio-beat-detection Cycles:10 Average:128.50 Median:122.50 stddev:14.76 (12.0%) stddev-sans-first:13.66 08:32:36 INFO - PROCESS | 16530 | Values: 149.0 117.0 121.0 159.0 121.0 119.0 118.0 120.0 137.0 124.0 08:32:36 INFO - PROCESS | 16530 | 08:32:36 INFO - PROCESS | 16530 | [#2] audio-dft Cycles:10 Average:162.50 Median:163.00 stddev:1.43 (0.9%) stddev-sans-first:1.51 08:32:36 INFO - PROCESS | 16530 | Values: 162.0 163.0 165.0 162.0 161.0 163.0 163.0 164.0 162.0 160.0 08:32:36 INFO - PROCESS | 16530 | 08:32:36 INFO - PROCESS | 16530 | [#3] audio-fft Cycles:10 Average:80.40 Median:76.00 stddev:10.84 (14.3%) stddev-sans-first:11.32 08:32:36 INFO - PROCESS | 16530 | Values: 75.0 76.0 76.0 108.0 76.0 75.0 76.0 75.0 91.0 76.0 08:32:36 INFO - PROCESS | 16530 | 08:32:36 INFO - PROCESS | 16530 | [#4] audio-oscillator Cycles:10 Average:89.70 Median:86.00 stddev:7.83 (9.1%) stddev-sans-first:7.80 08:32:36 INFO - PROCESS | 16530 | Values: 82.0 87.0 105.0 86.0 86.0 85.0 93.0 87.0 84.0 102.0 08:32:36 INFO - PROCESS | 16530 | 08:32:36 INFO - PROCESS | 16530 | [#5] imaging-gaussian-blur Cycles:10 Average:117.90 Median:118.00 stddev:0.57 (0.5%) stddev-sans-first:0.44 08:32:36 INFO - PROCESS | 16530 | Values: 119.0 118.0 117.0 118.0 118.0 118.0 118.0 118.0 118.0 117.0 08:32:36 INFO - PROCESS | 16530 | 08:32:36 INFO - PROCESS | 16530 | [#6] imaging-darkroom Cycles:10 Average:148.00 Median:148.00 stddev:0.67 (0.5%) stddev-sans-first:0.71 08:32:36 INFO - PROCESS | 16530 | Values: 148.0 148.0 147.0 149.0 148.0 148.0 147.0 149.0 148.0 148.0 08:32:36 INFO - PROCESS | 16530 | 08:32:36 INFO - PROCESS | 16530 | [#7] imaging-desaturate Cycles:10 Average:96.00 Median:96.00 stddev:0.47 (0.5%) stddev-sans-first:0.33 08:32:36 INFO - PROCESS | 16530 | Values: 95.0 96.0 96.0 97.0 96.0 96.0 96.0 96.0 96.0 96.0 08:32:36 INFO - PROCESS | 16530 | 08:32:36 INFO - PROCESS | 16530 | [#8] json-parse-financial Cycles:10 Average:54.90 Median:54.00 stddev:2.18 (4.0%) stddev-sans-first:2.20 08:32:36 INFO - PROCESS | 16530 | Values: 53.0 54.0 54.0 53.0 56.0 54.0 60.0 54.0 54.0 57.0 08:32:36 INFO - PROCESS | 16530 | 08:32:36 INFO - PROCESS | 16530 | [#9] json-stringify-tinderbox Cycles:10 Average:65.30 Median:65.00 stddev:1.06 (1.6%) stddev-sans-first:1.12 08:32:36 INFO - PROCESS | 16530 | Values: 65.0 67.0 66.0 65.0 65.0 65.0 67.0 64.0 64.0 65.0 08:32:36 INFO - PROCESS | 16530 | 08:32:36 INFO - PROCESS | 16530 | [#10] stanford-crypto-aes Cycles:10 Average:78.00 Median:77.00 stddev:4.11 (5.3%) stddev-sans-first:4.34 08:32:36 INFO - PROCESS | 16530 | Values: 77.0 80.0 76.0 89.0 75.0 77.0 76.0 76.0 76.0 78.0 08:32:36 INFO - PROCESS | 16530 | 08:32:36 INFO - PROCESS | 16530 | [#11] stanford-crypto-ccm Cycles:10 Average:128.60 Median:128.50 stddev:10.79 (8.4%) stddev-sans-first:11.45 08:32:36 INFO - PROCESS | 16530 | Values: 129.0 130.0 124.0 126.0 128.0 120.0 131.0 121.0 157.0 120.0 08:32:36 INFO - PROCESS | 16530 | 08:32:36 INFO - PROCESS | 16530 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:157.30 Median:158.00 stddev:2.54 (1.6%) stddev-sans-first:2.65 08:32:36 INFO - PROCESS | 16530 | Values: 156.0 155.0 162.0 158.0 156.0 159.0 158.0 155.0 160.0 154.0 08:32:36 INFO - PROCESS | 16530 | 08:32:36 INFO - PROCESS | 16530 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:62.00 Median:63.00 stddev:2.45 (3.9%) stddev-sans-first:2.57 08:32:36 INFO - PROCESS | 16530 | Values: 63.0 61.0 64.0 67.0 63.0 63.0 60.0 60.0 59.0 60.0 08:32:36 INFO - PROCESS | 16530 | -------- Summary: end -------- 08:32:36 INFO - PROCESS | 16530 | 08:32:37 INFO - TEST-INFO | 16530: exit 0 08:32:37 INFO - TEST-OK | kraken | took 60848ms 08:32:37 INFO - SUITE-END | took 1172s 08:32:37 INFO - Completed test suite (00:19:32) 08:32:37 INFO - javascript benchmark 08:32:37 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7623.1842205515095, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3247.9837600811998, 3251.1872031992, 3267.1505408593757, 3287.654796246394, 3288.309455014447, 5504.724763761811, 5568.443155684429, 5568.554515638749, 5582.0, 5588.217649529059, 5549.445055494449, 5613.326400831896, 5625.943740562593, 5627.324721033471, 5663.575231857617, 5080.974595127029, 5116.462771408986, 5165.509276618715, 5185.196294574328, 5216.3218781558535, 5133.153029750087, 5168.48315168482, 5172.741362931857, 5180.922286165711, 5182.792688292483, 4911.410630724318, 4923.483034281403, 5159.045576568328, 5163.81926632568, 5192.091384007784, 4966.106100901854, 4990.800367985276, 4995.825146119886, 5041.899162016776, 5102.38771347437, 4955.058538877602, 4975.502449755032, 5028.472010438888, 5044.142495775727, 5078.339815823956, 5382.2464854920345, 5430.782768689248, 5439.646422982533, 5509.118541033416, 5535.114381698909, 5802.506786923117, 5833.183354330397, 5847.8538036549, 5900.734466948955, 5977.910331345033, 5943.970280148572, 5973.432523910222, 5976.103584462322, 5980.491658209057, 5995.040793473024, 5530.253415788898, 5531.0873705838485, 5537.252470916455, 5546.667199968015, 5563.499285064364, 5820.35976042635, 5843.035899076604, 6001.819945401558, 6030.065339872327, 6053.092036194518, 5827.504662103684, 5884.676342801187, 5893.823185304448, 5908.911366329508, 5929.407059294036, 5927.644341339534, 5967.1347654589845, 5979.880402392015, 5983.670898100646, 5986.491148252448, 5767.134929760569, 5814.854628634233, 5924.585279030426, 5957.6127551709, 5966.463018328284, 5967.254093238345, 5969.820905372846, 5970.940290597126, 5975.19334889793, 6002.339742628307, 4577.153226653079, 4583.289590113538, 4585.060062687141, 4586.931196032062, 4617.630589552828, 3968.1270120573427, 3978.3634618460906, 4040.8585699500377, 4070.531888832822, 4082.6325630692786, 5806.21616081832, 5807.82576522705, 5865.237519122486, 5901.262342207224, 5907.497862681635, 5962.493188078975, 5979.970100149471, 6002.879942401128, 6027.517798576104, 6045.0, 5633.183188437735, 5698.629589076697, 5698.6580805151825, 5758.654480731169, 5824.621399609012, 5038.874028149326, 5040.042391945519, 5049.26785616091, 5060.089183946851, 5067.442581316052, 6181.0, 6184.81445556634, 6187.133801267826, 6188.4739797116845, 6190.257169139642, 5859.794907178229, 5866.911996319973, 5890.882182356243, 5914.02418600926, 5922.585419020799, 6121.635889161074, 6139.093519790236, 6179.227596550431, 6188.44304012623, 6202.4417802398, 5786.247787787561, 5862.530997520274, 5894.0, 5897.203877476657, 5921.5558833086825, 5928.584999050197, 5992.820215393545, 5993.400659933972, 6003.129546215687, 6007.459328660441, 5713.7428815704225, 5782.595218334676, 5784.797532086357, 5840.970795145997, 5846.590738648254, 5771.68255745938, 5850.2102216200265, 5880.852978675567, 5891.793787217427, 5891.882162356815, 5802.506786923159, 5855.151003104611, 5856.502197313276, 5859.736311866061, 5869.207656966255, 5724.3703192647945, 5847.181394604844, 5850.970745146247, 5878.3239927407185, 5882.411758824083, 5628.240187574625, 5661.631993920382, 5700.173474846207, 5719.599628026164, 5738.512226460798], "value": 5496.7654373092555, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [545.0934199437163, 603.5443240353533, 609.6159419565673, 697.6720941157657, 707.8179440334641, 45486.54513454864, 46538.53461465384, 50312.0, 50372.0, 50486.747566262165, 51611.0, 52631.47368526314, 52715.472845271535, 52797.2080418794, 52798.73600632001, 9305.813883722338, 10728.73178170548, 11128.721781955475, 11146.108311335074, 11429.485673144729, 10929.071028962548, 10982.725431864188, 10994.945025274863, 11015.118790496781, 11050.392228427434, 11183.664490065312, 11192.888071119267, 11210.103191744682, 11229.550817967312, 11241.887581124207, 11083.168762342817, 11110.500027498781, 11164.0, 11174.27367221128, 11179.552817887316, 10944.850790667024, 11072.335659860353, 11098.112151027899, 11110.0, 11115.166362522843, 43425.78287108576, 44168.779156104014, 44210.55789442096, 44262.778686106365, 44274.55725442737, 4146.523149837747, 4172.937405938914, 4199.538050814408, 4224.4930608327195, 4306.655467562588, 32582.837085814655, 32665.836670816494, 32676.183095422566, 33058.4185602291, 33285.334293314, 4527.750973696446, 4667.509911459316, 4692.741899195543, 4816.349792778, 4820.734859582722, 385148.0, 386182.0, 388369.0, 388560.0, 388922.0, 62980.0, 63263.36736632667, 63345.683271583344, 63491.682541587, 63611.68194159092, 66371.66814165899, 66442.66778666076, 66607.66696166585, 66694.33305666881, 66722.66638666873, 17804.643907121786, 18231.08844557767, 19216.903915480332, 19787.802121978595, 19789.703154452694, 14765.483208087666, 15088.396464141531, 15187.392504299925, 15593.688126237412, 15650.139242341553, 19997.800021999883, 20194.29319973794, 20255.898720506597, 20384.388468345973, 20430.0, 7256.7822965311125, 7402.148752893486, 7591.164971853092, 7595.3164215220895, 7672.769816905502, 986.4820968991337, 993.735578624216, 1018.4398580780542, 1024.7438140464883, 1035.0736091198485, 33379.666203337656, 33684.0, 33918.0, 34168.5536090256, 34308.65691343055, 1082.9404382759024, 1181.303031211572, 1195.9820602690966, 1201.195199216527, 1215.9270443773225, 15907.125108118933, 17280.22238999248, 17987.550311242325, 18239.544011399823, 18317.3588924387, 565604.0, 574084.0, 575421.0, 577000.0, 577657.0, 63157.0, 63788.36211637917, 64036.35963640397, 64128.0, 64180.0, 1558.2158428599191, 1572.5989872582418, 1578.3213218316234, 1589.682063587287, 1613.0241204071367, 32155.839220803748, 32230.516542252353, 32482.51276230811, 32804.50793238151, 33199.66800331966, 53797.0, 54373.45626543684, 54723.17915231355, 54862.72568637131, 55201.72399138139, 496170.0, 496846.0, 498840.0, 499324.0, 499861.0, 29583.0, 29630.0, 30019.849900750356, 30712.846435768573, 32169.0, 48240.517594825, 48455.51544484651, 48708.0, 48883.75558122329, 49986.25020624766, 40387.0, 41067.794661026506, 41649.58350416457, 42431.36352954646, 42689.78655106829, 40293.0, 40709.389359159046, 41640.0, 42257.57742422536, 42390.36414453724, 39958.200835982534, 40505.39241911432, 40904.79547602243, 40991.0, 44504.55495445004, 35277.82361088178, 36246.63753362433, 36667.26665466622, 36831.263374732895, 37008.44487332746, 28380.290492737848, 28401.715982839905, 28581.857090714413, 28717.28206794847, 28742.0], "value": 22018.974134216318, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [424.56906240166217, 432.3860118631544, 437.4444455541462, 441.562852775752, 450.1402321565808, 20245.39263822086, 21625.243116490925, 22125.114995400185, 22193.334199974026, 22466.663000055014, 21986.340409787692, 22579.54840903185, 22712.318630441114, 22841.54316913665, 22962.31113066611, 6056.152138700574, 6196.4113409226275, 6227.43953044226, 6267.404596563342, 6269.4044065813905, 5998.130271110686, 6153.323134455206, 6169.167162433081, 6215.937840621581, 6220.377962203788, 6068.3324834268415, 6111.174991376151, 6117.755289788403, 6133.202683651141, 6148.538859585527, 5960.701964901759, 6113.663748493831, 6140.35526269742, 6143.447089761943, 6158.230221222348, 5477.890442191174, 5486.862828429281, 5500.50495455411, 5540.864122854846, 5541.0, 25700.10049648272, 25765.0, 25988.0, 26138.6079208812, 26430.339241518923, 2724.087430710714, 2781.0683421053973, 2810.985945070282, 2833.759130473912, 2843.7156284371604, 11177.776444471065, 15729.213539322987, 16106.275217615235, 16508.25712842925, 16876.915615421967, 2053.4968932611605, 2056.8663036902553, 2058.073866759964, 2068.88621125838, 2073.637113505146, 95400.52299738457, 96229.51885240599, 96641.0, 96788.51605741926, 98512.0, 11379.943100284445, 11523.539058437736, 11720.765584688259, 11825.88174118265, 11834.76330473403, 16136.515904522883, 16143.434979775651, 16145.838541614668, 16148.515544533682, 16150.03099814015, 9124.17882390588, 9296.30277729173, 9363.719088427359, 9398.624055037859, 9563.139317461462, 9333.57998890038, 9396.389234699722, 9431.170648805331, 9442.480663563432, 9601.711948641552, 7159.0, 7468.253174682488, 7480.5885676287235, 7483.925160748323, 7505.573940951202, 2032.7904896586508, 2036.256766280297, 2084.9478763030743, 2088.561402105575, 2113.8203252723383, 1179.204037274836, 1185.9881401185878, 1187.1333926233897, 1208.9395530223453, 1214.3442541027746, 20750.169993200103, 21196.364109076752, 21555.137794488044, 22404.55190896173, 23031.07875684954, 1006.864073350103, 1019.1184625299063, 1024.2164743970868, 1032.566322144686, 1041.286718597763, 11339.0, 11593.710157245967, 11633.360165190827, 11675.007624352025, 11819.645410637695, 685316.0, 710370.0, 722656.0, 728291.0, 748220.0, 102350.0, 122488.0, 122783.0, 124888.0, 127895.36052319678, 1184.3782014442315, 1186.5550418593027, 1224.3633310678576, 1224.5652793258444, 1229.5327775445273, 18066.90966545159, 18256.269749210413, 18384.448466546026, 18423.0, 18601.627967440305, 47655.76172119117, 48522.27216591824, 48854.0, 49130.75434622804, 50094.24858627051, 65407.0, 67661.0, 68056.319436805, 68358.0, 68768.0, 8134.308583770446, 8317.168283171635, 8336.666533338841, 8358.87461688063, 9399.0, 10291.639792607222, 13983.440662373798, 14035.719285614436, 14256.073355231876, 14431.85568144305, 11370.772584548427, 11495.770084598094, 11649.941750291195, 11776.764464710486, 11836.82244766312, 11553.075753939833, 11692.766144676889, 12077.758444830879, 12566.308853012806, 12666.303353315656, 12271.509139634672, 12282.754344912873, 12354.567590134302, 12488.313142776871, 12506.624801255977, 8211.83576328482, 8555.187257210555, 8747.518886461306, 8853.114688531095, 8882.0673829247, 8475.49147051179, 10391.324563903323, 10958.616448424267, 11073.667789966314, 11209.271397359145], "value": 10343.64566377261, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1455.3814628782766, 1505.4279373837944, 1509.7584386498156, 1511.5012046024813, 1525.916074615896, 8436.325093992482, 8677.479351238915, 9056.184943355096, 9133.817323653522, 9169.762082118912, 9098.13567711068, 9261.444313341204, 9265.444073355586, 9267.907320926788, 9281.953590232057, 2394.892229849661, 2419.842710223839, 2427.0291883246755, 2430.7812296893276, 2437.110454684045, 2433.1483980606736, 2461.4461746107163, 2465.161844972709, 2473.752624737521, 2479.814013948952, 2392.456865321866, 2393.066703985447, 2417.3231495181376, 2423.4062654649633, 2424.599941009731, 2349.0, 2353.5881220786296, 2375.228050883461, 2375.5723969685364, 2380.940476488084, 2293.3005433342823, 2295.896684649178, 2338.088145623208, 2347.3779448446176, 2356.7289761677457, 9213.0, 9216.585253663601, 9256.305777066747, 9257.768555786091, 9284.025177356416, 5470.890582188374, 5544.77820887164, 5571.247881535981, 5583.637063590894, 5606.943930560724, 3400.1499625093725, 3402.9659703403145, 3462.774919630216, 3499.5100685903994, 3543.3799085159994, 1441.617971237623, 1508.630385555535, 1583.6911802198576, 2270.1373478078226, 2274.6701728249313, 12213.084018698544, 12291.139620226499, 12338.074644401706, 12341.629751107392, 12341.93829030858, 4422.270325396338, 4644.419447569054, 4715.056988602225, 4748.0978614063215, 4783.808647654125, 9988.101070903653, 10029.598816047277, 10070.496475176358, 10081.798364032678, 10114.645987390553, 5517.44825517445, 5537.8061767837935, 5550.72246387679, 5574.721263936787, 5581.581381396411, 4992.650514463952, 5120.974395128001, 5122.257272695439, 5182.170852663556, 5235.528802407802, 3863.130795570974, 3993.7803420812133, 4003.499562554681, 4064.573219811877, 4084.591540845892, 1215.805471124616, 1220.5117952818944, 1229.551213806954, 1230.6923269182705, 1242.1118899986552, 981.7202097402206, 1009.0817356205818, 1009.4195837393528, 1016.598443614768, 1021.3973755484151, 5863.970680146572, 5873.911891321633, 5915.497182739516, 6039.063945088518, 6060.303065147476, 633.832034510855, 654.8722999015241, 659.1102012283475, 662.9933700663028, 664.4319107163305, 3879.4568760373572, 3938.487996560486, 3982.482277303932, 4097.631213190827, 4207.095474473003, 10104.949475252724, 10400.427976461368, 10477.47612619366, 10496.26526143178, 10498.107660848913, 10214.285000050073, 10317.123044541298, 10399.688009359732, 10419.739506512398, 10436.686899393031, 7930.206979302024, 8124.350051995826, 8210.220029097227, 8211.917880821355, 8232.794180145544, 5793.36273009977, 5819.883602328015, 5920.703964801656, 5923.851903702442, 5956.672383018976, 9440.763980900258, 9492.477913714536, 9547.140757331874, 9549.713508594754, 9657.372270802376, 9482.336236463658, 9487.098725621056, 9593.376430532273, 9643.566039528378, 9672.516374181403, 7089.432845372461, 7288.96355518219, 7885.0, 8097.514149151069, 8137.064237612751, 8888.111188881061, 8966.417182883091, 8967.10328967098, 8967.282617390463, 8970.686025989058, 7202.855942881009, 7327.963360183165, 7366.742164024234, 7522.887156692764, 7530.661120249492, 7109.893351599627, 7112.431005519443, 7133.464990125865, 7167.784966451015, 7177.102862142232, 6290.968545157428, 6382.329855365306, 6390.7763228286785, 6394.0408938659575, 6398.13625160616, 5004.224345226496, 5046.6719663221775, 5057.165567681292, 5059.443461219336, 5208.166693329201, 5011.348524691767, 5037.546620804145, 5149.2276158576515, 5157.6647517911215, 5177.0940085485645], "value": 4658.5764948793, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [404.14724930396875, 408.10624731837277, 413.94618699569054, 424.5966331984615, 424.9341352090426, 5154.458781827911, 5301.496357846008, 5464.754086066127, 5532.723363831808, 5534.363548191954, 5256.316678831756, 5429.131338985763, 5431.538319242859, 5436.320459942507, 5455.863603409907, 4406.713563618355, 4409.536998615139, 4410.603045725884, 4412.87471694719, 4432.844850430236, 4309.978450107745, 4376.452943382077, 4382.189294980439, 4387.956120438803, 4443.400375864686, 4373.671974601918, 4382.5398333175035, 4387.363832244323, 4404.383386325901, 4416.690831641787, 4374.715643483163, 4390.517043125285, 4395.7911574316995, 4398.03243286478, 4435.977820110878, 3902.278078555448, 4022.592092767537, 4038.29329867275, 4038.5557588665224, 4039.0, 5294.947050529522, 5320.52115309624, 5324.946750532484, 5336.30628018359, 5348.8127915523155, 4969.4036715594, 4990.451050384455, 4993.575546078588, 5007.32401125847, 5015.27278544609, 5444.849284532627, 5653.293338332708, 5654.575906807006, 5663.830085097454, 5746.885062298772, 4354.281543545343, 4358.7166834156, 4377.518472967971, 4378.715383500063, 4406.757628330441, 5968.641881487125, 5988.0, 5988.221531200959, 5992.550558708114, 6002.259344790005, 4394.791432356128, 4477.552244775497, 4503.144402563503, 4519.954800451954, 4542.523035081335, 4538.387317712132, 4539.6368290536675, 4556.840510582114, 4556.931646025312, 4592.15045216636, 5005.724685142352, 5042.193249080129, 5065.745743144339, 5069.645124841226, 5077.425997940651, 5738.368779434259, 5755.22304488897, 5839.649621022752, 5849.12827895078, 5906.143609176731, 1433.8566143385788, 1441.6395901024744, 1444.978325325121, 1451.361400983564, 1455.548779878241, 992.5682328187262, 1014.9441780701984, 1018.221060888421, 1030.8402197659375, 1033.3696445168441, 5462.672239665632, 5470.452954704498, 5534.363548191929, 5534.540911930044, 5567.276254086943, 5669.744861481243, 5692.459216374438, 5705.5435565154685, 5769.567282453832, 5771.249737534094, 5345.102488616563, 5367.5169234769055, 5371.435999220103, 5419.647722897999, 5516.9448305516435, 2976.821390716564, 3000.0, 3028.712272334125, 3029.469842777505, 3044.254157731326, 5655.575831812631, 5866.624017273011, 5888.116782482576, 5889.764409423575, 5958.672273025025, 5820.330661973842, 5826.796062137805, 5849.532037436995, 5881.3530511643685, 5881.382949486121, 5966.761329546856, 5974.312954010257, 5978.1929439525975, 6016.488598469179, 6075.605085669506, 5558.388577256418, 5623.325200975909, 5658.745356458887, 5671.610455438444, 5765.799981010412, 5592.51798273466, 5605.990921634145, 5610.382857885547, 5633.802816901389, 5682.488576028178, 5682.14767784819, 5870.735816888165, 5874.206982057368, 6012.248468941382, 6027.397260273938, 4084.652804511531, 4141.618569322592, 4144.191882582988, 4146.875593732193, 4171.416001759695, 5690.601657884074, 5716.0, 5721.256236689203, 5733.569982251432, 5881.117832325185, 5665.773369065191, 5682.772689092555, 5726.570507211893, 5729.770809167587, 5732.799352022659, 5705.546614955609, 5739.684317362418, 5748.45389687979, 5751.769929202785, 5790.904004476034, 5542.445755424425, 5696.344920334214, 5708.65748055118, 5720.914186287126, 5734.913976290442, 5743.368229494836, 5776.451237132465, 5794.449527294901, 5805.651660900359, 5853.443922827325, 5462.617616766788, 5578.525825304732, 5676.211993222122, 5676.262085928968, 5751.367349591458], "value": 4426.167818166022, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [800.1988071570573, 807.2694211738378, 824.0523398092193, 911.84498635232, 939.887213534376, 16379.918100409495, 17563.73654395185, 17885.7317140243, 17966.5508362291, 18154.09229538521, 15725.292361843716, 16048.0, 16161.272742726576, 16357.509274721777, 16484.67030659389, 826.4627991805314, 840.9789755256106, 841.4656692999928, 844.543946269017, 848.6987119572556, 817.2318021060214, 840.8780726794611, 845.3913182508614, 858.0561382479254, 858.3948316436928, 887.7425546591513, 893.5442924108719, 897.2687259883174, 898.9056149104348, 903.5346796399859, 890.447922288179, 895.9238464730506, 896.5203616065373, 901.432097778402, 903.2006674093409, 652.2759736692268, 659.3867703036175, 660.1418156396666, 661.256086902235, 662.4038365471115, 17322.91338543312, 17535.912320438445, 17745.11274436273, 17773.46679599614, 17890.642187156183, 16139.596510087342, 16363.509094727176, 16402.26189821461, 16468.176591170395, 16765.24556394965, 13499.190048597018, 13519.526816561372, 13680.863191368058, 13733.725325493535, 13739.106958047694, 4028.133951200506, 4041.4139949707424, 4047.9797601011805, 4079.4696689430184, 4096.201240758053, 55612.0, 66449.33876653074, 67621.32378676199, 68776.3122368775, 82233.0, 12285.877141228651, 12411.441485133191, 12641.810372844231, 12784.424700888483, 13147.53983610569, 21890.562188756456, 22950.540989180125, 22951.31146065621, 23314.0, 23585.174518891756, 8531.189536993976, 8590.65637374498, 8921.420107692978, 8961.327900407496, 8968.865467018, 4798.520147985174, 4971.105201063771, 4981.252812078144, 5030.597552195815, 5053.065182941167, 3762.9435558466644, 3815.7901315427916, 3853.479780229633, 3866.8066596670055, 3871.6902647788675, 698.8462538241579, 704.383664293743, 707.4234498883394, 707.8761216787042, 715.5849607227796, 644.7002144003061, 645.8998855177455, 665.8035879415584, 668.5721138471382, 671.684308375063, 11130.640292341985, 11268.830967535494, 11309.264897781617, 11425.428728563538, 11575.652730418102, 687.3229868579446, 693.8334799648048, 717.6878058044767, 719.7732714195116, 722.9277072292729, 5360.624756267024, 5381.165919282517, 5486.1770734389365, 5490.368607610096, 5504.91742623861, 65502.0, 79674.0, 83990.0, 84114.0, 87652.5617371909, 74083.62958185174, 74457.62771186109, 75599.24400756032, 76293.0, 76568.61715691385, 56143.0, 62254.37745622576, 62984.37015629877, 64265.35734642594, 64824.67587662126, 10185.0, 10374.27380083387, 10443.164546836388, 10538.156947444339, 10605.840912386166, 46324.0, 47023.52976470192, 47283.527164727915, 47463.762681186374, 47857.0, 56023.439765603456, 56838.0, 57507.42492575021, 57560.0, 58454.70772646109, 12645.430955606837, 12650.873491264969, 12739.171953822972, 12797.424115914993, 12888.806667899802, 13004.739905202032, 13010.154339967872, 13109.803352949904, 13311.33443327849, 13427.798583021067, 13247.933760331136, 13316.800247996482, 13352.799708004193, 13476.124051936593, 13753.656158596115, 13074.673133171747, 13341.933290333487, 13344.199348039148, 13468.730625387241, 13565.93217033948, 13522.101714132314, 13600.93199533996, 13699.589012329647, 13750.037497375088, 13762.174269543859, 10464.424456654957, 10607.151427885905, 10619.628313009007, 11003.284786488852, 11061.834072488758, 10837.945810270898, 10988.945055274673, 11044.613438529614, 11076.612318568812, 11100.389478578756], "value": 7601.724051783937, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1480.4999999999998, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [104.0, 112.0, 113.0, 112.0, 112.0, 113.0, 111.0, 113.0, 112.0, 112.0], "value": 111.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 117.0, 121.0, 159.0, 121.0, 119.0, 118.0, 120.0, 137.0, 124.0], "value": 128.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 163.0, 165.0, 162.0, 161.0, 163.0, 163.0, 164.0, 162.0, 160.0], "value": 162.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 76.0, 108.0, 76.0, 75.0, 76.0, 75.0, 91.0, 76.0], "value": 80.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 87.0, 105.0, 86.0, 86.0, 85.0, 93.0, 87.0, 84.0, 102.0], "value": 89.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [119.0, 118.0, 117.0, 118.0, 118.0, 118.0, 118.0, 118.0, 118.0, 117.0], "value": 117.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 148.0, 147.0, 149.0, 148.0, 148.0, 147.0, 149.0, 148.0, 148.0], "value": 148.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 96.0, 96.0, 97.0, 96.0, 96.0, 96.0, 96.0, 96.0, 96.0], "value": 96.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 54.0, 54.0, 53.0, 56.0, 54.0, 60.0, 54.0, 54.0, 57.0], "value": 54.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 67.0, 66.0, 65.0, 65.0, 65.0, 67.0, 64.0, 64.0, 65.0], "value": 65.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 80.0, 76.0, 89.0, 75.0, 77.0, 76.0, 76.0, 76.0, 78.0], "value": 78.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [129.0, 130.0, 124.0, 126.0, 128.0, 120.0, 131.0, 121.0, 157.0, 120.0], "value": 128.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [156.0, 155.0, 162.0, 158.0, 156.0, 159.0, 158.0, 155.0, 160.0, 154.0], "value": 157.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 61.0, 64.0, 67.0, 63.0, 63.0, 60.0, 60.0, 59.0, 60.0], "value": 62.0, "unit": "score"}]}]} 08:32:37 INFO - Return code: 0 08:32:37 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 08:32:37 ERROR - # TBPL SUCCESS # 08:32:37 INFO - Running post-action listener: _resource_record_post_action 08:32:37 INFO - [mozharness: 2017-02-06 16:32:37.509889Z] Finished run-tests step (success) 08:32:37 INFO - Running post-run listener: _resource_record_post_run 08:32:37 INFO - Total resource usage - Wall time: 1190s; CPU: 13.0%; Read bytes: 266240; Write bytes: 363339776; Read time: 28; Write time: 259188 08:32:37 INFO - TinderboxPrint: CPU usage
13.3% 08:32:37 INFO - TinderboxPrint: I/O read bytes / time
266,240 / 28 08:32:37 INFO - TinderboxPrint: I/O write bytes / time
363,339,776 / 259,188 08:32:37 INFO - TinderboxPrint: CPU idle
8,227.4 (86.6%) 08:32:37 INFO - TinderboxPrint: CPU user
1,210.2 (12.7%) 08:32:37 INFO - TinderboxPrint: Swap in / out
0 / 0 08:32:37 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 110198784; Read time: 0; Write time: 112024 08:32:37 INFO - run-tests - Wall time: 1173s; CPU: 13.0%; Read bytes: 266240; Write bytes: 253140992; Read time: 28; Write time: 147164 08:32:38 INFO - Running post-run listener: _upload_blobber_files 08:32:38 INFO - Blob upload gear active. 08:32:38 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 08:32:38 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 08:32:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 08:32:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 08:32:38 INFO - (blobuploader) - INFO - Open directory for files ... 08:32:38 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 08:32:38 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:32:38 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:32:39 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 08:32:39 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:32:39 INFO - (blobuploader) - INFO - Done attempting. 08:32:39 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 08:32:39 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:32:39 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:32:40 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 08:32:40 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:32:40 INFO - (blobuploader) - INFO - Done attempting. 08:32:40 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 08:32:40 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:32:40 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:32:43 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 08:32:43 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:32:43 INFO - (blobuploader) - INFO - Done attempting. 08:32:43 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 08:32:43 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:32:43 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:32:44 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 08:32:44 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:32:44 INFO - (blobuploader) - INFO - Done attempting. 08:32:44 INFO - (blobuploader) - INFO - Iteration through files over. 08:32:44 INFO - Return code: 0 08:32:44 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 08:32:44 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 08:32:44 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/1b07fe7f278ec510250d11e8ef48db8d290bfcc4ed77db856128b162c28a58bad468ac285572eaa4c1a72c9c58f8b56ec758c511fd580e739170a9e0d2eaa5bc", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/15a3debf6edf6cbdb6b66f2792a55335b4acda6cc5bda05f2054141d7cc23ba57275d6bc4e4095a79de4b323d1049ed955ea9c00b14311774e8fb019bb2b7984", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/a69c98b38aff46d2b8eb399debbf7db208462b89c2ace48d5694b03a621d058154071e052dd67d33294240e7ba1ce11b755c6b4b09a2e25278ea47cdf64cb024", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/977aa5b95744bbfe37875b4db0e3ceec604a05924747cb1fc3c32e35807ed0c643fea8466e2b96505e5e555e0d0e08695fb057ccdfc3ec7901ef04451cd7544b"} 08:32:44 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 08:32:44 INFO - Writing to file /builds/slave/test/properties/blobber_files 08:32:44 INFO - Contents: 08:32:44 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/1b07fe7f278ec510250d11e8ef48db8d290bfcc4ed77db856128b162c28a58bad468ac285572eaa4c1a72c9c58f8b56ec758c511fd580e739170a9e0d2eaa5bc", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/15a3debf6edf6cbdb6b66f2792a55335b4acda6cc5bda05f2054141d7cc23ba57275d6bc4e4095a79de4b323d1049ed955ea9c00b14311774e8fb019bb2b7984", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/a69c98b38aff46d2b8eb399debbf7db208462b89c2ace48d5694b03a621d058154071e052dd67d33294240e7ba1ce11b755c6b4b09a2e25278ea47cdf64cb024", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/977aa5b95744bbfe37875b4db0e3ceec604a05924747cb1fc3c32e35807ed0c643fea8466e2b96505e5e555e0d0e08695fb057ccdfc3ec7901ef04451cd7544b"} 08:32:44 INFO - Running post-run listener: copy_logs_to_upload_dir 08:32:44 INFO - Copying logs to upload dir... 08:32:44 INFO - mkdir: /builds/slave/test/build/upload/logs 08:32:44 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1234.716238 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 34 secs) (at 2017-02-06 08:32:44.330392) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-06 08:32:44.334068) ========= 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=9e0dfe3369c33a1556e63f89000001d8-1486397528.248384-154576822 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/1b07fe7f278ec510250d11e8ef48db8d290bfcc4ed77db856128b162c28a58bad468ac285572eaa4c1a72c9c58f8b56ec758c511fd580e739170a9e0d2eaa5bc", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/15a3debf6edf6cbdb6b66f2792a55335b4acda6cc5bda05f2054141d7cc23ba57275d6bc4e4095a79de4b323d1049ed955ea9c00b14311774e8fb019bb2b7984", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/a69c98b38aff46d2b8eb399debbf7db208462b89c2ace48d5694b03a621d058154071e052dd67d33294240e7ba1ce11b755c6b4b09a2e25278ea47cdf64cb024", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/977aa5b95744bbfe37875b4db0e3ceec604a05924747cb1fc3c32e35807ed0c643fea8466e2b96505e5e555e0d0e08695fb057ccdfc3ec7901ef04451cd7544b"} build_url:https://queue.taskcluster.net/v1/task/FdOqssVsSPi1119XfS4ZPA/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011338 build_url: 'https://queue.taskcluster.net/v1/task/FdOqssVsSPi1119XfS4ZPA/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/1b07fe7f278ec510250d11e8ef48db8d290bfcc4ed77db856128b162c28a58bad468ac285572eaa4c1a72c9c58f8b56ec758c511fd580e739170a9e0d2eaa5bc", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/15a3debf6edf6cbdb6b66f2792a55335b4acda6cc5bda05f2054141d7cc23ba57275d6bc4e4095a79de4b323d1049ed955ea9c00b14311774e8fb019bb2b7984", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/a69c98b38aff46d2b8eb399debbf7db208462b89c2ace48d5694b03a621d058154071e052dd67d33294240e7ba1ce11b755c6b4b09a2e25278ea47cdf64cb024", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/977aa5b95744bbfe37875b4db0e3ceec604a05924747cb1fc3c32e35807ed0c643fea8466e2b96505e5e555e0d0e08695fb057ccdfc3ec7901ef04451cd7544b"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-06 08:32:44.359149) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-02-06 08:32:44.359481) ========= 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=9e0dfe3369c33a1556e63f89000001d8-1486397528.248384-154576822 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004577 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-02-06 08:32:44.445559) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-06 08:32:44.445882) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-06 08:32:44.446193) ========= ========= Total master_lag: 0.17 =========