builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-023 starttime: 1503711452.17 results: success (0) revision: 31465a03c03d1eec31cd4dd5d6b803724dcb29cd ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-08-25 18:37:32.166704) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-08-25 18:37:32.167176) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-08-25 18:37:32.167456) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-08-25 18:37:32.183178) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-25 18:37:32.183443) ========= 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=6d15e502d8e29d5d2676d664000001c3-1503711450.800940-1362830451 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-08-25 18:37:32-- 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% 22.0M=0.001s 2017-08-25 18:37:32 (22.0 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.132391 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-25 18:37:32.330580) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-08-25 18:37:32.330890) ========= 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=6d15e502d8e29d5d2676d664000001c3-1503711450.800940-1362830451 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018077 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-08-25 18:37:32.382760) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-25 18:37:32.386106) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 31465a03c03d1eec31cd4dd5d6b803724dcb29cd --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'python archiver_client.py mozharness --repo mozilla-central --rev 31465a03c03d1eec31cd4dd5d6b803724dcb29cd --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=6d15e502d8e29d5d2676d664000001c3-1503711450.800940-1362830451 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-08-25 18:37:32,439 truncating revision to first 12 chars 2017-08-25 18:37:32,439 Setting DEBUG logging. 2017-08-25 18:37:32,439 attempt 1/10 2017-08-25 18:37:32,439 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/31465a03c03d?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-08-25 18:37:32,939 unpacking tar archive at: mozilla-central-31465a03c03d/testing/mozharness/ program finished with exit code 0 elapsedTime=0.857114 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-25 18:37:33.257848) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-08-25 18:37:33.261202) ========= script_repo_revision: 31465a03c03d1eec31cd4dd5d6b803724dcb29cd ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-08-25 18:37:33.261588) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-08-25 18:37:33.261858) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-08-25 18:37:33.273421) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 49 secs) (at 2017-08-25 18:37:33.273691) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 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', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] 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=6d15e502d8e29d5d2676d664000001c3-1503711450.800940-1362830451 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 18:37:33 INFO - MultiFileLogger online at 20170825 18:37:33 in /builds/slave/test 18:37:33 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 18:37:33 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 18:37:33 INFO - {'append_to_log': False, 18:37:33 INFO - 'base_work_dir': '/builds/slave/test', 18:37:33 INFO - 'blob_upload_branch': 'Firefox', 18:37:33 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 18:37:33 INFO - 'branch': 'Firefox', 18:37:33 INFO - 'buildbot_json_path': 'buildprops.json', 18:37:33 INFO - 'code_coverage': False, 18:37:33 INFO - 'config_files': ('talos/linux_config.py',), 18:37:33 INFO - 'default_actions': ('clobber', 18:37:33 INFO - 'read-buildbot-config', 18:37:33 INFO - 'download-and-extract', 18:37:33 INFO - 'populate-webroot', 18:37:33 INFO - 'create-virtualenv', 18:37:33 INFO - 'install', 18:37:33 INFO - 'setup-mitmproxy', 18:37:33 INFO - 'run-tests'), 18:37:33 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 18:37:33 INFO - 'disable_ccov_upload': False, 18:37:33 INFO - 'download_minidump_stackwalk': True, 18:37:33 INFO - 'download_symbols': 'ondemand', 18:37:33 INFO - 'enable_stylo': False, 18:37:33 INFO - 'enable_webrender': False, 18:37:33 INFO - 'exes': {'tooltool.py': '/tools/tooltool.py'}, 18:37:33 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 18:37:33 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 18:37:33 INFO - 'gecko_profile': False, 18:37:33 INFO - 'gecko_profile_interval': 0, 18:37:33 INFO - 'installer_path': 'installer.exe', 18:37:33 INFO - 'log_level': 'info', 18:37:33 INFO - 'log_name': 'talos', 18:37:33 INFO - 'log_to_console': True, 18:37:33 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 18:37:33 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 18:37:33 INFO - 'opt_config_files': (), 18:37:33 INFO - 'pip_index': False, 18:37:33 INFO - 'suite': 'dromaeojs-e10s', 18:37:33 INFO - 'system_bits': '32', 18:37:33 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 18:37:33 INFO - 'title': 'talos-linux64-ix-023', 18:37:33 INFO - 'tooltool_cache': '/builds/tooltool_cache', 18:37:33 INFO - 'use_talos_json': True, 18:37:33 INFO - 'verify': 'False', 18:37:33 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 18:37:33 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 18:37:33 INFO - 'work_dir': 'build'} 18:37:33 INFO - [mozharness: 2017-08-26 01:37:33.467410Z] Running clobber step. 18:37:33 INFO - Running pre-action listener: _resource_record_pre_action 18:37:33 INFO - Running main action method: clobber 18:37:33 INFO - rmtree: /builds/slave/test/build 18:37:33 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 18:37:35 INFO - Running post-action listener: _resource_record_post_action 18:37:35 INFO - [mozharness: 2017-08-26 01:37:35.012218Z] Finished clobber step (success) 18:37:35 INFO - [mozharness: 2017-08-26 01:37:35.012315Z] Running read-buildbot-config step. 18:37:35 INFO - Running pre-action listener: _resource_record_pre_action 18:37:35 INFO - Running main action method: read_buildbot_config 18:37:35 INFO - Using buildbot properties: 18:37:35 INFO - { 18:37:35 INFO - "project": "", 18:37:35 INFO - "product": "firefox", 18:37:35 INFO - "who": "kwierso@gmail.com", 18:37:35 INFO - "installer_path": "public/build/target.tar.bz2", 18:37:35 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 18:37:35 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 18:37:35 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs-e10s", 18:37:35 INFO - "stage_platform": "linux64-pgo", 18:37:35 INFO - "basedir": "/builds/slave/test", 18:37:35 INFO - "buildnumber": 129, 18:37:35 INFO - "platform": "ubuntu64_hw", 18:37:35 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 18:37:35 INFO - "slavebuilddir": "test", 18:37:35 INFO - "taskId": "PWXbbU_8SESSB2qo0A3iXQ", 18:37:35 INFO - "branch": "mozilla-central", 18:37:35 INFO - "script_repo_revision": "production", 18:37:35 INFO - "revision": "31465a03c03d1eec31cd4dd5d6b803724dcb29cd", 18:37:35 INFO - "slavename": "talos-linux64-ix-023", 18:37:35 INFO - "repo_path": "mozilla-central" 18:37:35 INFO - } 18:37:35 INFO - Finding installer, test and symbols from parent task. 18:37:35 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/PWXbbU_8SESSB2qo0A3iXQ'}, attempt #1 18:37:35 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/PWXbbU_8SESSB2qo0A3iXQ'}, attempt #1 18:37:36 INFO - Task dependencies: amxk63WMTxS--589HMz9Ww 18:37:36 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/amxk63WMTxS--589HMz9Ww'}, attempt #1 18:37:36 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/amxk63WMTxS--589HMz9Ww/artifacts/public/build/target.tar.bz2 18:37:36 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/amxk63WMTxS--589HMz9Ww/artifacts/public/build/target.test_packages.json 18:37:36 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/amxk63WMTxS--589HMz9Ww/artifacts/public/build/target.crashreporter-symbols.zip 18:37:36 INFO - Running post-action listener: _resource_record_post_action 18:37:36 INFO - [mozharness: 2017-08-26 01:37:36.508257Z] Finished read-buildbot-config step (success) 18:37:36 INFO - [mozharness: 2017-08-26 01:37:36.508472Z] Running download-and-extract step. 18:37:36 INFO - Running pre-action listener: _resource_record_pre_action 18:37:36 INFO - Running main action method: download_and_extract 18:37:36 INFO - mkdir: /builds/slave/test/build/tests 18:37:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 18:37:36 INFO - trying https://queue.taskcluster.net/v1/task/amxk63WMTxS--589HMz9Ww/artifacts/public/build/target.test_packages.json 18:37:36 INFO - Downloading https://queue.taskcluster.net/v1/task/amxk63WMTxS--589HMz9Ww/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 18:37:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/amxk63WMTxS--589HMz9Ww/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 18:37:37 INFO - Downloaded 989 bytes. 18:37:37 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 18:37:37 INFO - Using the following test package requirements: 18:37:37 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 18:37:37 INFO - u'common': [u'target.common.tests.zip'], 18:37:37 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 18:37:37 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 18:37:37 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 18:37:37 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 18:37:37 INFO - u'mozbase': [u'target.common.tests.zip'], 18:37:37 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 18:37:37 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 18:37:37 INFO - u'web-platform': [u'target.common.tests.zip', 18:37:37 INFO - u'target.web-platform.tests.tar.gz'], 18:37:37 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 18:37:37 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 18:37:37 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/amxk63WMTxS--589HMz9Ww/artifacts/public/build/target.common.tests.zip 18:37:37 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/amxk63WMTxS--589HMz9Ww/artifacts/public/build/target.common.tests.zip'}, attempt #1 18:37:37 INFO - Fetch https://queue.taskcluster.net/v1/task/amxk63WMTxS--589HMz9Ww/artifacts/public/build/target.common.tests.zip into memory 18:37:38 INFO - Content-Length response header: 55738871 18:37:38 INFO - Bytes received: 55738871 18:37:49 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 18:37:49 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/amxk63WMTxS--589HMz9Ww/artifacts/public/build/target.common.tests.zip 18:37:49 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/amxk63WMTxS--589HMz9Ww/artifacts/public/build/target.common.tests.zip'}, attempt #1 18:37:49 INFO - Fetch https://queue.taskcluster.net/v1/task/amxk63WMTxS--589HMz9Ww/artifacts/public/build/target.common.tests.zip into memory 18:37:50 INFO - Content-Length response header: 55738871 18:37:50 INFO - Bytes received: 55738871 18:38:02 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/amxk63WMTxS--589HMz9Ww/artifacts/public/build/target.talos.tests.zip 18:38:02 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/amxk63WMTxS--589HMz9Ww/artifacts/public/build/target.talos.tests.zip'}, attempt #1 18:38:02 INFO - Fetch https://queue.taskcluster.net/v1/task/amxk63WMTxS--589HMz9Ww/artifacts/public/build/target.talos.tests.zip into memory 18:38:03 INFO - Content-Length response header: 14496611 18:38:03 INFO - Bytes received: 14496611 18:38:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 18:38:03 INFO - trying https://queue.taskcluster.net/v1/task/amxk63WMTxS--589HMz9Ww/artifacts/public/build/target.tar.bz2 18:38:03 INFO - Downloading https://queue.taskcluster.net/v1/task/amxk63WMTxS--589HMz9Ww/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 18:38:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/amxk63WMTxS--589HMz9Ww/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 18:38:04 INFO - Downloaded 62333258 bytes. 18:38:04 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/amxk63WMTxS--589HMz9Ww/artifacts/public/build/target.tar.bz2 18:38:04 INFO - mkdir: /builds/slave/test/properties 18:38:04 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 18:38:04 INFO - Writing to file /builds/slave/test/properties/build_url 18:38:04 INFO - Contents: 18:38:04 INFO - build_url:https://queue.taskcluster.net/v1/task/amxk63WMTxS--589HMz9Ww/artifacts/public/build/target.tar.bz2 18:38:04 INFO - Running post-action listener: _resource_record_post_action 18:38:04 INFO - Running post-action listener: find_tests_for_verification 18:38:04 INFO - Running post-action listener: set_extra_try_arguments 18:38:04 INFO - [mozharness: 2017-08-26 01:38:04.552917Z] Finished download-and-extract step (success) 18:38:04 INFO - [mozharness: 2017-08-26 01:38:04.553015Z] Running populate-webroot step. 18:38:04 INFO - Running pre-action listener: _resource_record_pre_action 18:38:04 INFO - Running main action method: populate_webroot 18:38:04 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 18:38:04 INFO - 'chromez-stylo-e10s': {'talos_options': ['--stylo'], 18:38:04 INFO - 'tests': ['tresize', 'tcanvasmark']}, 18:38:04 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 18:38:04 INFO - 'dromaeojs-stylo-e10s': {'talos_options': ['--stylo'], 18:38:04 INFO - 'tests': ['dromaeo_css', 'kraken']}, 18:38:04 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 18:38:04 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:38:04 INFO - 'g1-stylo-e10s': {'pagesets_name': 'tp5n.zip', 18:38:04 INFO - 'talos_options': ['--stylo'], 18:38:04 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:38:04 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 18:38:04 INFO - 'tests': ['damp', 'tps']}, 18:38:04 INFO - 'g2-stylo-e10s': {'pagesets_name': 'tp5n.zip', 18:38:04 INFO - 'talos_options': ['--stylo'], 18:38:04 INFO - 'tests': ['damp', 'tps']}, 18:38:04 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 18:38:04 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 18:38:04 INFO - 'g4-stylo-e10s': {'talos_options': ['--stylo'], 18:38:04 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 18:38:04 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 18:38:04 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 18:38:04 INFO - 'g5-stylo-e10s': {'pagesets_name': 'tp5n.zip', 18:38:04 INFO - 'talos_options': ['--stylo'], 18:38:04 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 18:38:04 INFO - 'other-e10s': {'tests': ['a11yr', 18:38:04 INFO - 'ts_paint', 18:38:04 INFO - 'tpaint', 18:38:04 INFO - 'sessionrestore', 18:38:04 INFO - 'sessionrestore_many_windows', 18:38:04 INFO - 'sessionrestore_no_auto_restore', 18:38:04 INFO - 'tabpaint']}, 18:38:04 INFO - 'other-stylo-e10s': {'talos_options': ['--stylo'], 18:38:04 INFO - 'tests': ['a11yr', 18:38:04 INFO - 'ts_paint', 18:38:04 INFO - 'tpaint', 18:38:04 INFO - 'sessionrestore', 18:38:04 INFO - 'sessionrestore_many_windows', 18:38:04 INFO - 'sessionrestore_no_auto_restore', 18:38:04 INFO - 'tabpaint']}, 18:38:04 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 18:38:04 INFO - 'perf-reftest-singletons-e10s': {'tests': ['bloom_basic_singleton']}, 18:38:04 INFO - 'perf-reftest-singletons-stylo-e10s': {'talos_options': ['--stylo'], 18:38:04 INFO - 'tests': ['bloom_basic_singleton']}, 18:38:04 INFO - 'perf-reftest-stylo-e10s': {'talos_options': ['--stylo'], 18:38:04 INFO - 'tests': ['bloom_basic']}, 18:38:04 INFO - 'svgr-e10s': {'tests': ['tsvgx', 18:38:04 INFO - 'tsvgr_opacity', 18:38:04 INFO - 'tart', 18:38:04 INFO - 'tscrollx', 18:38:04 INFO - 'tsvg_static']}, 18:38:04 INFO - 'svgr-stylo-e10s': {'talos_options': ['--stylo'], 18:38:04 INFO - 'tests': ['tsvgx', 18:38:04 INFO - 'tsvgr_opacity', 18:38:04 INFO - 'tart', 18:38:04 INFO - 'tscrollx', 18:38:04 INFO - 'tsvg_static']}, 18:38:04 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 18:38:04 INFO - 'tp5o-stylo-e10s': {'pagesets_name': 'tp5n.zip', 18:38:04 INFO - 'talos_options': ['--stylo'], 18:38:04 INFO - 'tests': ['tp5o']}, 18:38:04 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 18:38:04 INFO - 'talos_options': ['--mitmproxy', 18:38:04 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 18:38:04 INFO - '--firstNonBlankPaint'], 18:38:04 INFO - 'tests': ['tp6_google', 18:38:04 INFO - 'tp6_youtube', 18:38:04 INFO - 'tp6_amazon', 18:38:04 INFO - 'tp6_facebook']}, 18:38:04 INFO - 'tp6-stylo-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 18:38:04 INFO - 'talos_options': ['--stylo', 18:38:04 INFO - '--mitmproxy', 18:38:04 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 18:38:04 INFO - '--firstNonBlankPaint'], 18:38:04 INFO - 'tests': ['tp6_google', 18:38:04 INFO - 'tp6_youtube', 18:38:04 INFO - 'tp6_amazon', 18:38:04 INFO - 'tp6_facebook']}, 18:38:04 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 18:38:04 INFO - 'talos_options': ['--stylo', 18:38:04 INFO - '--stylo-threads=1', 18:38:04 INFO - '--mitmproxy', 18:38:04 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 18:38:04 INFO - '--firstNonBlankPaint'], 18:38:04 INFO - 'tests': ['tp6_google', 18:38:04 INFO - 'tp6_youtube', 18:38:04 INFO - 'tp6_amazon', 18:38:04 INFO - 'tp6_facebook']}, 18:38:04 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 18:38:04 INFO - 'talos_options': ['--xperf_path', 18:38:04 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:38:04 INFO - 'tests': ['tp5n']}, 18:38:04 INFO - 'xperf-stylo-e10s': {'pagesets_name': 'tp5n.zip', 18:38:04 INFO - 'talos_options': ['--stylo', 18:38:04 INFO - '--xperf_path', 18:38:04 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:38:04 INFO - 'tests': ['tp5n']}}} 18:38:04 INFO - Running post-action listener: _resource_record_post_action 18:38:04 INFO - [mozharness: 2017-08-26 01:38:04.567206Z] Finished populate-webroot step (success) 18:38:04 INFO - [mozharness: 2017-08-26 01:38:04.567295Z] Running create-virtualenv step. 18:38:04 INFO - Running pre-action listener: _resource_record_pre_action 18:38:04 INFO - Running main action method: create_virtualenv 18:38:04 INFO - Creating virtualenv /builds/slave/test/build/venv 18:38:04 INFO - Running command: ['virtualenv', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 18:38:04 INFO - Copy/paste: virtualenv --no-site-packages --distribute /builds/slave/test/build/venv 18:38:04 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 18:38:04 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 18:38:04 INFO - New python executable in /builds/slave/test/build/venv/bin/python 18:38:05 INFO - Installing distribute.............................................................................................................................................................................................done. 18:38:05 INFO - Installing pip...............done. 18:38:05 INFO - Return code: 0 18:38:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 18:38:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 18:38:05 INFO - Reading from file tmpfile_stdout 18:38:05 INFO - Output received: 18:38:05 INFO - pip 1.1 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.1-py2.7.egg (python 2.7) 18:38:05 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 18:38:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 18:38:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:38:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 18:38:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:38:05 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/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 0xe851f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1050a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11f3f90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11f1130>, '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 0x11f2030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11f24c0>, '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': '6d15e502d8e29d5d2676d664000001c3-1503711450.800940-1362830451', '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 18:38:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--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 18:38:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 18:38:05 INFO - Using env: {'DISPLAY': ':0', 18:38:05 INFO - 'HOME': '/home/cltbld', 18:38:05 INFO - 'LANG': 'en_US.UTF-8', 18:38:05 INFO - 'LANGUAGE': 'en_US:en', 18:38:05 INFO - 'LOGNAME': 'cltbld', 18:38:05 INFO - 'MAIL': '/var/mail/cltbld', 18:38:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:38:05 INFO - 'MOZ_NO_REMOTE': '1', 18:38:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:38:05 INFO - 'NO_EM_RESTART': '1', 18:38:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:38:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:38:05 INFO - 'PWD': '/builds/slave/test', 18:38:05 INFO - 'SHELL': '/bin/bash', 18:38:05 INFO - 'SHLVL': '1', 18:38:05 INFO - 'TERM': 'linux', 18:38:05 INFO - 'TMOUT': '86400', 18:38:05 INFO - 'USER': 'cltbld', 18:38:05 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1503711450.800940-1362830451', 18:38:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:38:05 INFO - '_': '/tools/buildbot/bin/python'} 18:38:06 INFO - Ignoring indexes: http://pypi.python.org/simple/ 18:38:06 INFO - Downloading/unpacking pip>=1.5 18:38:06 INFO - Running setup.py egg_info for package pip 18:38:06 INFO - warning: no files found matching 'pip/cacert.pem' 18:38:06 INFO - warning: no files found matching '*.html' under directory 'docs' 18:38:06 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 18:38:06 INFO - no previously-included directories found matching 'docs/_build/_sources' 18:38:06 INFO - Installing collected packages: pip 18:38:06 INFO - Found existing installation: pip 1.1 18:38:06 INFO - Uninstalling pip: 18:38:06 INFO - Successfully uninstalled pip 18:38:06 INFO - Running setup.py install for pip 18:38:06 INFO - warning: no files found matching 'pip/cacert.pem' 18:38:06 INFO - warning: no files found matching '*.html' under directory 'docs' 18:38:06 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 18:38:06 INFO - no previously-included directories found matching 'docs/_build/_sources' 18:38:06 INFO - Installing pip script to /builds/slave/test/build/venv/bin 18:38:06 INFO - Installing pip2.7 script to /builds/slave/test/build/venv/bin 18:38:06 INFO - Installing pip2 script to /builds/slave/test/build/venv/bin 18:38:06 INFO - Successfully installed pip 18:38:06 INFO - Cleaning up... 18:38:06 INFO - Return code: 0 18:38:06 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 18:38:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 18:38:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:38:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 18:38:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:38:06 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/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 0xe851f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1050a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11f3f90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11f1130>, '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 0x11f2030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11f24c0>, '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': '6d15e502d8e29d5d2676d664000001c3-1503711450.800940-1362830451', '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 18:38:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--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 18:38:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 18:38:06 INFO - Using env: {'DISPLAY': ':0', 18:38:06 INFO - 'HOME': '/home/cltbld', 18:38:06 INFO - 'LANG': 'en_US.UTF-8', 18:38:06 INFO - 'LANGUAGE': 'en_US:en', 18:38:06 INFO - 'LOGNAME': 'cltbld', 18:38:06 INFO - 'MAIL': '/var/mail/cltbld', 18:38:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:38:06 INFO - 'MOZ_NO_REMOTE': '1', 18:38:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:38:06 INFO - 'NO_EM_RESTART': '1', 18:38:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:38:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:38:06 INFO - 'PWD': '/builds/slave/test', 18:38:06 INFO - 'SHELL': '/bin/bash', 18:38:06 INFO - 'SHLVL': '1', 18:38:06 INFO - 'TERM': 'linux', 18:38:06 INFO - 'TMOUT': '86400', 18:38:06 INFO - 'USER': 'cltbld', 18:38:06 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1503711450.800940-1362830451', 18:38:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:38:06 INFO - '_': '/tools/buildbot/bin/python'} 18:38:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:38:06 INFO - Downloading/unpacking psutil>=3.1.1 18:38:06 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 18:38:06 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 18:38:06 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 18:38:06 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 18:38:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 18:38:08 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:38:08 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:38:08 INFO - Installing collected packages: psutil 18:38:08 INFO - Running setup.py install for psutil 18:38:08 INFO - building 'psutil._psutil_linux' extension 18:38:08 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 18:38:08 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 18:38:08 INFO - building 'psutil._psutil_posix' extension 18:38:08 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 18:38:08 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 18:38:08 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:38:08 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:38:08 INFO - Successfully installed psutil 18:38:08 INFO - Cleaning up... 18:38:08 INFO - Return code: 0 18:38:08 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 18:38:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 18:38:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:38:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 18:38:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:38:08 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/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 0xe851f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1050a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11f3f90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11f1130>, '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 0x11f2030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11f24c0>, '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': '6d15e502d8e29d5d2676d664000001c3-1503711450.800940-1362830451', '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 18:38:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--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 18:38:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 18:38:08 INFO - Using env: {'DISPLAY': ':0', 18:38:08 INFO - 'HOME': '/home/cltbld', 18:38:08 INFO - 'LANG': 'en_US.UTF-8', 18:38:08 INFO - 'LANGUAGE': 'en_US:en', 18:38:08 INFO - 'LOGNAME': 'cltbld', 18:38:08 INFO - 'MAIL': '/var/mail/cltbld', 18:38:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:38:08 INFO - 'MOZ_NO_REMOTE': '1', 18:38:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:38:08 INFO - 'NO_EM_RESTART': '1', 18:38:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:38:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:38:08 INFO - 'PWD': '/builds/slave/test', 18:38:08 INFO - 'SHELL': '/bin/bash', 18:38:08 INFO - 'SHLVL': '1', 18:38:08 INFO - 'TERM': 'linux', 18:38:08 INFO - 'TMOUT': '86400', 18:38:08 INFO - 'USER': 'cltbld', 18:38:08 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1503711450.800940-1362830451', 18:38:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:38:08 INFO - '_': '/tools/buildbot/bin/python'} 18:38:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:38:08 INFO - Downloading/unpacking mozsystemmonitor==0.3 18:38:08 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 18:38:08 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 18:38:08 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 18:38:08 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 18:38:10 INFO - Downloading mozsystemmonitor-0.3.tar.gz 18:38:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 18:38:10 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 18:38:10 INFO - Installing collected packages: mozsystemmonitor 18:38:10 INFO - Running setup.py install for mozsystemmonitor 18:38:10 INFO - Successfully installed mozsystemmonitor 18:38:10 INFO - Cleaning up... 18:38:10 INFO - Return code: 0 18:38:10 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 18:38:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 18:38:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:38:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 18:38:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:38:10 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/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 0xe851f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1050a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11f3f90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11f1130>, '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 0x11f2030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11f24c0>, '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': '6d15e502d8e29d5d2676d664000001c3-1503711450.800940-1362830451', '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 18:38:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--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 18:38:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 18:38:10 INFO - Using env: {'DISPLAY': ':0', 18:38:10 INFO - 'HOME': '/home/cltbld', 18:38:10 INFO - 'LANG': 'en_US.UTF-8', 18:38:10 INFO - 'LANGUAGE': 'en_US:en', 18:38:10 INFO - 'LOGNAME': 'cltbld', 18:38:10 INFO - 'MAIL': '/var/mail/cltbld', 18:38:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:38:10 INFO - 'MOZ_NO_REMOTE': '1', 18:38:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:38:10 INFO - 'NO_EM_RESTART': '1', 18:38:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:38:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:38:10 INFO - 'PWD': '/builds/slave/test', 18:38:10 INFO - 'SHELL': '/bin/bash', 18:38:10 INFO - 'SHLVL': '1', 18:38:10 INFO - 'TERM': 'linux', 18:38:10 INFO - 'TMOUT': '86400', 18:38:10 INFO - 'USER': 'cltbld', 18:38:10 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1503711450.800940-1362830451', 18:38:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:38:10 INFO - '_': '/tools/buildbot/bin/python'} 18:38:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:38:10 INFO - Downloading/unpacking jsonschema==2.5.1 18:38:10 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 18:38:10 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 18:38:10 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 18:38:10 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 18:38:11 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 18:38:11 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 18:38:11 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 18:38:11 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 18:38:11 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 18:38:11 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 18:38:11 INFO - Downloading functools32-3.2.3-2.tar.gz 18:38:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 18:38:11 INFO - warning: no files found matching '*.txt' 18:38:11 INFO - no previously-included directories found matching 'build' 18:38:11 INFO - no previously-included directories found matching 'dist' 18:38:11 INFO - no previously-included directories found matching '.git*' 18:38:11 INFO - Installing collected packages: jsonschema, functools32 18:38:11 INFO - Running setup.py install for functools32 18:38:11 INFO - warning: no files found matching '*.txt' 18:38:11 INFO - no previously-included directories found matching 'build' 18:38:11 INFO - no previously-included directories found matching 'dist' 18:38:11 INFO - no previously-included directories found matching '.git*' 18:38:11 INFO - Successfully installed jsonschema functools32 18:38:11 INFO - Cleaning up... 18:38:11 INFO - Return code: 0 18:38:11 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 18:38:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 18:38:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:38:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 18:38:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:38:11 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/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 0xe851f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1050a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11f3f90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11f1130>, '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 0x11f2030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11f24c0>, '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': '6d15e502d8e29d5d2676d664000001c3-1503711450.800940-1362830451', '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 18:38:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--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 18:38:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 18:38:11 INFO - Using env: {'DISPLAY': ':0', 18:38:11 INFO - 'HOME': '/home/cltbld', 18:38:11 INFO - 'LANG': 'en_US.UTF-8', 18:38:11 INFO - 'LANGUAGE': 'en_US:en', 18:38:11 INFO - 'LOGNAME': 'cltbld', 18:38:11 INFO - 'MAIL': '/var/mail/cltbld', 18:38:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:38:11 INFO - 'MOZ_NO_REMOTE': '1', 18:38:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:38:11 INFO - 'NO_EM_RESTART': '1', 18:38:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:38:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:38:11 INFO - 'PWD': '/builds/slave/test', 18:38:11 INFO - 'SHELL': '/bin/bash', 18:38:11 INFO - 'SHLVL': '1', 18:38:11 INFO - 'TERM': 'linux', 18:38:11 INFO - 'TMOUT': '86400', 18:38:11 INFO - 'USER': 'cltbld', 18:38:11 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1503711450.800940-1362830451', 18:38:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:38:11 INFO - '_': '/tools/buildbot/bin/python'} 18:38:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:38:12 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 18:38:12 INFO - Cleaning up... 18:38:12 INFO - Return code: 0 18:38:12 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 18:38:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 18:38:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:38:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 18:38:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:38:12 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/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 0xe851f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1050a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11f3f90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11f1130>, '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 0x11f2030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11f24c0>, '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': '6d15e502d8e29d5d2676d664000001c3-1503711450.800940-1362830451', '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 18:38:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--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 18:38:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 18:38:12 INFO - Using env: {'DISPLAY': ':0', 18:38:12 INFO - 'HOME': '/home/cltbld', 18:38:12 INFO - 'LANG': 'en_US.UTF-8', 18:38:12 INFO - 'LANGUAGE': 'en_US:en', 18:38:12 INFO - 'LOGNAME': 'cltbld', 18:38:12 INFO - 'MAIL': '/var/mail/cltbld', 18:38:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:38:12 INFO - 'MOZ_NO_REMOTE': '1', 18:38:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:38:12 INFO - 'NO_EM_RESTART': '1', 18:38:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:38:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:38:12 INFO - 'PWD': '/builds/slave/test', 18:38:12 INFO - 'SHELL': '/bin/bash', 18:38:12 INFO - 'SHLVL': '1', 18:38:12 INFO - 'TERM': 'linux', 18:38:12 INFO - 'TMOUT': '86400', 18:38:12 INFO - 'USER': 'cltbld', 18:38:12 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1503711450.800940-1362830451', 18:38:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:38:12 INFO - '_': '/tools/buildbot/bin/python'} 18:38:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:38:12 INFO - Downloading/unpacking blobuploader==1.2.4 18:38:12 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 18:38:12 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 18:38:12 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 18:38:12 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 18:38:13 INFO - Downloading blobuploader-1.2.4.tar.gz 18:38:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 18:38:13 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 18:38:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:38:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:38:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:38:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:38:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 18:38:13 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 18:38:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:38:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:38:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:38:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:38:13 INFO - Downloading docopt-0.6.1.tar.gz 18:38:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 18:38:14 INFO - Installing collected packages: blobuploader, requests, docopt 18:38:14 INFO - Running setup.py install for blobuploader 18:38:14 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 18:38:14 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 18:38:14 INFO - Running setup.py install for requests 18:38:14 INFO - Running setup.py install for docopt 18:38:14 INFO - Successfully installed blobuploader requests docopt 18:38:14 INFO - Cleaning up... 18:38:14 INFO - Return code: 0 18:38:14 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:38:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 18:38:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:38:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 18:38:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:38:14 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/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 0xe851f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1050a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11f3f90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11f1130>, '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 0x11f2030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11f24c0>, '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': '6d15e502d8e29d5d2676d664000001c3-1503711450.800940-1362830451', '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 18:38:14 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/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 18:38:14 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/pub --find-links http://pypi.pub.build.mozilla.org/pub 18:38:14 INFO - Using env: {'DISPLAY': ':0', 18:38:14 INFO - 'HOME': '/home/cltbld', 18:38:14 INFO - 'LANG': 'en_US.UTF-8', 18:38:14 INFO - 'LANGUAGE': 'en_US:en', 18:38:14 INFO - 'LOGNAME': 'cltbld', 18:38:14 INFO - 'MAIL': '/var/mail/cltbld', 18:38:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:38:14 INFO - 'MOZ_NO_REMOTE': '1', 18:38:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:38:14 INFO - 'NO_EM_RESTART': '1', 18:38:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:38:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:38:14 INFO - 'PWD': '/builds/slave/test', 18:38:14 INFO - 'SHELL': '/bin/bash', 18:38:14 INFO - 'SHLVL': '1', 18:38:14 INFO - 'TERM': 'linux', 18:38:14 INFO - 'TMOUT': '86400', 18:38:14 INFO - 'USER': 'cltbld', 18:38:14 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1503711450.800940-1362830451', 18:38:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:38:14 INFO - '_': '/tools/buildbot/bin/python'} 18:38:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:38:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:38:14 INFO - Running setup.py (path:/tmp/pip-ibiW_D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:38:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:38:14 INFO - Running setup.py (path:/tmp/pip-Aakl1l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:38:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:38:14 INFO - Running setup.py (path:/tmp/pip-JgfvhR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:38:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:38:15 INFO - Running setup.py (path:/tmp/pip-WR2DlY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:38:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:38:15 INFO - Running setup.py (path:/tmp/pip-cvvrsS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:38:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:38:15 INFO - Running setup.py (path:/tmp/pip-CjfAiB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:38:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:38:15 INFO - Running setup.py (path:/tmp/pip-aJqTi_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:38:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:38:15 INFO - Running setup.py (path:/tmp/pip-v1PaYN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:38:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:38:15 INFO - Running setup.py (path:/tmp/pip-oqD2na-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:38:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:38:15 INFO - Running setup.py (path:/tmp/pip-4xr3rg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:38:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:38:15 INFO - Running setup.py (path:/tmp/pip-O19eTB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:38:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:38:15 INFO - Running setup.py (path:/tmp/pip-I0k2Em-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:38:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:38:15 INFO - Running setup.py (path:/tmp/pip-P81_Ys-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:38:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:38:15 INFO - Running setup.py (path:/tmp/pip-8Vplff-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:38:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:38:15 INFO - Running setup.py (path:/tmp/pip-iWbtbE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:38:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:38:15 INFO - Running setup.py (path:/tmp/pip-IlNaB4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:38:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:38:15 INFO - Running setup.py (path:/tmp/pip-8XWm5M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:38:16 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 18:38:16 INFO - Running setup.py install for manifestparser 18:38:16 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 18:38:16 INFO - Running setup.py install for mozcrash 18:38:16 INFO - Running setup.py install for mozdebug 18:38:16 INFO - Running setup.py install for mozdevice 18:38:16 INFO - Installing dm script to /builds/slave/test/build/venv/bin 18:38:16 INFO - Running setup.py install for mozfile 18:38:16 INFO - Running setup.py install for mozhttpd 18:38:16 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 18:38:16 INFO - Running setup.py install for mozinfo 18:38:16 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 18:38:16 INFO - Running setup.py install for mozInstall 18:38:16 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 18:38:16 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 18:38:16 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 18:38:16 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 18:38:16 INFO - Running setup.py install for mozleak 18:38:16 INFO - Running setup.py install for mozlog 18:38:17 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 18:38:17 INFO - Running setup.py install for moznetwork 18:38:17 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 18:38:17 INFO - Running setup.py install for mozprocess 18:38:17 INFO - Running setup.py install for mozprofile 18:38:17 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 18:38:17 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 18:38:17 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 18:38:17 INFO - Running setup.py install for mozrunner 18:38:17 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 18:38:17 INFO - Running setup.py install for mozscreenshot 18:38:17 INFO - Running setup.py install for moztest 18:38:17 INFO - Running setup.py install for mozversion 18:38:17 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 18:38:17 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 18:38:17 INFO - Cleaning up... 18:38:17 INFO - Return code: 0 18:38:17 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:38:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 18:38:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:38:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 18:38:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:38:17 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/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 0xe851f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1050a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11f3f90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11f1130>, '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 0x11f2030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11f24c0>, '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': '6d15e502d8e29d5d2676d664000001c3-1503711450.800940-1362830451', '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 18:38:17 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/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 18:38:17 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/pub --find-links http://pypi.pub.build.mozilla.org/pub 18:38:17 INFO - Using env: {'DISPLAY': ':0', 18:38:17 INFO - 'HOME': '/home/cltbld', 18:38:17 INFO - 'LANG': 'en_US.UTF-8', 18:38:17 INFO - 'LANGUAGE': 'en_US:en', 18:38:17 INFO - 'LOGNAME': 'cltbld', 18:38:17 INFO - 'MAIL': '/var/mail/cltbld', 18:38:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:38:17 INFO - 'MOZ_NO_REMOTE': '1', 18:38:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:38:17 INFO - 'NO_EM_RESTART': '1', 18:38:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:38:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:38:17 INFO - 'PWD': '/builds/slave/test', 18:38:17 INFO - 'SHELL': '/bin/bash', 18:38:17 INFO - 'SHLVL': '1', 18:38:17 INFO - 'TERM': 'linux', 18:38:17 INFO - 'TMOUT': '86400', 18:38:17 INFO - 'USER': 'cltbld', 18:38:17 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1503711450.800940-1362830451', 18:38:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:38:17 INFO - '_': '/tools/buildbot/bin/python'} 18:38:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:38:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:38:18 INFO - Running setup.py (path:/tmp/pip-EE6bEM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:38:18 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)) 18:38:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:38:18 INFO - Running setup.py (path:/tmp/pip-1btO1n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:38:18 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)) 18:38:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:38:18 INFO - Running setup.py (path:/tmp/pip-BpjozT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:38:18 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)) 18:38:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:38:18 INFO - Running setup.py (path:/tmp/pip-2Vfj_Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:38:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.51 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)) 18:38:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:38:18 INFO - Running setup.py (path:/tmp/pip-6drdtT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:38:18 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)) 18:38:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:38:18 INFO - Running setup.py (path:/tmp/pip-A9cAX6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:38:18 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)) 18:38:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:38:18 INFO - Running setup.py (path:/tmp/pip-z4d690-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:38:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.10 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)) 18:38:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:38:18 INFO - Running setup.py (path:/tmp/pip-w_RcJQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:38:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.13 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)) 18:38:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:38:18 INFO - Running setup.py (path:/tmp/pip-wkCa1L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:38:18 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)) 18:38:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:38:18 INFO - Running setup.py (path:/tmp/pip-9WcfHa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:38:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.5 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)) 18:38:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:38:18 INFO - Running setup.py (path:/tmp/pip-a7U4En-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:38:18 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)) 18:38:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:38:18 INFO - Running setup.py (path:/tmp/pip-HHXhhT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:38:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 18:38:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:38:18 INFO - Running setup.py (path:/tmp/pip-1_7EaK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:38:18 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)) 18:38:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:38:18 INFO - Running setup.py (path:/tmp/pip-3wfztD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:38:19 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)) 18:38:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:38:19 INFO - Running setup.py (path:/tmp/pip-dlwWGo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:38:19 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)) 18:38:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:38:19 INFO - Running setup.py (path:/tmp/pip-7EHumS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:38:19 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)) 18:38:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:38:19 INFO - Running setup.py (path:/tmp/pip-upE5zq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:38:19 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)) 18:38:19 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)) 18:38:19 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)) 18:38:19 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)) 18:38:19 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.51->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 18:38:19 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.51->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 18:38:19 INFO - Requirement already satisfied (use --upgrade to upgrade): requests in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozInstall==1.13->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 18:38:19 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 18:38:19 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 18:38:19 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 18:38:19 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 18:38:19 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 18:38:20 INFO - Downloading blessings-1.6.tar.gz 18:38:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 18:38:20 INFO - Installing collected packages: blessings 18:38:20 INFO - Running setup.py install for blessings 18:38:20 INFO - Successfully installed blessings 18:38:20 INFO - Cleaning up... 18:38:20 INFO - Return code: 0 18:38:20 INFO - Done creating virtualenv /builds/slave/test/build/venv. 18:38:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:38:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:38:20 INFO - Reading from file tmpfile_stdout 18:38:20 INFO - Current package versions: 18:38:20 INFO - argparse == 1.2.1 18:38:20 INFO - blessings == 1.6 18:38:20 INFO - blobuploader == 1.2.4 18:38:20 INFO - docopt == 0.6.1 18:38:20 INFO - functools32 == 3.2.3-2 18:38:20 INFO - jsonschema == 2.5.1 18:38:20 INFO - manifestparser == 1.1 18:38:20 INFO - mozInstall == 1.13 18:38:20 INFO - mozcrash == 1.0 18:38:20 INFO - mozdebug == 0.1 18:38:20 INFO - mozdevice == 0.51 18:38:20 INFO - mozfile == 1.2 18:38:20 INFO - mozhttpd == 0.7 18:38:20 INFO - mozinfo == 0.10 18:38:20 INFO - mozleak == 0.1 18:38:20 INFO - mozlog == 3.5 18:38:20 INFO - moznetwork == 0.27 18:38:20 INFO - mozprocess == 0.25 18:38:20 INFO - mozprofile == 0.28 18:38:20 INFO - mozrunner == 6.13 18:38:20 INFO - mozscreenshot == 0.1 18:38:20 INFO - mozsystemmonitor == 0.3 18:38:20 INFO - moztest == 0.8 18:38:20 INFO - mozversion == 1.4 18:38:20 INFO - psutil == 3.1.1 18:38:20 INFO - requests == 1.2.3 18:38:20 INFO - wsgiref == 0.1.2 18:38:20 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:38:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 18:38:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:38:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 18:38:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:38:20 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/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 0xe851f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1050a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11f3f90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11f1130>, '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 0x11f2030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11f24c0>, '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': '6d15e502d8e29d5d2676d664000001c3-1503711450.800940-1362830451', '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 18:38:20 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/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 18:38:20 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/pub --find-links http://pypi.pub.build.mozilla.org/pub 18:38:20 INFO - Using env: {'DISPLAY': ':0', 18:38:20 INFO - 'HOME': '/home/cltbld', 18:38:20 INFO - 'LANG': 'en_US.UTF-8', 18:38:20 INFO - 'LANGUAGE': 'en_US:en', 18:38:20 INFO - 'LOGNAME': 'cltbld', 18:38:20 INFO - 'MAIL': '/var/mail/cltbld', 18:38:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:38:20 INFO - 'MOZ_NO_REMOTE': '1', 18:38:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:38:20 INFO - 'NO_EM_RESTART': '1', 18:38:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:38:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:38:20 INFO - 'PWD': '/builds/slave/test', 18:38:20 INFO - 'SHELL': '/bin/bash', 18:38:20 INFO - 'SHLVL': '1', 18:38:20 INFO - 'TERM': 'linux', 18:38:20 INFO - 'TMOUT': '86400', 18:38:20 INFO - 'USER': 'cltbld', 18:38:20 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1503711450.800940-1362830451', 18:38:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:38:20 INFO - '_': '/tools/buildbot/bin/python'} 18:38:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:38:21 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)) 18:38:21 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)) 18:38:21 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)) 18:38:21 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)) 18:38:21 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)) 18:38:21 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)) 18:38:21 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)) 18:38:21 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)) 18:38:21 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)) 18:38:21 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 18:38:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:38:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:38:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:38:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:38:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 18:38:22 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)) 18:38:22 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)) 18:38:22 INFO - Installing collected packages: simplejson 18:38:22 INFO - Running setup.py install for simplejson 18:38:22 INFO - building 'simplejson._speedups' extension 18:38:22 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c simplejson/_speedups.c -o build/temp.linux-x86_64-2.7/simplejson/_speedups.o 18:38:23 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/simplejson/_speedups.o -o build/lib.linux-x86_64-2.7/simplejson/_speedups.so 18:38:23 INFO - Successfully installed simplejson 18:38:23 INFO - Cleaning up... 18:38:23 INFO - Return code: 0 18:38:23 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 18:38:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 18:38:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:38:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 18:38:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:38:23 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/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 0xe851f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1050a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11f3f90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11f1130>, '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 0x11f2030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11f24c0>, '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': '6d15e502d8e29d5d2676d664000001c3-1503711450.800940-1362830451', '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 18:38:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 18:38:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 18:38:23 INFO - Using env: {'DISPLAY': ':0', 18:38:23 INFO - 'HOME': '/home/cltbld', 18:38:23 INFO - 'LANG': 'en_US.UTF-8', 18:38:23 INFO - 'LANGUAGE': 'en_US:en', 18:38:23 INFO - 'LOGNAME': 'cltbld', 18:38:23 INFO - 'MAIL': '/var/mail/cltbld', 18:38:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:38:23 INFO - 'MOZ_NO_REMOTE': '1', 18:38:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:38:23 INFO - 'NO_EM_RESTART': '1', 18:38:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:38:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:38:23 INFO - 'PWD': '/builds/slave/test', 18:38:23 INFO - 'SHELL': '/bin/bash', 18:38:23 INFO - 'SHLVL': '1', 18:38:23 INFO - 'TERM': 'linux', 18:38:23 INFO - 'TMOUT': '86400', 18:38:23 INFO - 'USER': 'cltbld', 18:38:23 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1503711450.800940-1362830451', 18:38:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:38:23 INFO - '_': '/tools/buildbot/bin/python'} 18:38:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:38:23 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 18:38:23 INFO - Cleaning up... 18:38:23 INFO - Return code: 0 18:38:23 INFO - Running post-action listener: _resource_record_post_action 18:38:23 INFO - Running post-action listener: _start_resource_monitoring 18:38:23 INFO - Starting resource monitoring. 18:38:23 INFO - [mozharness: 2017-08-26 01:38:23.518671Z] Finished create-virtualenv step (success) 18:38:23 INFO - [mozharness: 2017-08-26 01:38:23.519232Z] Running install step. 18:38:23 INFO - Running pre-action listener: _resource_record_pre_action 18:38:23 INFO - Running main action method: install 18:38:23 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:38:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:38:23 INFO - Reading from file tmpfile_stdout 18:38:23 INFO - Detecting whether we're running mozinstall >=1.0... 18:38:23 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 18:38:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 18:38:23 INFO - Reading from file tmpfile_stdout 18:38:23 INFO - Output received: 18:38:23 INFO - Usage: mozinstall [options] installer 18:38:23 INFO - Options: 18:38:23 INFO - -h, --help show this help message and exit 18:38:23 INFO - -d DEST, --destination=DEST 18:38:23 INFO - Directory to install application into. [default: 18:38:23 INFO - "/builds/slave/test"] 18:38:23 INFO - --app=APP Application being installed. [default: firefox] 18:38:23 INFO - mkdir: /builds/slave/test/build/application 18:38:23 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'] 18:38:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 18:38:41 INFO - Reading from file tmpfile_stdout 18:38:41 INFO - Output received: 18:38:41 INFO - /builds/slave/test/build/application/firefox/firefox 18:38:41 INFO - Running post-action listener: _resource_record_post_action 18:38:41 INFO - [mozharness: 2017-08-26 01:38:41.468608Z] Finished install step (success) 18:38:41 INFO - [mozharness: 2017-08-26 01:38:41.468952Z] Running setup-mitmproxy step. 18:38:41 INFO - Running pre-action listener: _resource_record_pre_action 18:38:41 INFO - Running main action method: setup_mitmproxy 18:38:41 INFO - Skipping: mitmproxy is not required 18:38:41 INFO - Running post-action listener: _resource_record_post_action 18:38:41 INFO - [mozharness: 2017-08-26 01:38:41.470671Z] Finished setup-mitmproxy step (success) 18:38:41 INFO - [mozharness: 2017-08-26 01:38:41.470989Z] Running run-tests step. 18:38:41 INFO - Running pre-action listener: _resource_record_pre_action 18:38:41 INFO - Running pre-action listener: _set_gcov_prefix 18:38:41 INFO - Running main action method: run_tests 18:38:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 18:38:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 18:38:41 INFO - Python 2.7.3 18:38:41 INFO - Return code: 0 18:38:41 INFO - grabbing minidump binary from tooltool 18:38:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 18:38:41 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://tooltool.mozilla-releng.net/', '--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 0x11f1130>, '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 0x11f2030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11f24c0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 18:38:41 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://tooltool.mozilla-releng.net/', '--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 18:38:41 INFO - Copy/paste: /tools/tooltool.py --url https://tooltool.mozilla-releng.net/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 18:38:41 INFO - Calling ['/tools/tooltool.py', '--url', 'https://tooltool.mozilla-releng.net/', '--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 18:38:41 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 18:38:41 INFO - Return code: 0 18:38:41 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 18:38:41 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 18:38:41 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 18:38:41 INFO - ENV: RUST_BACKTRACE is now full 18:38:41 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 18:38:41 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 18:38:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/amxk63WMTxS--589HMz9Ww/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-023', '--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 18:38:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/amxk63WMTxS--589HMz9Ww/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-023 --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 18:38:41 INFO - Using env: {'DISPLAY': ':0', 18:38:41 INFO - 'HOME': '/home/cltbld', 18:38:41 INFO - 'LANG': 'en_US.UTF-8', 18:38:41 INFO - 'LANGUAGE': 'en_US:en', 18:38:41 INFO - 'LOGNAME': 'cltbld', 18:38:41 INFO - 'MAIL': '/var/mail/cltbld', 18:38:41 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 18:38:41 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 18:38:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:38:41 INFO - 'MOZ_NO_REMOTE': '1', 18:38:41 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 18:38:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:38:41 INFO - 'NO_EM_RESTART': '1', 18:38:41 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:38:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:38:41 INFO - 'PWD': '/builds/slave/test', 18:38:41 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 18:38:41 INFO - 'RUST_BACKTRACE': 'full', 18:38:41 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 18:38:41 INFO - 'SHELL': '/bin/bash', 18:38:41 INFO - 'SHLVL': '1', 18:38:41 INFO - 'TERM': 'linux', 18:38:41 INFO - 'TMOUT': '86400', 18:38:41 INFO - 'USER': 'cltbld', 18:38:41 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1503711450.800940-1362830451', 18:38:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:38:41 INFO - '_': '/tools/buildbot/bin/python'} 18:38:41 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/amxk63WMTxS--589HMz9Ww/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-023', '--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 18:38:41 INFO - mozversion application_buildid: 20170826002533 18:38:41 INFO - mozversion application_changeset: 31465a03c03d1eec31cd4dd5d6b803724dcb29cd 18:38:41 INFO - mozversion application_display_name: Nightly 18:38:41 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 18:38:41 INFO - mozversion application_name: Firefox 18:38:41 INFO - mozversion application_remotingname: firefox 18:38:41 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 18:38:41 INFO - mozversion application_vendor: Mozilla 18:38:41 INFO - mozversion application_version: 57.0a1 18:38:41 INFO - mozversion platform_buildid: 20170826002533 18:38:41 INFO - mozversion platform_changeset: 31465a03c03d1eec31cd4dd5d6b803724dcb29cd 18:38:41 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 18:38:41 INFO - mozversion platform_version: 57.0a1 18:38:41 INFO - using testdate: 1503711521 18:38:41 INFO - actual date: 1503711521 18:38:41 INFO - starting webserver on 'localhost:48593' 18:38:41 INFO - SUITE-START | Running 2 tests 18:38:41 INFO - TEST-START | dromaeo_css 18:38:41 INFO - Initialising browser for dromaeo_css test... 18:38:41 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:48593/getInfo.html -profile /tmp/tmpqlW5al/profile 18:38:41 INFO - TEST-INFO | started process 19284 (/builds/slave/test/build/application/firefox/firefox http://localhost:48593/getInfo.html) 18:38:46 INFO - TEST-INFO | 19284: exit 0 18:38:47 INFO - Browser initialized. 18:38:47 INFO - Running cycle 1/1 for dromaeo_css test... 18:38:47 INFO - Using env: {'DISPLAY': ':0', 18:38:47 INFO - 'HOME': '/home/cltbld', 18:38:47 INFO - 'JSGC_DISABLE_POISONING': '1', 18:38:47 INFO - 'LANG': 'en_US.UTF-8', 18:38:47 INFO - 'LANGUAGE': 'en_US:en', 18:38:47 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 18:38:47 INFO - 'LOGNAME': 'cltbld', 18:38:47 INFO - 'MAIL': '/var/mail/cltbld', 18:38:47 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 18:38:47 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 18:38:47 INFO - 'MOZ_CRASHREPORTER': '1', 18:38:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:38:47 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 18:38:47 INFO - 'MOZ_NO_REMOTE': '1', 18:38:47 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 18:38:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:38:47 INFO - 'NO_EM_RESTART': '1', 18:38:47 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:38:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:38:47 INFO - 'PWD': '/builds/slave/test', 18:38:47 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 18:38:47 INFO - 'RUST_BACKTRACE': 'full', 18:38:47 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 18:38:47 INFO - 'SHELL': '/bin/bash', 18:38:47 INFO - 'SHLVL': '1', 18:38:47 INFO - 'TERM': 'linux', 18:38:47 INFO - 'TMOUT': '86400', 18:38:47 INFO - 'USER': 'cltbld', 18:38:47 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1503711450.800940-1362830451', 18:38:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:38:47 INFO - '_': '/tools/buildbot/bin/python'} 18:38:47 INFO - TEST-INFO | started process 19461 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpqlW5al/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 18:38:47 INFO - PID 19461 | 18:38:47 INFO - PID 19461 | (/builds/slave/test/build/application/firefox/firefox:19513): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 18:38:47 INFO - PID 19461 | 18:38:48 INFO - PID 19461 | 18:38:48 INFO - PID 19461 | (/builds/slave/test/build/application/firefox/firefox:19565): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 18:38:48 INFO - PID 19461 | 18:38:48 INFO - PID 19461 | __metrics Screen width/height:1600/1200 18:38:48 INFO - PID 19461 | colorDepth:24 18:38:48 INFO - PID 19461 | Browser inner width/height: 1024/768 18:38:48 INFO - PID 19461 | __metrics 18:38:58 INFO - PID 19461 | RSS: Main: 165744640 18:38:58 INFO - PID 19461 | 18:41:56 INFO - PID 19461 | Cycle 1(1): loaded http://localhost:48593/tests/dromaeo/cssquery-dojo.html (next: http://localhost:48593/tests/dromaeo/cssquery-ext.html) 18:41:57 INFO - PID 19461 | RSS: Main: 170332160 18:41:57 INFO - PID 19461 | 18:44:59 INFO - PID 19461 | Cycle 1(1): loaded http://localhost:48593/tests/dromaeo/cssquery-ext.html (next: http://localhost:48593/tests/dromaeo/cssquery-jquery.html) 18:44:59 INFO - PID 19461 | RSS: Main: 166502400 18:44:59 INFO - PID 19461 | 18:48:01 INFO - PID 19461 | Cycle 1(1): loaded http://localhost:48593/tests/dromaeo/cssquery-jquery.html (next: http://localhost:48593/tests/dromaeo/cssquery-mootools.html) 18:48:02 INFO - PID 19461 | RSS: Main: 169107456 18:48:02 INFO - PID 19461 | 18:51:03 INFO - PID 19461 | Cycle 1(1): loaded http://localhost:48593/tests/dromaeo/cssquery-mootools.html (next: http://localhost:48593/tests/dromaeo/cssquery-prototype.html) 18:51:04 INFO - PID 19461 | RSS: Main: 167587840 18:51:04 INFO - PID 19461 | 18:54:07 INFO - PID 19461 | Cycle 1(1): loaded http://localhost:48593/tests/dromaeo/cssquery-prototype.html (next: http://localhost:48593/tests/dromaeo/cssquery-yui.html) 18:54:08 INFO - PID 19461 | RSS: Main: 171438080 18:54:08 INFO - PID 19461 | 18:57:09 INFO - PID 19461 | Cycle 1(1): loaded http://localhost:48593/tests/dromaeo/cssquery-yui.html (next: http://localhost:48593/tests/dromaeo/cssquery-dojo.html) 18:57:09 INFO - PID 19461 | RSS: Main: 171847680 18:57:09 INFO - PID 19461 | 18:57:09 INFO - PID 19461 | __start_tp_report 18:57:09 INFO - PID 19461 | _x_x_mozilla_page_load 18:57:09 INFO - PID 19461 | _x_x_mozilla_page_load_details 18:57:09 INFO - PID 19461 | |i|pagename|runs| 18:57:09 INFO - PID 19461 | |0;dojo.html;3824.1778017726183;3845.173287743135;3860.305145073886;3873.786941718204;3875.612438756124;5962.224910761605;6014.518838492915;6041.939580604198;6083.117947897557;6086.7869624563145;5974;6035.094735789634;6049.334573196956;6050.304215015274;6128.693565321739;5459;5508.862278443051;5526.253955715967;5543.445655434454;5558.416366281543;5356.812511562096;5452.972735136319;5472.042392581302;5529.060059789846;5600.52395546379;5453.182022696587;5508.862278443031;5534.280543529356;5540.750666220009;5571.052921003439;5482.616216864821;5496.80761173361;5506.174073888908;5549.944500554983;5565.916511252334;5494.313210848644;5497.587680923947;5510.118381059011;5519.172124181365;5528.143137813645;5958.225430693982;5984.640921544677;6013.75944962201;6034.6982650867285;6087.269527656709;6336.398042185985;6388.265349484822;6424.453921416685;6465.676716164173;6468.8059358219325;6479.870402591921;6559.245686746038;6562.639054851981;6601.537892347537;6601.900971485432;6056.3338032816355;6064.332923378425;6126.908096378558;6132.908006379907;6150.938490615082;6514.57655252407;6625.304343043911;6693.464522838161;6700.698468568926;6705.798826035227;6382.776602818879;6390.456811171102;6395.328490508523;6406;6413.551051426355;6479.8056058318325;6482.611043337415;6488.416042556192;6490.545661803723;6550.868982620321;6403.135576697179;6461.741530338733;6481.935180648133;6492.156019717407;6513.544051916415;6367.808965731036;6425.132607098076;6429.903551446732;6439.227292724903;6524.347565243533;4890.193118135468;4904;4905.23968784839;4908.214685650279;4908.533689299511;4468.240399132155;4505.594496495331;4549.090181963555;4558.840440584564;4560.042391097841;6058.1215723719815;6061.181740464981;6079.300880398722;6123.601965872204;6145.4161854623735;6414.198225221848;6415.903761443582;6445.548811583144;6495.350464953467;6501.382368674968;5948.583599148018;6031.306399763996;6058.818235452855;6100.48145907594;6114.969425152845;5361.222622719762;5387.892242155135;5424.566034717213;5435.239066530688;5441.428649991773;6671.099401580725;6725.29384414649;6850.246472887979;6874.346937040973;6882.827929301808;6363.14097596837;6415.454686351526;6421.486281097407;6425.710843011982;6500.219973603198;6835.111435513351;6841.589504629738;6848.863022739617;6850.212225593921;6852.383285504328;6368.87262254743;6375.840603984938;6436.967815160894;6493.155889734304;6494.383033611799;6420.06908998202;6464.612123272619;6475.061116138039;6517.283098859027;6525.2169739631545;6109;6169.81490555284;6197.659128747962;6233.875322493615;6252.249730032425;6176.413240742122;6230.626162430269;6239.563230573816;6248.656323902229;6260.968695156495;6142.508599311955;6186.566940314315;6271.153394291895;6286.905696414466;6312.4634406076;6113.51091912637;6292.024736165901;6310.7475700971445;6329.082283068838;6330.430261276507;6095.329513753395;6114.449699527064;6117.480014198843;6170.6914654268;6190.442860142609 18:57:09 INFO - PID 19461 | |1;ext.html;928.3130483442253;939.5912777941592;967.6613185385114;992.4392718114269;999.9450030248333;32393;33606.15984600386;41121.58878411215;41996.37005444921;42077;41675;41747.791261043654;41767.37348939768;41839.37240941388;41842.163156736846;7665.310122088997;7704.8844267336035;7781.066272047334;7863.174366691473;7883.211678832128;7687;7838.216178382145;7842.921570784305;7843.764687059397;7852.450328477009;7838.80402989927;7849.646765895548;7855.6464959076975;7858.09631892334;7890;7800.609969501559;7802.921970780277;7809.843803123934;7837.7648670539975;7839.412044096687;7675.808104797369;7723.034620672416;7746.922530774733;7751.341136003446;7756.689732410697;38069.61930380688;38195.618043819486;39032.804835975636;39296.41055384171;39302.21395572073;3515.367233897897;3520.1551627609447;3528.311979164064;3534.469829525566;3568.2685049564775;31963;31976.680233197603;32016.679833201837;32098.518522222184;32130.518042229152;5230.503102205284;5238.5023422774775;5245.895082098375;5278.498542638443;5297.523222909918;204425;204608;204818;204920.99999999852;205072;49385.259221111715;49391.25913111306;49443.50556494389;49510.50489495059;49523.25715114276;55482.72258638681;57468.71265643729;57515.71242143846;57546;57548.547087174906;14749.631259218606;16563.6687266254;16673;16720.331186752635;16722.83277167213;12403.379831008593;13026.54407095747;13385.799213011813;13425.66435839112;13434.731305373838;14980.202375714984;15012.399504019935;15037.398504059714;15120.54638360851;15225.923870380577;5987.161797348374;6090.847728806815;6139.662318572521;6170.598911070766;6350.174477317919;1035.4460363705382;1036.72008557689;1042.3849928542197;1047.863777708893;1049.6063976008998;23508.412289692893;23845;23869;24103;24110.276691699277;1119.9664010079712;1131.6476810211882;1146.9412404733523;1147.9196456248148;1158.368689064462;12375.133740638248;12594.559190428474;12683.49266029367;12710.300933448749;12822.615321540368;271359;272222;272290;272305;272410;53630;54110.18834717482;54225.45774542283;54397.72801135969;54433;1475.5794598539364;1501.3394106593064;1515.181801827001;1517.650940283719;1552.5652817211198;23781.048758049485;28120.71879281181;28678.569821452278;29124.27189320284;29362.119136425943;52214.73892630512;52479;52540.211896822344;52611.21083183832;52736.47263527316;242694;246155;246826;247084;247158;37151.81424092862;37377;38399.616003840725;38404.615953840104;38610.613893861824;45939;46557.30164047474;46769.29846052244;47133.52866471291;47164.056718866115;34176.82911585525;35006.82496587501;35244.823775880956;35389.292214156085;35467.82266088653;34752.131196720286;34764.82617586896;34846.303073937874;34904;35008;38651.42022869603;38782.224355513295;38985.41521877117;39006.219875602896;39103.804480977415;33238.5014224782;33402.164945876546;33600;33730.15674608154;33951.4907276396;25425.61861572115;25607;25664;25915.481690366465;26107.08625198109 18:57:09 INFO - PID 19461 | |2;jquery.html;579.8376454592712;586.947174754272;589.2987345059381;591.3377017740132;604.2899592978251;22945.885270573646;23381.532369352644;23970.5205895882;23975.280741577757;23980.400489987715;26197.738022619815;26616.866915665443;26633.733662663366;26640.467190656225;26855.462890742172;6307.873842523147;6432.935670643304;6433.260175079856;6438.613683179001;6440.259370172444;5868.501177399905;6052.334243233241;6082.513398928075;6337.841553961165;6387.616742995412;6044.727987240584;6046.697665116727;6047.092936059582;6047.909281360783;6051.394860513936;6055.424734650202;6058.939410605882;6067.180930574382;6075.362086980847;6075.939240607581;5655.632383895075;5675.31896172462;5680.715964201773;5691.06097493913;5697.544196464273;27506.312342191406;30478.238044048856;30840.144981877267;30889.691103088906;31094.53358199629;2223.788740069691;2250.504888924434;2251.79733823955;2252.042881775239;2252.662100684894;20124.79875201244;20352.491187720276;20396.5920681587;20431.693524597144;20438.897805511027;2367.6448532720055;2373.655819906104;2389.307100940725;2411.445367565452;2421.5399074176025;158321;162891;163070;163553.18223408927;163780.9999999988;14620.342084606218;15342.386304547694;15893.920530397274;15975.360985560448;16003.959742616693;23753.16863909755;24804.751952480245;24859.751402486105;25099.121530746335;25166;10010.64962726301;10012.749681258027;10180.898191018143;10265.384076955257;10324.690259292083;8942.105789421006;9054.86417703735;9069.54652267384;9073.909260907438;9141.54292285383;9833.901660983298;9859.704208873745;9892;9944.154746846454;10122.089011988955;2704.770094541986;2763.571646394812;2808.747212750862;2893.7684985201136;2964.9407011859644;970.9028797458826;1005.527402121002;1025.261811495722;1029.897010298979;1033.7777377863795;20238.69641955372;21109.68335474969;21589.352319430443;21681.132754689952;24340.391490212533;1037.3101887244898;1054.6466933577185;1059.7297689089232;1059.862217911682;1066.8773091094624;11567.537298507965;11811.645650630495;11841.763164736656;11914.106442016884;12024.819627705592;610922;612695;633952;665385;673654;129107;132255;132316;136128;137350;1294.0682708449901;1308.7251677147715;1321.4119716726157;1325.5294370498334;1332.5202926946292;18596.326330629767;18889.622207555498;19092.522686932938;19127.23491060342;19760.01199940026;51392;63773.68113159404;63931;64961.67519162374;65424;75035.62482187554;76777.23222767701;77551;77915.61042194752;78075;15021.399144034116;15304.540863774104;15415.306311216247;15435.22823858825;15473.226338683246;23613;23851.165209217594;23926.64110038316;24064.87967560151;24071.638925415784;16605.75091373606;16752.832471675127;16931;16938.15309234509;16957.49127526176;17526.912365438093;17559.736603950696;17649.470515884543;17923.193456294237;17968.91015544914;19099.713504297168;19264.8073519263;19326.4202073938;20060.799392005894;20390.69413958762;14683.779743304072;15303.158326292161;15505.922470387575;15555.066695998275;15557.76663350028;19312.61374772525;19471.4158575243;19497.415077547696;19538.413847584594;19615.11731972036 18:57:09 INFO - PID 19461 | |3;mootools.html;1391.2139641102776;1433.7561715914592;1467.449706360115;1467.9486217982374;1475.8229012518495;15777.526674199778;16245.756313655274;16379.09914954677;16382.83617163831;16401.261943212554;15616.375344986216;16724.83275167248;16738.497845064638;16760.41338553151;16765.91617041916;2771.778257739381;2818.985905070482;2819.0837977657243;2819.3374556979197;2820.4218135282217;2686.1807148819603;2750.2024412920327;2792.2740087577276;2795.6365672462553;2797.7621902138344;2568.9229323120335;2712.9593056104172;2763.2677340504783;2766.432881259337;2767.51568475517;2546.31249562618;2550.1711943618307;2577.9355516112246;2579.6904371475357;2581.638570600108;2582.83211591246;2596.1173201111715;2618.2930608735724;2622.829516081468;2624.593188055854;14570.635734106627;14651.926740366336;14683.339249733788;14742.852571474363;14825;7964;8225.71210007653;8227.13615070415;8242.17578242177;8242.793930151794;5188.662736922088;5359.356877174725;5371.462853714636;5473.425290344497;5505.3393592768725;1867.458437053253;1873.6721073812027;1880.4170707080848;1904.628597423503;1904.9142788574547;27890.163295101178;28179.577306340216;28204.717952820618;28230.294242644097;28249.57625635617;6760.9846323370375;6802.007116868562;6831.795046148623;6952.687129079203;6956.095707558086;18507.814921850877;18615.162317695736;18670.43988680342;18697.065146742607;18725.25098996025;8055.718049868344;8226.712065077694;8227.259546640711;8239.134890836376;8243.175682431829;6285.120083188357;6417.550771445954;6610.867782644416;7407.333339999426;7548.622568871535;5214.426413094557;5353.223782551586;5417.566594672417;5422.43064478232;5510.421405752419;1516.4313382481569;1519.6504803894945;1529.06726896593;1529.8852586056091;1533.0377117289886;945.4421891084294;950.021477877787;951.191487235844;952.3666761603595;984.6799790068256;9470.479123648265;9516.19112375456;9524.95237523808;9606.519674016272;9639.228861691048;1019.7042857571221;1051.3113910388554;1052.8526006359116;1060.4008735064817;1066.338869900651;4920;5006.224035274538;5060.3927528696795;5071.442141364447;5149.970005998815;23175.18886838986;23376.76623233746;23942.162024329064;24097;24102.39744006414;23138.768612313663;23140.190093346653;23423.297301080995;23424.765752342257;23433.88283058574;12199.939000304941;12246.387680616112;12350;12370.876291237153;12494.312812795202;8997.235235004837;9019.729408117766;9035.63857445721;9036.367454278137;9154.496502692416;20144.294949676692;20290.188392464137;20297.49256268605;20526.794732053088;20669.793302066788;20629.793702062787;20803.06386212594;20812.687809682564;20859.957002150135;21040.263590774248;13168.144070635379;13273.33633318311;13407.463701452223;13417.731645366843;13425.798613020617;14522.49171279;14729.631759206106;14858.257087145816;14875.776863346842;14882.330295136528;12066.517339306329;12106.51573937068;12252.87747122553;12501.187422817487;12572.874271257171;11370.94314528422;11551.133664974992;11745;11765.705857353292;11864.110191735826;9596.040395960626;9715.659951901649;9721.951390243003;9738.561764720745;9772.315937884565;7714.688502954624;7767.262110099531;7781.5331080135375;7824.334931530883;7861.921380786348;7877.291043806085;8113.107558168479;8121.918780812116;8177.141400152898;8191.344692424473 18:57:09 INFO - PID 19461 | |4;prototype.html;526.807715183958;528.3342987835331;545.9535939445148;551.3494076989152;559.0607778931396;5942.61373010754;6004.789832355868;6015.338312785596;6130.846728831782;6131.754729810802;5940.3762604926505;5980.61126026808;6003.5497337699735;6021.488173505258;6021.548383871205;4979.377577802775;4979.701217926918;4981.427135879366;4987.526185012436;5026.547610715035;4696.906061878761;4787.760611969387;4944.456109827916;4953.232249001392;4956.231784073474;4710.646701497401;4792.760361981905;4795.952040479586;4806.110869489138;4819.807207711705;4777.402824646919;4811.59101476375;4827.7998141616845;4845.0067736114015;4847.230760772292;4394.780260986938;4409.581089796464;4417.646588272931;4419.806652203919;4424.093060922503;5866.677332746697;5921.171036054956;5929.199558059693;5953.166556682068;5986.4612184903135;5514.9043363521605;5547.55619550435;5557.861053473655;5595.580331475156;5619.6066275360745;6305.716242769086;6347.904781428282;6363.459105975998;6380.266269379034;6380.553361264713;4793.664443488957;4819.783109760069;4840.564349208588;4856.927146092811;4876.561109500127;6353.5870168438905;6443.226812782496;6456.418922296922;6501.349865013461;6635.469162466991;4877.5366340197625;4899.4365647950945;4926.211806111005;4930.605551555867;4986.750662466862;5006.774695138727;5030.119729047402;5042.117629414911;5055.34280543527;5056.216286475602;5521.917171242435;5554.222408862763;5617.9719101404235;5635.774569017275;5650.74571644277;6361.936380636227;6393.264774550893;6401.199850018747;6406.391392817768;6411.455026322721;1711.7517959895745;1737.695903216932;1742.851857592119;1753.7544743735887;1761.0666346836197;1196.8803119688137;1237.3627581795383;1241.3296819717432;1246.3581255653346;1252.4927404401233;6045.879082418415;6076.179715738407;6118.449339559372;6129.724162412702;6134.141220229171;6378.553501254868;6385.393387628168;6451.1936007999;6480.157579514633;6516.706748196342;6032.607880487754;6043.456088952015;6049.733144102223;6090.543209259324;6107.908381374283;3321.0036988903717;3376.307856889381;3414.641462646436;3425.7088147507243;3433.1588760753775;6449;6762.391384775296;6780.796576102724;6833.794986150423;6862.176538815374;6577.276499585042;6580.967095164589;6589.341065893373;6610.8016759497295;6644.402003819583;6705.2624211336715;6730.394264516217;6785.660716964132;6802.455803535804;6808.727650894008;6271.686415679289;6410.8076757697345;6451.483881289391;6483.319251478715;6507.316731743288;6393.968030159819;6419.871602568016;6433.970564709624;6437.356264373525;6499.805005849832;6805.829854253683;6806;6859.862802743817;6873.175218973755;6901;4943.505649435172;4976.2286845539;4977.527134922177;4980.950190498049;5006.874828129326;6299.96850015747;6368;6439.484841212786;6528.804135875931;6546.476281897341;6131.172291740736;6179.505639548735;6213.875722485615;6239.188905442264;6292.905606415999;6128.846778830565;6188.659623720559;6228.252609686867;6236.906446403217;6256.186695729526;6171.197744293213;6171.6297022178815;6174.691265436621;6231.501479881689;6255.874882502416;6204.689765511796;6238.909965161722;6306.432421082125;6323.778667746791;6342.492600592034;6178.814635560941;6196.225471816023;6201.666641672062;6203.937960620336;6217.844553886008 18:57:09 INFO - PID 19461 | |5;yui.html;949.4066208619613;951.7294411960033;977.7897751983322;989.5448093876817;1000.1998401278977;16946.74579881301;17408.12959352032;17424.82575174248;17450;18250.726239106425;17933.461996140137;19471.805281947178;19646.803531964677;19664.410067697958;19757.506062348413;1059.3220338983058;1079.6653037558342;1079.8002369561657;1080.4975686305866;1081.5349399758102;1045.6235755128148;1068.9251752377336;1070.1545778834711;1082.832161015044;1088.1947358954355;1110.5890820396423;1113.0149817411568;1115.4144074360945;1117.083991127276;1117.4133579870552;1107.5403707461394;1107.634480621401;1108.3682301088384;1110.9500072496676;1111.4053981120103;813.3655748516167;818.5048045932185;818.643889907892;821.404481750726;822.4325215601276;15890.443834465737;16251.431199908066;19084;19283.90358048201;19299;21758.78241217599;21832.563348733096;21850.12599496034;22405.55188896213;22426;16074.839251607451;16263.268152933146;16296.592585185346;16374.181290935405;16412.507624771275;3896.8051597420017;3915.8629447969183;3918.118423354751;3920.2355540669582;3929.705272104575;124023.9999999991;139700;139859;140969;141138;15260.923695381674;15368.154751488775;15491.767623485657;15517.146556939477;15881;28253.71746282511;28331;28346.574801377996;28416.28959275993;28562.714372856004;8945.06076861933;8957.865632015395;8959.104089590988;8959.641614335354;8980.146886045815;3930.8427662893164;4286.421333120051;4445.2887537993765;4503.549645035536;4504.346869703874;4822.7829747661435;5832.562557808096;5990.7903223386975;5993.101034844808;6001.399860013964;1125.6285425809463;1149.0290704354807;1165.6328256599145;1166.4342793745027;1166.9183157179086;729.606012753118;741.9035525381773;751.3425752466592;759.5063208914139;766.938644908406;11939.522419103312;12247.142700011093;12258.877411225774;13026.934865325802;13640.317984100755;723.9239879812649;744.2334395572569;752.9774106776805;757.7310054930531;763.694522191128;5632.493075623213;5683.573731970118;5716.79991200306;6033.396660333931;6078.3617720138745;124381.40283687256;124827.3758631201;125758.37120814338;128321.3583932093;132204;111941;113017.43491282656;113855;114128.42935785268;117272;99157;100536;100773;101922.99999999852;102967.97032029583;11208.607698730832;11215.943920280346;11413.828792567952;11482.13883958723;11698.883011169779;46854;48579.757101214265;49213.26180107373;49453.75273123611;50255;61875;61940.38059619346;63246.68376658087;63550.68224658847;65273.673631633435;16007.839921600635;16190.838091618933;16291.755623665418;16445.09551974653;16483.58791030234;18317.450476485727;18438.631227375645;18631.695781295723;20633.48416289605;21370.679439808104;17596.648067038845;18743.531411714815;19039.90480047591;19155.616887662447;19272;17786.91106544459;17904.28382864723;18015.369462068764;18496.44510664682;18704.251829926652;16522.66954660876;17528.91235543865;18374.908125459286;18888.716669250247;19196;12748.171368860994;12760.42578084007;13047.28239946812;13061.020423468468;13885.722285554435;14045.789313160516;14440.855591443951;14535.709285814013;14930.776038359216;15009.399624014917 18:57:09 INFO - PID 19461 | __end_tp_report 18:57:09 INFO - PID 19461 | __start_cc_report 18:57:09 INFO - PID 19461 | _x_x_mozilla_cycle_collect,343 18:57:09 INFO - PID 19461 | __end_cc_report 18:57:09 INFO - PID 19461 | __startTimestamp1503712629962__endTimestamp 18:57:09 INFO - PID 19461 | 18:57:09 INFO - PID 19461 | ------- Summary: start ------- 18:57:09 INFO - PID 19461 | Number of tests: 6 18:57:09 INFO - PID 19461 | 18:57:09 INFO - PID 19461 | [#0] dojo.html Cycles:165 Average:6016.63 Median:6170.69 stddev:647.09 (10.5%) stddev-sans-first:625.80 18:57:09 INFO - PID 19461 | Values: 3824.2 3845.2 3860.3 3873.8 3875.6 5962.2 6014.5 6041.9 6083.1 6086.8 5974.0 6035.1 6049.3 6050.3 6128.7 5459.0 5508.9 5526.3 5543.4 5558.4 5356.8 5453.0 5472.0 5529.1 5600.5 5453.2 5508.9 5534.3 5540.8 5571.1 5482.6 5496.8 5506.2 5549.9 5565.9 5494.3 5497.6 5510.1 5519.2 5528.1 5958.2 5984.6 6013.8 6034.7 6087.3 6336.4 6388.3 6424.5 6465.7 6468.8 6479.9 6559.2 6562.6 6601.5 6601.9 6056.3 6064.3 6126.9 6132.9 6150.9 6514.6 6625.3 6693.5 6700.7 6705.8 6382.8 6390.5 6395.3 6406.0 6413.6 6479.8 6482.6 6488.4 6490.5 6550.9 6403.1 6461.7 6481.9 6492.2 6513.5 6367.8 6425.1 6429.9 6439.2 6524.3 4890.2 4904.0 4905.2 4908.2 4908.5 4468.2 4505.6 4549.1 4558.8 4560.0 6058.1 6061.2 6079.3 6123.6 6145.4 6414.2 6415.9 6445.5 6495.4 6501.4 5948.6 6031.3 6058.8 6100.5 6115.0 5361.2 5387.9 5424.6 5435.2 5441.4 6671.1 6725.3 6850.2 6874.3 6882.8 6363.1 6415.5 6421.5 6425.7 6500.2 6835.1 6841.6 6848.9 6850.2 6852.4 6368.9 6375.8 6437.0 6493.2 6494.4 6420.1 6464.6 6475.1 6517.3 6525.2 6109.0 6169.8 6197.7 6233.9 6252.2 6176.4 6230.6 6239.6 6248.7 6261.0 6142.5 6186.6 6271.2 6286.9 6312.5 6113.5 6292.0 6310.7 6329.1 6330.4 6095.3 6114.4 6117.5 6170.7 6190.4 18:57:09 INFO - PID 19461 | 18:57:09 INFO - PID 19461 | [#1] ext.html Cycles:180 Average:41867.22 Median:19518.05 stddev:63085.79 (323.2%) stddev-sans-first:63187.87 18:57:09 INFO - PID 19461 | Values: 928.3 939.6 967.7 992.4 999.9 32393.0 33606.2 41121.6 41996.4 42077.0 41675.0 41747.8 41767.4 41839.4 41842.2 7665.3 7704.9 7781.1 7863.2 7883.2 7687.0 7838.2 7842.9 7843.8 7852.5 7838.8 7849.6 7855.6 7858.1 7890.0 7800.6 7802.9 7809.8 7837.8 7839.4 7675.8 7723.0 7746.9 7751.3 7756.7 38069.6 38195.6 39032.8 39296.4 39302.2 3515.4 3520.2 3528.3 3534.5 3568.3 31963.0 31976.7 32016.7 32098.5 32130.5 5230.5 5238.5 5245.9 5278.5 5297.5 204425.0 204608.0 204818.0 204921.0 205072.0 49385.3 49391.3 49443.5 49510.5 49523.3 55482.7 57468.7 57515.7 57546.0 57548.5 14749.6 16563.7 16673.0 16720.3 16722.8 12403.4 13026.5 13385.8 13425.7 13434.7 14980.2 15012.4 15037.4 15120.5 15225.9 5987.2 6090.8 6139.7 6170.6 6350.2 1035.4 1036.7 1042.4 1047.9 1049.6 23508.4 23845.0 23869.0 24103.0 24110.3 1120.0 1131.6 1146.9 1147.9 1158.4 12375.1 12594.6 12683.5 12710.3 12822.6 271359.0 272222.0 272290.0 272305.0 272410.0 53630.0 54110.2 54225.5 54397.7 54433.0 1475.6 1501.3 1515.2 1517.7 1552.6 23781.0 28120.7 28678.6 29124.3 29362.1 52214.7 52479.0 52540.2 52611.2 52736.5 242694.0 246155.0 246826.0 247084.0 247158.0 37151.8 37377.0 38399.6 38404.6 38610.6 45939.0 46557.3 46769.3 47133.5 47164.1 34176.8 35006.8 35244.8 35389.3 35467.8 34752.1 34764.8 34846.3 34904.0 35008.0 38651.4 38782.2 38985.4 39006.2 39103.8 33238.5 33402.2 33600.0 33730.2 33951.5 25425.6 25607.0 25664.0 25915.5 26107.1 18:57:09 INFO - PID 19461 | 18:57:09 INFO - PID 19461 | [#2] jquery.html Cycles:180 Average:40749.64 Median:23497.27 stddev:107136.88 (456.0%) stddev-sans-first:107394.98 18:57:09 INFO - PID 19461 | Values: 579.8 586.9 589.3 591.3 604.3 22945.9 23381.5 23970.5 23975.3 23980.4 26197.7 26616.9 26633.7 26640.5 26855.5 6307.9 6432.9 6433.3 6438.6 6440.3 5868.5 6052.3 6082.5 6337.8 6387.6 6044.7 6046.7 6047.1 6047.9 6051.4 6055.4 6058.9 6067.2 6075.4 6075.9 5655.6 5675.3 5680.7 5691.1 5697.5 27506.3 30478.2 30840.1 30889.7 31094.5 2223.8 2250.5 2251.8 2252.0 2252.7 20124.8 20352.5 20396.6 20431.7 20438.9 2367.6 2373.7 2389.3 2411.4 2421.5 158321.0 162891.0 163070.0 163553.2 163781.0 14620.3 15342.4 15893.9 15975.4 16004.0 23753.2 24804.8 24859.8 25099.1 25166.0 10010.6 10012.7 10180.9 10265.4 10324.7 8942.1 9054.9 9069.5 9073.9 9141.5 9833.9 9859.7 9892.0 9944.2 10122.1 2704.8 2763.6 2808.7 2893.8 2964.9 970.9 1005.5 1025.3 1029.9 1033.8 20238.7 21109.7 21589.4 21681.1 24340.4 1037.3 1054.6 1059.7 1059.9 1066.9 11567.5 11811.6 11841.8 11914.1 12024.8 610922.0 612695.0 633952.0 665385.0 673654.0 129107.0 132255.0 132316.0 136128.0 137350.0 1294.1 1308.7 1321.4 1325.5 1332.5 18596.3 18889.6 19092.5 19127.2 19760.0 51392.0 63773.7 63931.0 64961.7 65424.0 75035.6 76777.2 77551.0 77915.6 78075.0 15021.4 15304.5 15415.3 15435.2 15473.2 23613.0 23851.2 23926.6 24064.9 24071.6 16605.8 16752.8 16931.0 16938.2 16957.5 17526.9 17559.7 17649.5 17923.2 17968.9 19099.7 19264.8 19326.4 20060.8 20390.7 14683.8 15303.2 15505.9 15555.1 15557.8 19312.6 19471.4 19497.4 19538.4 19615.1 18:57:09 INFO - PID 19461 | 18:57:09 INFO - PID 19461 | [#3] mootools.html Cycles:180 Average:9926.18 Median:2582.24 stddev:7265.62 (281.4%) stddev-sans-first:7257.70 18:57:09 INFO - PID 19461 | Values: 1391.2 1433.8 1467.4 1467.9 1475.8 15777.5 16245.8 16379.1 16382.8 16401.3 15616.4 16724.8 16738.5 16760.4 16765.9 2771.8 2819.0 2819.1 2819.3 2820.4 2686.2 2750.2 2792.3 2795.6 2797.8 2568.9 2713.0 2763.3 2766.4 2767.5 2546.3 2550.2 2577.9 2579.7 2581.6 2582.8 2596.1 2618.3 2622.8 2624.6 14570.6 14651.9 14683.3 14742.9 14825.0 7964.0 8225.7 8227.1 8242.2 8242.8 5188.7 5359.4 5371.5 5473.4 5505.3 1867.5 1873.7 1880.4 1904.6 1904.9 27890.2 28179.6 28204.7 28230.3 28249.6 6761.0 6802.0 6831.8 6952.7 6956.1 18507.8 18615.2 18670.4 18697.1 18725.3 8055.7 8226.7 8227.3 8239.1 8243.2 6285.1 6417.6 6610.9 7407.3 7548.6 5214.4 5353.2 5417.6 5422.4 5510.4 1516.4 1519.7 1529.1 1529.9 1533.0 945.4 950.0 951.2 952.4 984.7 9470.5 9516.2 9525.0 9606.5 9639.2 1019.7 1051.3 1052.9 1060.4 1066.3 4920.0 5006.2 5060.4 5071.4 5150.0 23175.2 23376.8 23942.2 24097.0 24102.4 23138.8 23140.2 23423.3 23424.8 23433.9 12199.9 12246.4 12350.0 12370.9 12494.3 8997.2 9019.7 9035.6 9036.4 9154.5 20144.3 20290.2 20297.5 20526.8 20669.8 20629.8 20803.1 20812.7 20860.0 21040.3 13168.1 13273.3 13407.5 13417.7 13425.8 14522.5 14729.6 14858.3 14875.8 14882.3 12066.5 12106.5 12252.9 12501.2 12572.9 11370.9 11551.1 11745.0 11765.7 11864.1 9596.0 9715.7 9722.0 9738.6 9772.3 7714.7 7767.3 7781.5 7824.3 7861.9 7877.3 8113.1 8121.9 8177.1 8191.3 18:57:09 INFO - PID 19461 | 18:57:09 INFO - PID 19461 | [#4] prototype.html Cycles:180 Average:5413.70 Median:6047.81 stddev:1507.96 (24.9%) stddev-sans-first:1466.90 18:57:09 INFO - PID 19461 | Values: 526.8 528.3 546.0 551.3 559.1 5942.6 6004.8 6015.3 6130.8 6131.8 5940.4 5980.6 6003.5 6021.5 6021.5 4979.4 4979.7 4981.4 4987.5 5026.5 4696.9 4787.8 4944.5 4953.2 4956.2 4710.6 4792.8 4796.0 4806.1 4819.8 4777.4 4811.6 4827.8 4845.0 4847.2 4394.8 4409.6 4417.6 4419.8 4424.1 5866.7 5921.2 5929.2 5953.2 5986.5 5514.9 5547.6 5557.9 5595.6 5619.6 6305.7 6347.9 6363.5 6380.3 6380.6 4793.7 4819.8 4840.6 4856.9 4876.6 6353.6 6443.2 6456.4 6501.3 6635.5 4877.5 4899.4 4926.2 4930.6 4986.8 5006.8 5030.1 5042.1 5055.3 5056.2 5521.9 5554.2 5618.0 5635.8 5650.7 6361.9 6393.3 6401.2 6406.4 6411.5 1711.8 1737.7 1742.9 1753.8 1761.1 1196.9 1237.4 1241.3 1246.4 1252.5 6045.9 6076.2 6118.4 6129.7 6134.1 6378.6 6385.4 6451.2 6480.2 6516.7 6032.6 6043.5 6049.7 6090.5 6107.9 3321.0 3376.3 3414.6 3425.7 3433.2 6449.0 6762.4 6780.8 6833.8 6862.2 6577.3 6581.0 6589.3 6610.8 6644.4 6705.3 6730.4 6785.7 6802.5 6808.7 6271.7 6410.8 6451.5 6483.3 6507.3 6394.0 6419.9 6434.0 6437.4 6499.8 6805.8 6806.0 6859.9 6873.2 6901.0 4943.5 4976.2 4977.5 4981.0 5006.9 6300.0 6368.0 6439.5 6528.8 6546.5 6131.2 6179.5 6213.9 6239.2 6292.9 6128.8 6188.7 6228.3 6236.9 6256.2 6171.2 6171.6 6174.7 6231.5 6255.9 6204.7 6238.9 6306.4 6323.8 6342.5 6178.8 6196.2 6201.7 6203.9 6217.8 18:57:09 INFO - PID 19461 | 18:57:09 INFO - PID 19461 | [#5] yui.html Cycles:180 Average:25235.78 Median:17918.87 stddev:36240.76 (202.2%) stddev-sans-first:36296.54 18:57:09 INFO - PID 19461 | Values: 949.4 951.7 977.8 989.5 1000.2 16946.7 17408.1 17424.8 17450.0 18250.7 17933.5 19471.8 19646.8 19664.4 19757.5 1059.3 1079.7 1079.8 1080.5 1081.5 1045.6 1068.9 1070.2 1082.8 1088.2 1110.6 1113.0 1115.4 1117.1 1117.4 1107.5 1107.6 1108.4 1111.0 1111.4 813.4 818.5 818.6 821.4 822.4 15890.4 16251.4 19084.0 19283.9 19299.0 21758.8 21832.6 21850.1 22405.6 22426.0 16074.8 16263.3 16296.6 16374.2 16412.5 3896.8 3915.9 3918.1 3920.2 3929.7 124024.0 139700.0 139859.0 140969.0 141138.0 15260.9 15368.2 15491.8 15517.1 15881.0 28253.7 28331.0 28346.6 28416.3 28562.7 8945.1 8957.9 8959.1 8959.6 8980.1 3930.8 4286.4 4445.3 4503.5 4504.3 4822.8 5832.6 5990.8 5993.1 6001.4 1125.6 1149.0 1165.6 1166.4 1166.9 729.6 741.9 751.3 759.5 766.9 11939.5 12247.1 12258.9 13026.9 13640.3 723.9 744.2 753.0 757.7 763.7 5632.5 5683.6 5716.8 6033.4 6078.4 124381.4 124827.4 125758.4 128321.4 132204.0 111941.0 113017.4 113855.0 114128.4 117272.0 99157.0 100536.0 100773.0 101923.0 102968.0 11208.6 11215.9 11413.8 11482.1 11698.9 46854.0 48579.8 49213.3 49453.8 50255.0 61875.0 61940.4 63246.7 63550.7 65273.7 16007.8 16190.8 16291.8 16445.1 16483.6 18317.5 18438.6 18631.7 20633.5 21370.7 17596.6 18743.5 19039.9 19155.6 19272.0 17786.9 17904.3 18015.4 18496.4 18704.3 16522.7 17528.9 18374.9 18888.7 19196.0 12748.2 12760.4 13047.3 13061.0 13885.7 14045.8 14440.9 14535.7 14930.8 15009.4 18:57:09 INFO - PID 19461 | -------- Summary: end -------- 18:57:09 INFO - PID 19461 | 18:57:10 INFO - TEST-INFO | 19461: exit 0 18:57:10 INFO - TEST-OK | dromaeo_css | took 1108802ms 18:57:10 INFO - TEST-START | kraken 18:57:10 INFO - Initialising browser for kraken test... 18:57:10 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:48593/getInfo.html -profile /tmp/tmpYXXTjS/profile 18:57:10 INFO - TEST-INFO | started process 19875 (/builds/slave/test/build/application/firefox/firefox http://localhost:48593/getInfo.html) 18:57:15 INFO - TEST-INFO | 19875: exit 0 18:57:15 INFO - Browser initialized. 18:57:15 INFO - Running cycle 1/1 for kraken test... 18:57:15 INFO - Using env: {'DISPLAY': ':0', 18:57:15 INFO - 'HOME': '/home/cltbld', 18:57:15 INFO - 'JSGC_DISABLE_POISONING': '1', 18:57:15 INFO - 'LANG': 'en_US.UTF-8', 18:57:15 INFO - 'LANGUAGE': 'en_US:en', 18:57:15 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 18:57:15 INFO - 'LOGNAME': 'cltbld', 18:57:15 INFO - 'MAIL': '/var/mail/cltbld', 18:57:16 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 18:57:16 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 18:57:16 INFO - 'MOZ_CRASHREPORTER': '1', 18:57:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:57:16 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 18:57:16 INFO - 'MOZ_NO_REMOTE': '1', 18:57:16 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 18:57:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:57:16 INFO - 'NO_EM_RESTART': '1', 18:57:16 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:57:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:57:16 INFO - 'PWD': '/builds/slave/test', 18:57:16 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 18:57:16 INFO - 'RUST_BACKTRACE': 'full', 18:57:16 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 18:57:16 INFO - 'SHELL': '/bin/bash', 18:57:16 INFO - 'SHLVL': '1', 18:57:16 INFO - 'TERM': 'linux', 18:57:16 INFO - 'TMOUT': '86400', 18:57:16 INFO - 'USER': 'cltbld', 18:57:16 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1503711450.800940-1362830451', 18:57:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:57:16 INFO - '_': '/tools/buildbot/bin/python'} 18:57:16 INFO - TEST-INFO | started process 20052 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpYXXTjS/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 18:57:16 INFO - PID 20052 | 18:57:16 INFO - PID 20052 | (/builds/slave/test/build/application/firefox/firefox:20102): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 18:57:16 INFO - PID 20052 | 18:57:17 INFO - PID 20052 | 18:57:17 INFO - PID 20052 | (/builds/slave/test/build/application/firefox/firefox:20157): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 18:57:17 INFO - PID 20052 | 18:57:17 INFO - PID 20052 | __metrics Screen width/height:1600/1200 18:57:17 INFO - PID 20052 | colorDepth:24 18:57:17 INFO - PID 20052 | Browser inner width/height: 1024/768 18:57:17 INFO - PID 20052 | __metrics 18:57:27 INFO - PID 20052 | RSS: Main: 165257216 18:57:27 INFO - PID 20052 | 18:57:29 INFO - PID 20052 | Cycle 1(1): loaded http://localhost:48593/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:48593/tests/kraken/driver.html?testName=audio-beat-detection) 18:57:30 INFO - PID 20052 | RSS: Main: 169480192 18:57:30 INFO - PID 20052 | 18:57:33 INFO - PID 20052 | Cycle 1(1): loaded http://localhost:48593/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:48593/tests/kraken/driver.html?testName=audio-dft) 18:57:33 INFO - PID 20052 | RSS: Main: 172527616 18:57:33 INFO - PID 20052 | 18:57:36 INFO - PID 20052 | Cycle 1(1): loaded http://localhost:48593/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:48593/tests/kraken/driver.html?testName=audio-fft) 18:57:37 INFO - PID 20052 | RSS: Main: 165744640 18:57:37 INFO - PID 20052 | 18:57:39 INFO - PID 20052 | Cycle 1(1): loaded http://localhost:48593/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:48593/tests/kraken/driver.html?testName=audio-oscillator) 18:57:40 INFO - PID 20052 | RSS: Main: 166588416 18:57:40 INFO - PID 20052 | 18:57:42 INFO - PID 20052 | Cycle 1(1): loaded http://localhost:48593/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:48593/tests/kraken/driver.html?testName=imaging-gaussian-blur) 18:57:42 INFO - PID 20052 | RSS: Main: 166490112 18:57:42 INFO - PID 20052 | 18:57:45 INFO - PID 20052 | Cycle 1(1): loaded http://localhost:48593/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:48593/tests/kraken/driver.html?testName=imaging-darkroom) 18:57:46 INFO - PID 20052 | RSS: Main: 167960576 18:57:46 INFO - PID 20052 | 18:57:49 INFO - PID 20052 | Cycle 1(1): loaded http://localhost:48593/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:48593/tests/kraken/driver.html?testName=imaging-desaturate) 18:57:50 INFO - PID 20052 | RSS: Main: 169918464 18:57:50 INFO - PID 20052 | 18:57:53 INFO - PID 20052 | Cycle 1(1): loaded http://localhost:48593/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:48593/tests/kraken/driver.html?testName=json-parse-financial) 18:57:53 INFO - PID 20052 | RSS: Main: 168529920 18:57:53 INFO - PID 20052 | 18:57:55 INFO - PID 20052 | Cycle 1(1): loaded http://localhost:48593/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:48593/tests/kraken/driver.html?testName=json-stringify-tinderbox) 18:57:56 INFO - PID 20052 | RSS: Main: 168484864 18:57:56 INFO - PID 20052 | 18:57:57 INFO - PID 20052 | Cycle 1(1): loaded http://localhost:48593/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:48593/tests/kraken/driver.html?testName=stanford-crypto-aes) 18:57:58 INFO - PID 20052 | RSS: Main: 168546304 18:57:58 INFO - PID 20052 | 18:58:00 INFO - PID 20052 | Cycle 1(1): loaded http://localhost:48593/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:48593/tests/kraken/driver.html?testName=stanford-crypto-ccm) 18:58:01 INFO - PID 20052 | RSS: Main: 167886848 18:58:01 INFO - PID 20052 | 18:58:03 INFO - PID 20052 | Cycle 1(1): loaded http://localhost:48593/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:48593/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 18:58:04 INFO - PID 20052 | RSS: Main: 167968768 18:58:04 INFO - PID 20052 | 18:58:07 INFO - PID 20052 | Cycle 1(1): loaded http://localhost:48593/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:48593/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 18:58:07 INFO - PID 20052 | RSS: Main: 168517632 18:58:07 INFO - PID 20052 | 18:58:09 INFO - PID 20052 | Cycle 1(1): loaded http://localhost:48593/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:48593/tests/kraken/driver.html?testName=ai-astar) 18:58:09 INFO - PID 20052 | RSS: Main: 170307584 18:58:09 INFO - PID 20052 | 18:58:09 INFO - PID 20052 | __start_tp_report 18:58:09 INFO - PID 20052 | _x_x_mozilla_page_load 18:58:09 INFO - PID 20052 | _x_x_mozilla_page_load_details 18:58:09 INFO - PID 20052 | |i|pagename|runs| 18:58:09 INFO - PID 20052 | |0;ai-astar;97;107;99;107;105;107;108;98;108;107 18:58:09 INFO - PID 20052 | |1;audio-beat-detection;146;113;142;174;115;138;143;118;165;118 18:58:09 INFO - PID 20052 | |2;audio-dft;162;164;162;162;164;171;163;160;167;167 18:58:09 INFO - PID 20052 | |3;audio-fft;78;81;74;171;86;73;72;88;99;73 18:58:09 INFO - PID 20052 | |4;audio-oscillator;78;78;137;78;78;78;121;78;78;130 18:58:09 INFO - PID 20052 | |5;imaging-gaussian-blur;114;114;115;114;114;118;114;114;115;115 18:58:09 INFO - PID 20052 | |6;imaging-darkroom;150;150;149;149;150;153;149;149;150;150 18:58:09 INFO - PID 20052 | |7;imaging-desaturate;94;94;94;94;94;94;99;95;93;94 18:58:09 INFO - PID 20052 | |8;json-parse-financial;48;46;47;45;45;45;47;46;45;46 18:58:09 INFO - PID 20052 | |9;json-stringify-tinderbox;51;51;51;51;50;51;50;51;51;51 18:58:09 INFO - PID 20052 | |10;stanford-crypto-aes;75;72;73;73;73;73;71;76;74;73 18:58:09 INFO - PID 20052 | |11;stanford-crypto-ccm;116;119;115;112;128;127;119;115;112;156 18:58:09 INFO - PID 20052 | |12;stanford-crypto-pbkdf2;166;165;166;161;168;169;165;163;162;163 18:58:09 INFO - PID 20052 | |13;stanford-crypto-sha256-iterative;63;69;60;59;60;62;59;64;62;60 18:58:09 INFO - PID 20052 | __end_tp_report 18:58:09 INFO - PID 20052 | __start_cc_report 18:58:09 INFO - PID 20052 | _x_x_mozilla_cycle_collect,888 18:58:09 INFO - PID 20052 | __end_cc_report 18:58:09 INFO - PID 20052 | __startTimestamp1503712689652__endTimestamp 18:58:09 INFO - PID 20052 | 18:58:09 INFO - PID 20052 | ------- Summary: start ------- 18:58:09 INFO - PID 20052 | Number of tests: 14 18:58:09 INFO - PID 20052 | 18:58:09 INFO - PID 20052 | [#0] ai-astar Cycles:10 Average:104.30 Median:108.00 stddev:4.45 (4.1%) stddev-sans-first:3.86 18:58:09 INFO - PID 20052 | Values: 97.0 107.0 99.0 107.0 105.0 107.0 108.0 98.0 108.0 107.0 18:58:09 INFO - PID 20052 | 18:58:09 INFO - PID 20052 | [#1] audio-beat-detection Cycles:10 Average:137.20 Median:142.50 stddev:21.29 (14.9%) stddev-sans-first:22.34 18:58:09 INFO - PID 20052 | Values: 146.0 113.0 142.0 174.0 115.0 138.0 143.0 118.0 165.0 118.0 18:58:09 INFO - PID 20052 | 18:58:09 INFO - PID 20052 | [#2] audio-dft Cycles:10 Average:164.20 Median:164.00 stddev:3.26 (2.0%) stddev-sans-first:3.36 18:58:09 INFO - PID 20052 | Values: 162.0 164.0 162.0 162.0 164.0 171.0 163.0 160.0 167.0 167.0 18:58:09 INFO - PID 20052 | 18:58:09 INFO - PID 20052 | [#3] audio-fft Cycles:10 Average:89.50 Median:79.50 stddev:29.89 (37.6%) stddev-sans-first:31.42 18:58:09 INFO - PID 20052 | Values: 78.0 81.0 74.0 171.0 86.0 73.0 72.0 88.0 99.0 73.0 18:58:09 INFO - PID 20052 | 18:58:09 INFO - PID 20052 | [#4] audio-oscillator Cycles:10 Average:93.40 Median:78.00 stddev:25.08 (32.2%) stddev-sans-first:25.98 18:58:09 INFO - PID 20052 | Values: 78.0 78.0 137.0 78.0 78.0 78.0 121.0 78.0 78.0 130.0 18:58:09 INFO - PID 20052 | 18:58:09 INFO - PID 20052 | [#5] imaging-gaussian-blur Cycles:10 Average:114.70 Median:114.50 stddev:1.25 (1.1%) stddev-sans-first:1.30 18:58:09 INFO - PID 20052 | Values: 114.0 114.0 115.0 114.0 114.0 118.0 114.0 114.0 115.0 115.0 18:58:09 INFO - PID 20052 | 18:58:09 INFO - PID 20052 | [#6] imaging-darkroom Cycles:10 Average:149.90 Median:150.00 stddev:1.20 (0.8%) stddev-sans-first:1.27 18:58:09 INFO - PID 20052 | Values: 150.0 150.0 149.0 149.0 150.0 153.0 149.0 149.0 150.0 150.0 18:58:09 INFO - PID 20052 | 18:58:09 INFO - PID 20052 | [#7] imaging-desaturate Cycles:10 Average:94.50 Median:94.00 stddev:1.65 (1.8%) stddev-sans-first:1.74 18:58:09 INFO - PID 20052 | Values: 94.0 94.0 94.0 94.0 94.0 94.0 99.0 95.0 93.0 94.0 18:58:09 INFO - PID 20052 | 18:58:09 INFO - PID 20052 | [#8] json-parse-financial Cycles:10 Average:46.00 Median:46.00 stddev:1.05 (2.3%) stddev-sans-first:0.83 18:58:09 INFO - PID 20052 | Values: 48.0 46.0 47.0 45.0 45.0 45.0 47.0 46.0 45.0 46.0 18:58:09 INFO - PID 20052 | 18:58:09 INFO - PID 20052 | [#9] json-stringify-tinderbox Cycles:10 Average:50.80 Median:51.00 stddev:0.42 (0.8%) stddev-sans-first:0.44 18:58:09 INFO - PID 20052 | Values: 51.0 51.0 51.0 51.0 50.0 51.0 50.0 51.0 51.0 51.0 18:58:09 INFO - PID 20052 | 18:58:09 INFO - PID 20052 | [#10] stanford-crypto-aes Cycles:10 Average:73.30 Median:73.00 stddev:1.42 (1.9%) stddev-sans-first:1.36 18:58:09 INFO - PID 20052 | Values: 75.0 72.0 73.0 73.0 73.0 73.0 71.0 76.0 74.0 73.0 18:58:09 INFO - PID 20052 | 18:58:09 INFO - PID 20052 | [#11] stanford-crypto-ccm Cycles:10 Average:121.90 Median:119.00 stddev:13.20 (11.1%) stddev-sans-first:13.83 18:58:09 INFO - PID 20052 | Values: 116.0 119.0 115.0 112.0 128.0 127.0 119.0 115.0 112.0 156.0 18:58:09 INFO - PID 20052 | 18:58:09 INFO - PID 20052 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:164.80 Median:165.50 stddev:2.57 (1.6%) stddev-sans-first:2.69 18:58:09 INFO - PID 20052 | Values: 166.0 165.0 166.0 161.0 168.0 169.0 165.0 163.0 162.0 163.0 18:58:09 INFO - PID 20052 | 18:58:09 INFO - PID 20052 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:61.80 Median:62.00 stddev:3.05 (4.9%) stddev-sans-first:3.20 18:58:09 INFO - PID 20052 | Values: 63.0 69.0 60.0 59.0 60.0 62.0 59.0 64.0 62.0 60.0 18:58:09 INFO - PID 20052 | -------- Summary: end -------- 18:58:09 INFO - PID 20052 | 18:58:09 INFO - PID 20052 | 18:58:09 INFO - PID 20052 | ###!!! [Parent][MessageChannel] Error: (msgtype=0x150082,name=PBrowser::Msg_Destroy) Closed channel: cannot send/recv 18:58:09 INFO - PID 20052 | 18:58:09 INFO - PID 20052 | 18:58:09 INFO - PID 20052 | ###!!! [Child][MessageChannel] Error: (msgtype=0x150001,name=PBrowser::Msg_AsyncMessage) Closed channel: cannot send/recv 18:58:09 INFO - PID 20052 | 18:58:10 INFO - PID 20052 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 18:58:10 INFO - TEST-INFO | 20052: exit 0 18:58:10 INFO - TEST-OK | kraken | took 59849ms 18:58:10 INFO - SUITE-END | took 1168s 18:58:10 INFO - Completed test suite (00:19:28) 18:58:10 INFO - javascript benchmark 18:58:10 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8742.148251766921, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3824.1778017726183, 3845.173287743135, 3860.305145073886, 3873.786941718204, 3875.612438756124, 5962.224910761605, 6014.518838492915, 6041.939580604198, 6083.117947897557, 6086.7869624563145, 5974.0, 6035.094735789634, 6049.334573196956, 6050.304215015274, 6128.693565321739, 5459.0, 5508.862278443051, 5526.253955715967, 5543.445655434454, 5558.416366281543, 5356.812511562096, 5452.972735136319, 5472.042392581302, 5529.060059789846, 5600.52395546379, 5453.182022696587, 5508.862278443031, 5534.280543529356, 5540.750666220009, 5571.052921003439, 5482.616216864821, 5496.80761173361, 5506.174073888908, 5549.944500554983, 5565.916511252334, 5494.313210848644, 5497.587680923947, 5510.118381059011, 5519.172124181365, 5528.143137813645, 5958.225430693982, 5984.640921544677, 6013.75944962201, 6034.6982650867285, 6087.269527656709, 6336.398042185985, 6388.265349484822, 6424.453921416685, 6465.676716164173, 6468.8059358219325, 6479.870402591921, 6559.245686746038, 6562.639054851981, 6601.537892347537, 6601.900971485432, 6056.3338032816355, 6064.332923378425, 6126.908096378558, 6132.908006379907, 6150.938490615082, 6514.57655252407, 6625.304343043911, 6693.464522838161, 6700.698468568926, 6705.798826035227, 6382.776602818879, 6390.456811171102, 6395.328490508523, 6406.0, 6413.551051426355, 6479.8056058318325, 6482.611043337415, 6488.416042556192, 6490.545661803723, 6550.868982620321, 6403.135576697179, 6461.741530338733, 6481.935180648133, 6492.156019717407, 6513.544051916415, 6367.808965731036, 6425.132607098076, 6429.903551446732, 6439.227292724903, 6524.347565243533, 4890.193118135468, 4904.0, 4905.23968784839, 4908.214685650279, 4908.533689299511, 4468.240399132155, 4505.594496495331, 4549.090181963555, 4558.840440584564, 4560.042391097841, 6058.1215723719815, 6061.181740464981, 6079.300880398722, 6123.601965872204, 6145.4161854623735, 6414.198225221848, 6415.903761443582, 6445.548811583144, 6495.350464953467, 6501.382368674968, 5948.583599148018, 6031.306399763996, 6058.818235452855, 6100.48145907594, 6114.969425152845, 5361.222622719762, 5387.892242155135, 5424.566034717213, 5435.239066530688, 5441.428649991773, 6671.099401580725, 6725.29384414649, 6850.246472887979, 6874.346937040973, 6882.827929301808, 6363.14097596837, 6415.454686351526, 6421.486281097407, 6425.710843011982, 6500.219973603198, 6835.111435513351, 6841.589504629738, 6848.863022739617, 6850.212225593921, 6852.383285504328, 6368.87262254743, 6375.840603984938, 6436.967815160894, 6493.155889734304, 6494.383033611799, 6420.06908998202, 6464.612123272619, 6475.061116138039, 6517.283098859027, 6525.2169739631545, 6109.0, 6169.81490555284, 6197.659128747962, 6233.875322493615, 6252.249730032425, 6176.413240742122, 6230.626162430269, 6239.563230573816, 6248.656323902229, 6260.968695156495, 6142.508599311955, 6186.566940314315, 6271.153394291895, 6286.905696414466, 6312.4634406076, 6113.51091912637, 6292.024736165901, 6310.7475700971445, 6329.082283068838, 6330.430261276507, 6095.329513753395, 6114.449699527064, 6117.480014198843, 6170.6914654268, 6190.442860142609], "value": 5977.210642388813, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [928.3130483442253, 939.5912777941592, 967.6613185385114, 992.4392718114269, 999.9450030248333, 32393.0, 33606.15984600386, 41121.58878411215, 41996.37005444921, 42077.0, 41675.0, 41747.791261043654, 41767.37348939768, 41839.37240941388, 41842.163156736846, 7665.310122088997, 7704.8844267336035, 7781.066272047334, 7863.174366691473, 7883.211678832128, 7687.0, 7838.216178382145, 7842.921570784305, 7843.764687059397, 7852.450328477009, 7838.80402989927, 7849.646765895548, 7855.6464959076975, 7858.09631892334, 7890.0, 7800.609969501559, 7802.921970780277, 7809.843803123934, 7837.7648670539975, 7839.412044096687, 7675.808104797369, 7723.034620672416, 7746.922530774733, 7751.341136003446, 7756.689732410697, 38069.61930380688, 38195.618043819486, 39032.804835975636, 39296.41055384171, 39302.21395572073, 3515.367233897897, 3520.1551627609447, 3528.311979164064, 3534.469829525566, 3568.2685049564775, 31963.0, 31976.680233197603, 32016.679833201837, 32098.518522222184, 32130.518042229152, 5230.503102205284, 5238.5023422774775, 5245.895082098375, 5278.498542638443, 5297.523222909918, 204425.0, 204608.0, 204818.0, 204920.99999999852, 205072.0, 49385.259221111715, 49391.25913111306, 49443.50556494389, 49510.50489495059, 49523.25715114276, 55482.72258638681, 57468.71265643729, 57515.71242143846, 57546.0, 57548.547087174906, 14749.631259218606, 16563.6687266254, 16673.0, 16720.331186752635, 16722.83277167213, 12403.379831008593, 13026.54407095747, 13385.799213011813, 13425.66435839112, 13434.731305373838, 14980.202375714984, 15012.399504019935, 15037.398504059714, 15120.54638360851, 15225.923870380577, 5987.161797348374, 6090.847728806815, 6139.662318572521, 6170.598911070766, 6350.174477317919, 1035.4460363705382, 1036.72008557689, 1042.3849928542197, 1047.863777708893, 1049.6063976008998, 23508.412289692893, 23845.0, 23869.0, 24103.0, 24110.276691699277, 1119.9664010079712, 1131.6476810211882, 1146.9412404733523, 1147.9196456248148, 1158.368689064462, 12375.133740638248, 12594.559190428474, 12683.49266029367, 12710.300933448749, 12822.615321540368, 271359.0, 272222.0, 272290.0, 272305.0, 272410.0, 53630.0, 54110.18834717482, 54225.45774542283, 54397.72801135969, 54433.0, 1475.5794598539364, 1501.3394106593064, 1515.181801827001, 1517.650940283719, 1552.5652817211198, 23781.048758049485, 28120.71879281181, 28678.569821452278, 29124.27189320284, 29362.119136425943, 52214.73892630512, 52479.0, 52540.211896822344, 52611.21083183832, 52736.47263527316, 242694.0, 246155.0, 246826.0, 247084.0, 247158.0, 37151.81424092862, 37377.0, 38399.616003840725, 38404.615953840104, 38610.613893861824, 45939.0, 46557.30164047474, 46769.29846052244, 47133.52866471291, 47164.056718866115, 34176.82911585525, 35006.82496587501, 35244.823775880956, 35389.292214156085, 35467.82266088653, 34752.131196720286, 34764.82617586896, 34846.303073937874, 34904.0, 35008.0, 38651.42022869603, 38782.224355513295, 38985.41521877117, 39006.219875602896, 39103.804480977415, 33238.5014224782, 33402.164945876546, 33600.0, 33730.15674608154, 33951.4907276396, 25425.61861572115, 25607.0, 25664.0, 25915.481690366465, 26107.08625198109], "value": 18237.212487786757, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [579.8376454592712, 586.947174754272, 589.2987345059381, 591.3377017740132, 604.2899592978251, 22945.885270573646, 23381.532369352644, 23970.5205895882, 23975.280741577757, 23980.400489987715, 26197.738022619815, 26616.866915665443, 26633.733662663366, 26640.467190656225, 26855.462890742172, 6307.873842523147, 6432.935670643304, 6433.260175079856, 6438.613683179001, 6440.259370172444, 5868.501177399905, 6052.334243233241, 6082.513398928075, 6337.841553961165, 6387.616742995412, 6044.727987240584, 6046.697665116727, 6047.092936059582, 6047.909281360783, 6051.394860513936, 6055.424734650202, 6058.939410605882, 6067.180930574382, 6075.362086980847, 6075.939240607581, 5655.632383895075, 5675.31896172462, 5680.715964201773, 5691.06097493913, 5697.544196464273, 27506.312342191406, 30478.238044048856, 30840.144981877267, 30889.691103088906, 31094.53358199629, 2223.788740069691, 2250.504888924434, 2251.79733823955, 2252.042881775239, 2252.662100684894, 20124.79875201244, 20352.491187720276, 20396.5920681587, 20431.693524597144, 20438.897805511027, 2367.6448532720055, 2373.655819906104, 2389.307100940725, 2411.445367565452, 2421.5399074176025, 158321.0, 162891.0, 163070.0, 163553.18223408927, 163780.9999999988, 14620.342084606218, 15342.386304547694, 15893.920530397274, 15975.360985560448, 16003.959742616693, 23753.16863909755, 24804.751952480245, 24859.751402486105, 25099.121530746335, 25166.0, 10010.64962726301, 10012.749681258027, 10180.898191018143, 10265.384076955257, 10324.690259292083, 8942.105789421006, 9054.86417703735, 9069.54652267384, 9073.909260907438, 9141.54292285383, 9833.901660983298, 9859.704208873745, 9892.0, 9944.154746846454, 10122.089011988955, 2704.770094541986, 2763.571646394812, 2808.747212750862, 2893.7684985201136, 2964.9407011859644, 970.9028797458826, 1005.527402121002, 1025.261811495722, 1029.897010298979, 1033.7777377863795, 20238.69641955372, 21109.68335474969, 21589.352319430443, 21681.132754689952, 24340.391490212533, 1037.3101887244898, 1054.6466933577185, 1059.7297689089232, 1059.862217911682, 1066.8773091094624, 11567.537298507965, 11811.645650630495, 11841.763164736656, 11914.106442016884, 12024.819627705592, 610922.0, 612695.0, 633952.0, 665385.0, 673654.0, 129107.0, 132255.0, 132316.0, 136128.0, 137350.0, 1294.0682708449901, 1308.7251677147715, 1321.4119716726157, 1325.5294370498334, 1332.5202926946292, 18596.326330629767, 18889.622207555498, 19092.522686932938, 19127.23491060342, 19760.01199940026, 51392.0, 63773.68113159404, 63931.0, 64961.67519162374, 65424.0, 75035.62482187554, 76777.23222767701, 77551.0, 77915.61042194752, 78075.0, 15021.399144034116, 15304.540863774104, 15415.306311216247, 15435.22823858825, 15473.226338683246, 23613.0, 23851.165209217594, 23926.64110038316, 24064.87967560151, 24071.638925415784, 16605.75091373606, 16752.832471675127, 16931.0, 16938.15309234509, 16957.49127526176, 17526.912365438093, 17559.736603950696, 17649.470515884543, 17923.193456294237, 17968.91015544914, 19099.713504297168, 19264.8073519263, 19326.4202073938, 20060.799392005894, 20390.69413958762, 14683.779743304072, 15303.158326292161, 15505.922470387575, 15555.066695998275, 15557.76663350028, 19312.61374772525, 19471.4158575243, 19497.415077547696, 19538.413847584594, 19615.11731972036], "value": 12484.692198053368, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1391.2139641102776, 1433.7561715914592, 1467.449706360115, 1467.9486217982374, 1475.8229012518495, 15777.526674199778, 16245.756313655274, 16379.09914954677, 16382.83617163831, 16401.261943212554, 15616.375344986216, 16724.83275167248, 16738.497845064638, 16760.41338553151, 16765.91617041916, 2771.778257739381, 2818.985905070482, 2819.0837977657243, 2819.3374556979197, 2820.4218135282217, 2686.1807148819603, 2750.2024412920327, 2792.2740087577276, 2795.6365672462553, 2797.7621902138344, 2568.9229323120335, 2712.9593056104172, 2763.2677340504783, 2766.432881259337, 2767.51568475517, 2546.31249562618, 2550.1711943618307, 2577.9355516112246, 2579.6904371475357, 2581.638570600108, 2582.83211591246, 2596.1173201111715, 2618.2930608735724, 2622.829516081468, 2624.593188055854, 14570.635734106627, 14651.926740366336, 14683.339249733788, 14742.852571474363, 14825.0, 7964.0, 8225.71210007653, 8227.13615070415, 8242.17578242177, 8242.793930151794, 5188.662736922088, 5359.356877174725, 5371.462853714636, 5473.425290344497, 5505.3393592768725, 1867.458437053253, 1873.6721073812027, 1880.4170707080848, 1904.628597423503, 1904.9142788574547, 27890.163295101178, 28179.577306340216, 28204.717952820618, 28230.294242644097, 28249.57625635617, 6760.9846323370375, 6802.007116868562, 6831.795046148623, 6952.687129079203, 6956.095707558086, 18507.814921850877, 18615.162317695736, 18670.43988680342, 18697.065146742607, 18725.25098996025, 8055.718049868344, 8226.712065077694, 8227.259546640711, 8239.134890836376, 8243.175682431829, 6285.120083188357, 6417.550771445954, 6610.867782644416, 7407.333339999426, 7548.622568871535, 5214.426413094557, 5353.223782551586, 5417.566594672417, 5422.43064478232, 5510.421405752419, 1516.4313382481569, 1519.6504803894945, 1529.06726896593, 1529.8852586056091, 1533.0377117289886, 945.4421891084294, 950.021477877787, 951.191487235844, 952.3666761603595, 984.6799790068256, 9470.479123648265, 9516.19112375456, 9524.95237523808, 9606.519674016272, 9639.228861691048, 1019.7042857571221, 1051.3113910388554, 1052.8526006359116, 1060.4008735064817, 1066.338869900651, 4920.0, 5006.224035274538, 5060.3927528696795, 5071.442141364447, 5149.970005998815, 23175.18886838986, 23376.76623233746, 23942.162024329064, 24097.0, 24102.39744006414, 23138.768612313663, 23140.190093346653, 23423.297301080995, 23424.765752342257, 23433.88283058574, 12199.939000304941, 12246.387680616112, 12350.0, 12370.876291237153, 12494.312812795202, 8997.235235004837, 9019.729408117766, 9035.63857445721, 9036.367454278137, 9154.496502692416, 20144.294949676692, 20290.188392464137, 20297.49256268605, 20526.794732053088, 20669.793302066788, 20629.793702062787, 20803.06386212594, 20812.687809682564, 20859.957002150135, 21040.263590774248, 13168.144070635379, 13273.33633318311, 13407.463701452223, 13417.731645366843, 13425.798613020617, 14522.49171279, 14729.631759206106, 14858.257087145816, 14875.776863346842, 14882.330295136528, 12066.517339306329, 12106.51573937068, 12252.87747122553, 12501.187422817487, 12572.874271257171, 11370.94314528422, 11551.133664974992, 11745.0, 11765.705857353292, 11864.110191735826, 9596.040395960626, 9715.659951901649, 9721.951390243003, 9738.561764720745, 9772.315937884565, 7714.688502954624, 7767.262110099531, 7781.5331080135375, 7824.334931530883, 7861.921380786348, 7877.291043806085, 8113.107558168479, 8121.918780812116, 8177.141400152898, 8191.344692424473], "value": 6984.514090075841, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [526.807715183958, 528.3342987835331, 545.9535939445148, 551.3494076989152, 559.0607778931396, 5942.61373010754, 6004.789832355868, 6015.338312785596, 6130.846728831782, 6131.754729810802, 5940.3762604926505, 5980.61126026808, 6003.5497337699735, 6021.488173505258, 6021.548383871205, 4979.377577802775, 4979.701217926918, 4981.427135879366, 4987.526185012436, 5026.547610715035, 4696.906061878761, 4787.760611969387, 4944.456109827916, 4953.232249001392, 4956.231784073474, 4710.646701497401, 4792.760361981905, 4795.952040479586, 4806.110869489138, 4819.807207711705, 4777.402824646919, 4811.59101476375, 4827.7998141616845, 4845.0067736114015, 4847.230760772292, 4394.780260986938, 4409.581089796464, 4417.646588272931, 4419.806652203919, 4424.093060922503, 5866.677332746697, 5921.171036054956, 5929.199558059693, 5953.166556682068, 5986.4612184903135, 5514.9043363521605, 5547.55619550435, 5557.861053473655, 5595.580331475156, 5619.6066275360745, 6305.716242769086, 6347.904781428282, 6363.459105975998, 6380.266269379034, 6380.553361264713, 4793.664443488957, 4819.783109760069, 4840.564349208588, 4856.927146092811, 4876.561109500127, 6353.5870168438905, 6443.226812782496, 6456.418922296922, 6501.349865013461, 6635.469162466991, 4877.5366340197625, 4899.4365647950945, 4926.211806111005, 4930.605551555867, 4986.750662466862, 5006.774695138727, 5030.119729047402, 5042.117629414911, 5055.34280543527, 5056.216286475602, 5521.917171242435, 5554.222408862763, 5617.9719101404235, 5635.774569017275, 5650.74571644277, 6361.936380636227, 6393.264774550893, 6401.199850018747, 6406.391392817768, 6411.455026322721, 1711.7517959895745, 1737.695903216932, 1742.851857592119, 1753.7544743735887, 1761.0666346836197, 1196.8803119688137, 1237.3627581795383, 1241.3296819717432, 1246.3581255653346, 1252.4927404401233, 6045.879082418415, 6076.179715738407, 6118.449339559372, 6129.724162412702, 6134.141220229171, 6378.553501254868, 6385.393387628168, 6451.1936007999, 6480.157579514633, 6516.706748196342, 6032.607880487754, 6043.456088952015, 6049.733144102223, 6090.543209259324, 6107.908381374283, 3321.0036988903717, 3376.307856889381, 3414.641462646436, 3425.7088147507243, 3433.1588760753775, 6449.0, 6762.391384775296, 6780.796576102724, 6833.794986150423, 6862.176538815374, 6577.276499585042, 6580.967095164589, 6589.341065893373, 6610.8016759497295, 6644.402003819583, 6705.2624211336715, 6730.394264516217, 6785.660716964132, 6802.455803535804, 6808.727650894008, 6271.686415679289, 6410.8076757697345, 6451.483881289391, 6483.319251478715, 6507.316731743288, 6393.968030159819, 6419.871602568016, 6433.970564709624, 6437.356264373525, 6499.805005849832, 6805.829854253683, 6806.0, 6859.862802743817, 6873.175218973755, 6901.0, 4943.505649435172, 4976.2286845539, 4977.527134922177, 4980.950190498049, 5006.874828129326, 6299.96850015747, 6368.0, 6439.484841212786, 6528.804135875931, 6546.476281897341, 6131.172291740736, 6179.505639548735, 6213.875722485615, 6239.188905442264, 6292.905606415999, 6128.846778830565, 6188.659623720559, 6228.252609686867, 6236.906446403217, 6256.186695729526, 6171.197744293213, 6171.6297022178815, 6174.691265436621, 6231.501479881689, 6255.874882502416, 6204.689765511796, 6238.909965161722, 6306.432421082125, 6323.778667746791, 6342.492600592034, 6178.814635560941, 6196.225471816023, 6201.666641672062, 6203.937960620336, 6217.844553886008], "value": 4979.8246673478025, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [949.4066208619613, 951.7294411960033, 977.7897751983322, 989.5448093876817, 1000.1998401278977, 16946.74579881301, 17408.12959352032, 17424.82575174248, 17450.0, 18250.726239106425, 17933.461996140137, 19471.805281947178, 19646.803531964677, 19664.410067697958, 19757.506062348413, 1059.3220338983058, 1079.6653037558342, 1079.8002369561657, 1080.4975686305866, 1081.5349399758102, 1045.6235755128148, 1068.9251752377336, 1070.1545778834711, 1082.832161015044, 1088.1947358954355, 1110.5890820396423, 1113.0149817411568, 1115.4144074360945, 1117.083991127276, 1117.4133579870552, 1107.5403707461394, 1107.634480621401, 1108.3682301088384, 1110.9500072496676, 1111.4053981120103, 813.3655748516167, 818.5048045932185, 818.643889907892, 821.404481750726, 822.4325215601276, 15890.443834465737, 16251.431199908066, 19084.0, 19283.90358048201, 19299.0, 21758.78241217599, 21832.563348733096, 21850.12599496034, 22405.55188896213, 22426.0, 16074.839251607451, 16263.268152933146, 16296.592585185346, 16374.181290935405, 16412.507624771275, 3896.8051597420017, 3915.8629447969183, 3918.118423354751, 3920.2355540669582, 3929.705272104575, 124023.9999999991, 139700.0, 139859.0, 140969.0, 141138.0, 15260.923695381674, 15368.154751488775, 15491.767623485657, 15517.146556939477, 15881.0, 28253.71746282511, 28331.0, 28346.574801377996, 28416.28959275993, 28562.714372856004, 8945.06076861933, 8957.865632015395, 8959.104089590988, 8959.641614335354, 8980.146886045815, 3930.8427662893164, 4286.421333120051, 4445.2887537993765, 4503.549645035536, 4504.346869703874, 4822.7829747661435, 5832.562557808096, 5990.7903223386975, 5993.101034844808, 6001.399860013964, 1125.6285425809463, 1149.0290704354807, 1165.6328256599145, 1166.4342793745027, 1166.9183157179086, 729.606012753118, 741.9035525381773, 751.3425752466592, 759.5063208914139, 766.938644908406, 11939.522419103312, 12247.142700011093, 12258.877411225774, 13026.934865325802, 13640.317984100755, 723.9239879812649, 744.2334395572569, 752.9774106776805, 757.7310054930531, 763.694522191128, 5632.493075623213, 5683.573731970118, 5716.79991200306, 6033.396660333931, 6078.3617720138745, 124381.40283687256, 124827.3758631201, 125758.37120814338, 128321.3583932093, 132204.0, 111941.0, 113017.43491282656, 113855.0, 114128.42935785268, 117272.0, 99157.0, 100536.0, 100773.0, 101922.99999999852, 102967.97032029583, 11208.607698730832, 11215.943920280346, 11413.828792567952, 11482.13883958723, 11698.883011169779, 46854.0, 48579.757101214265, 49213.26180107373, 49453.75273123611, 50255.0, 61875.0, 61940.38059619346, 63246.68376658087, 63550.68224658847, 65273.673631633435, 16007.839921600635, 16190.838091618933, 16291.755623665418, 16445.09551974653, 16483.58791030234, 18317.450476485727, 18438.631227375645, 18631.695781295723, 20633.48416289605, 21370.679439808104, 17596.648067038845, 18743.531411714815, 19039.90480047591, 19155.616887662447, 19272.0, 17786.91106544459, 17904.28382864723, 18015.369462068764, 18496.44510664682, 18704.251829926652, 16522.66954660876, 17528.91235543865, 18374.908125459286, 18888.716669250247, 19196.0, 12748.171368860994, 12760.42578084007, 13047.28239946812, 13061.020423468468, 13885.722285554435, 14045.789313160516, 14440.855591443951, 14535.709285814013, 14930.776038359216, 15009.399624014917], "value": 9429.643305913854, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1466.3, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [97.0, 107.0, 99.0, 107.0, 105.0, 107.0, 108.0, 98.0, 108.0, 107.0], "value": 104.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 113.0, 142.0, 174.0, 115.0, 138.0, 143.0, 118.0, 165.0, 118.0], "value": 137.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 164.0, 162.0, 162.0, 164.0, 171.0, 163.0, 160.0, 167.0, 167.0], "value": 164.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 81.0, 74.0, 171.0, 86.0, 73.0, 72.0, 88.0, 99.0, 73.0], "value": 89.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 78.0, 137.0, 78.0, 78.0, 78.0, 121.0, 78.0, 78.0, 130.0], "value": 93.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 114.0, 115.0, 114.0, 114.0, 118.0, 114.0, 114.0, 115.0, 115.0], "value": 114.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 150.0, 149.0, 149.0, 150.0, 153.0, 149.0, 149.0, 150.0, 150.0], "value": 149.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 94.0, 94.0, 94.0, 94.0, 99.0, 95.0, 93.0, 94.0], "value": 94.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [48.0, 46.0, 47.0, 45.0, 45.0, 45.0, 47.0, 46.0, 45.0, 46.0], "value": 46.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [51.0, 51.0, 51.0, 51.0, 50.0, 51.0, 50.0, 51.0, 51.0, 51.0], "value": 50.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 72.0, 73.0, 73.0, 73.0, 73.0, 71.0, 76.0, 74.0, 73.0], "value": 73.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 119.0, 115.0, 112.0, 128.0, 127.0, 119.0, 115.0, 112.0, 156.0], "value": 121.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [166.0, 165.0, 166.0, 161.0, 168.0, 169.0, 165.0, 163.0, 162.0, 163.0], "value": 164.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 69.0, 60.0, 59.0, 60.0, 62.0, 59.0, 64.0, 62.0, 60.0], "value": 61.8, "unit": "score"}]}]} 18:58:10 INFO - Return code: 0 18:58:10 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 18:58:10 INFO - # TBPL SUCCESS # 18:58:10 INFO - Running post-action listener: _package_coverage_data 18:58:10 INFO - Running post-action listener: _resource_record_post_action 18:58:10 INFO - [mozharness: 2017-08-26 01:58:10.956243Z] Finished run-tests step (success) 18:58:10 INFO - Running post-run listener: _resource_record_post_run 18:58:11 INFO - Total resource usage - Wall time: 1187s; CPU: 13.0%; Read bytes: 8192; Write bytes: 426393600; Read time: 44; Write time: 235652 18:58:11 INFO - TinderboxPrint: CPU usage
13.0% 18:58:11 INFO - TinderboxPrint: I/O read bytes / time
8,192 / 44 18:58:11 INFO - TinderboxPrint: I/O write bytes / time
426,393,600 / 235,652 18:58:11 INFO - TinderboxPrint: CPU idle
8,228.5 (86.9%) 18:58:11 INFO - TinderboxPrint: CPU user
1,189.1 (12.6%) 18:58:11 INFO - TinderboxPrint: Swap in / out
0 / 0 18:58:11 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 106594304; Read time: 0; Write time: 63072 18:58:11 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 18:58:11 INFO - run-tests - Wall time: 1169s; CPU: 13.0%; Read bytes: 8192; Write bytes: 319365120; Read time: 44; Write time: 172552 18:58:11 INFO - Running post-run listener: _upload_blobber_files 18:58:11 INFO - Blob upload gear active. 18:58:11 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 18:58:11 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 18:58:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 18:58:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 18:58:12 INFO - (blobuploader) - INFO - Open directory for files ... 18:58:12 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 18:58:12 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:58:12 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:58:12 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 18:58:12 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:58:12 INFO - (blobuploader) - INFO - Done attempting. 18:58:12 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 18:58:12 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:58:12 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:58:14 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 18:58:14 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:58:14 INFO - (blobuploader) - INFO - Done attempting. 18:58:14 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 18:58:14 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:58:14 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:58:15 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 18:58:15 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:58:15 INFO - (blobuploader) - INFO - Done attempting. 18:58:15 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 18:58:15 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:58:15 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:58:22 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 18:58:22 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:58:22 INFO - (blobuploader) - INFO - Done attempting. 18:58:22 INFO - (blobuploader) - INFO - Iteration through files over. 18:58:22 INFO - Return code: 0 18:58:22 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 18:58:22 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 18:58:22 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4ff3fd9e00b20597eb7feecf14470cb6ca0c17431034d0b0fe084a5a2675e673e5b4cb2afb334e1b6fec3abd201a12f28715263ffb88dd723e66fb84cd341bc8", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/94372071d4e7a492175400d94445399da2b8a4b26f174a86731822390fefd30a88d6c826af5fc30e7053a1352f824021b29f97ac9cfa1537d08787dd2a66f52b", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/de237f6f19492f4a9ab15de12d330a138e359d5ef9f63476486c95d4f24cbc8adbe0ae68372a41385e44b784f4735a38d0ba08c48e65429a25c0dec8fb4ece6d", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/894b93e21d11c6cdf59354d7ce3b670b7fd3f971921e82eeed607c3586dd43f446f5abde725710ae1f0da024e678b082d1fa4fbe6059b53e90452bbdc412c036"} 18:58:22 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 18:58:22 INFO - Writing to file /builds/slave/test/properties/blobber_files 18:58:22 INFO - Contents: 18:58:22 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4ff3fd9e00b20597eb7feecf14470cb6ca0c17431034d0b0fe084a5a2675e673e5b4cb2afb334e1b6fec3abd201a12f28715263ffb88dd723e66fb84cd341bc8", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/94372071d4e7a492175400d94445399da2b8a4b26f174a86731822390fefd30a88d6c826af5fc30e7053a1352f824021b29f97ac9cfa1537d08787dd2a66f52b", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/de237f6f19492f4a9ab15de12d330a138e359d5ef9f63476486c95d4f24cbc8adbe0ae68372a41385e44b784f4735a38d0ba08c48e65429a25c0dec8fb4ece6d", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/894b93e21d11c6cdf59354d7ce3b670b7fd3f971921e82eeed607c3586dd43f446f5abde725710ae1f0da024e678b082d1fa4fbe6059b53e90452bbdc412c036"} 18:58:22 INFO - Running post-run listener: copy_logs_to_upload_dir 18:58:22 INFO - Copying logs to upload dir... 18:58:22 INFO - mkdir: /builds/slave/test/build/upload/logs 18:58:22 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1249.013971 ========= master_lag: 0.09 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 49 secs) (at 2017-08-25 18:58:22.376117) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-08-25 18:58:22.380497) ========= 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=6d15e502d8e29d5d2676d664000001c3-1503711450.800940-1362830451 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4ff3fd9e00b20597eb7feecf14470cb6ca0c17431034d0b0fe084a5a2675e673e5b4cb2afb334e1b6fec3abd201a12f28715263ffb88dd723e66fb84cd341bc8", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/94372071d4e7a492175400d94445399da2b8a4b26f174a86731822390fefd30a88d6c826af5fc30e7053a1352f824021b29f97ac9cfa1537d08787dd2a66f52b", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/de237f6f19492f4a9ab15de12d330a138e359d5ef9f63476486c95d4f24cbc8adbe0ae68372a41385e44b784f4735a38d0ba08c48e65429a25c0dec8fb4ece6d", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/894b93e21d11c6cdf59354d7ce3b670b7fd3f971921e82eeed607c3586dd43f446f5abde725710ae1f0da024e678b082d1fa4fbe6059b53e90452bbdc412c036"} build_url:https://queue.taskcluster.net/v1/task/amxk63WMTxS--589HMz9Ww/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011232 build_url: 'https://queue.taskcluster.net/v1/task/amxk63WMTxS--589HMz9Ww/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4ff3fd9e00b20597eb7feecf14470cb6ca0c17431034d0b0fe084a5a2675e673e5b4cb2afb334e1b6fec3abd201a12f28715263ffb88dd723e66fb84cd341bc8", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/94372071d4e7a492175400d94445399da2b8a4b26f174a86731822390fefd30a88d6c826af5fc30e7053a1352f824021b29f97ac9cfa1537d08787dd2a66f52b", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/de237f6f19492f4a9ab15de12d330a138e359d5ef9f63476486c95d4f24cbc8adbe0ae68372a41385e44b784f4735a38d0ba08c48e65429a25c0dec8fb4ece6d", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/894b93e21d11c6cdf59354d7ce3b670b7fd3f971921e82eeed607c3586dd43f446f5abde725710ae1f0da024e678b082d1fa4fbe6059b53e90452bbdc412c036"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-08-25 18:58:22.409699) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-08-25 18:58:22.410022) ========= 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=6d15e502d8e29d5d2676d664000001c3-1503711450.800940-1362830451 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004773 ========= master_lag: 0.07 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-08-25 18:58:22.488956) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-08-25 18:58:22.492285) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-08-25 18:58:22.492564) ========= ========= Total master_lag: 0.24 =========