builder: mozilla-central_ubuntu64_hw_styloseq_test-dromaeojs-e10s slave: talos-linux64-ix-023 starttime: 1503698858.62 results: success (0) revision: 03d7b6dd65b93afaa6981269f69e9f7cd34224bc ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-08-25 15:07:38.625041) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-08-25 15:07:38.625456) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-08-25 15:07:38.625741) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-08-25 15:07:38.644080) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-25 15:07:38.644361) ========= 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-1503698856.952209-1681960764 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-08-25 15:07:38-- 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% 110K=0.1s 2017-08-25 15:07:38 (110 KB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.283550 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-25 15:07:38.945053) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-08-25 15:07:38.945370) ========= 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-1503698856.952209-1681960764 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020971 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-08-25 15:07:39.000776) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-25 15:07:39.001129) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 03d7b6dd65b93afaa6981269f69e9f7cd34224bc --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 03d7b6dd65b93afaa6981269f69e9f7cd34224bc --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-1503698856.952209-1681960764 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-08-25 15:07:39,003 truncating revision to first 12 chars 2017-08-25 15:07:39,004 Setting DEBUG logging. 2017-08-25 15:07:39,004 attempt 1/10 2017-08-25 15:07:39,004 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/03d7b6dd65b9?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-08-25 15:07:39,472 unpacking tar archive at: mozilla-central-03d7b6dd65b9/testing/mozharness/ program finished with exit code 0 elapsedTime=0.806798 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-25 15:07:39.830680) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-08-25 15:07:39.833031) ========= script_repo_revision: 03d7b6dd65b93afaa6981269f69e9f7cd34224bc ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-08-25 15:07:39.833411) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-08-25 15:07:39.833680) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-08-25 15:07:39.845328) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 52 secs) (at 2017-08-25 15:07:39.845616) ========= /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-1503698856.952209-1681960764 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 15:07:39 INFO - MultiFileLogger online at 20170825 15:07:39 in /builds/slave/test 15:07:39 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 15:07:39 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 15:07:39 INFO - {'append_to_log': False, 15:07:39 INFO - 'base_work_dir': '/builds/slave/test', 15:07:39 INFO - 'blob_upload_branch': 'Firefox', 15:07:39 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 15:07:39 INFO - 'branch': 'Firefox', 15:07:39 INFO - 'buildbot_json_path': 'buildprops.json', 15:07:39 INFO - 'code_coverage': False, 15:07:39 INFO - 'config_files': ('talos/linux_config.py',), 15:07:39 INFO - 'default_actions': ('clobber', 15:07:39 INFO - 'read-buildbot-config', 15:07:39 INFO - 'download-and-extract', 15:07:39 INFO - 'populate-webroot', 15:07:39 INFO - 'create-virtualenv', 15:07:39 INFO - 'install', 15:07:39 INFO - 'setup-mitmproxy', 15:07:39 INFO - 'run-tests'), 15:07:39 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 15:07:39 INFO - 'disable_ccov_upload': False, 15:07:39 INFO - 'download_minidump_stackwalk': True, 15:07:39 INFO - 'download_symbols': 'ondemand', 15:07:39 INFO - 'enable_stylo': False, 15:07:39 INFO - 'enable_webrender': False, 15:07:39 INFO - 'exes': {'tooltool.py': '/tools/tooltool.py'}, 15:07:39 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 15:07:39 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 15:07:39 INFO - 'gecko_profile': False, 15:07:39 INFO - 'gecko_profile_interval': 0, 15:07:39 INFO - 'installer_path': 'installer.exe', 15:07:39 INFO - 'log_level': 'info', 15:07:39 INFO - 'log_name': 'talos', 15:07:39 INFO - 'log_to_console': True, 15:07:39 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 15:07:39 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 15:07:39 INFO - 'opt_config_files': (), 15:07:39 INFO - 'pip_index': False, 15:07:39 INFO - 'suite': 'dromaeojs-e10s', 15:07:39 INFO - 'system_bits': '32', 15:07:39 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 15:07:39 INFO - 'title': 'talos-linux64-ix-023', 15:07:39 INFO - 'tooltool_cache': '/builds/tooltool_cache', 15:07:39 INFO - 'use_talos_json': True, 15:07:39 INFO - 'verify': 'False', 15:07:39 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 15:07:39 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 15:07:39 INFO - 'work_dir': 'build'} 15:07:39 INFO - [mozharness: 2017-08-25 22:07:39.973777Z] Running clobber step. 15:07:39 INFO - Running pre-action listener: _resource_record_pre_action 15:07:39 INFO - Running main action method: clobber 15:07:39 INFO - rmtree: /builds/slave/test/build 15:07:39 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 15:07:40 INFO - Running post-action listener: _resource_record_post_action 15:07:40 INFO - [mozharness: 2017-08-25 22:07:40.991432Z] Finished clobber step (success) 15:07:40 INFO - [mozharness: 2017-08-25 22:07:40.991529Z] Running read-buildbot-config step. 15:07:40 INFO - Running pre-action listener: _resource_record_pre_action 15:07:40 INFO - Running main action method: read_buildbot_config 15:07:40 INFO - Using buildbot properties: 15:07:40 INFO - { 15:07:40 INFO - "project": "", 15:07:40 INFO - "product": "firefox", 15:07:40 INFO - "who": "kwierso@gmail.com", 15:07:40 INFO - "installer_path": "public/build/target.tar.bz2", 15:07:40 INFO - "builddir": "mozilla-central_ubuntu64_hw_styloseq_test-dromaeojs-e10s", 15:07:40 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 15:07:40 INFO - "buildername": "Ubuntu HW 12.04 x64 stylo-sequential mozilla-central talos dromaeojs-e10s", 15:07:40 INFO - "stage_platform": "linux64-stylosequential", 15:07:40 INFO - "basedir": "/builds/slave/test", 15:07:40 INFO - "buildnumber": 171, 15:07:40 INFO - "platform": "ubuntu64_hw_styloseq", 15:07:40 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 15:07:40 INFO - "slavebuilddir": "test", 15:07:40 INFO - "taskId": "IqzlgSA5SqKwNeoij9_K5w", 15:07:40 INFO - "branch": "mozilla-central", 15:07:40 INFO - "script_repo_revision": "production", 15:07:40 INFO - "revision": "03d7b6dd65b93afaa6981269f69e9f7cd34224bc", 15:07:40 INFO - "slavename": "talos-linux64-ix-023", 15:07:40 INFO - "repo_path": "mozilla-central" 15:07:40 INFO - } 15:07:40 INFO - Finding installer, test and symbols from parent task. 15:07:40 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/IqzlgSA5SqKwNeoij9_K5w'}, attempt #1 15:07:41 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/IqzlgSA5SqKwNeoij9_K5w'}, attempt #1 15:07:41 INFO - Task dependencies: fFNdRubgQVGid70fwvBNNw 15:07:41 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/fFNdRubgQVGid70fwvBNNw'}, attempt #1 15:07:42 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/fFNdRubgQVGid70fwvBNNw/artifacts/public/build/target.tar.bz2 15:07:42 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/fFNdRubgQVGid70fwvBNNw/artifacts/public/build/target.test_packages.json 15:07:42 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/fFNdRubgQVGid70fwvBNNw/artifacts/public/build/target.crashreporter-symbols.zip 15:07:42 INFO - Running post-action listener: _resource_record_post_action 15:07:42 INFO - [mozharness: 2017-08-25 22:07:42.349821Z] Finished read-buildbot-config step (success) 15:07:42 INFO - [mozharness: 2017-08-25 22:07:42.350037Z] Running download-and-extract step. 15:07:42 INFO - Running pre-action listener: _resource_record_pre_action 15:07:42 INFO - Running main action method: download_and_extract 15:07:42 INFO - mkdir: /builds/slave/test/build/tests 15:07:42 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')]} 15:07:42 INFO - trying https://queue.taskcluster.net/v1/task/fFNdRubgQVGid70fwvBNNw/artifacts/public/build/target.test_packages.json 15:07:42 INFO - Downloading https://queue.taskcluster.net/v1/task/fFNdRubgQVGid70fwvBNNw/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 15:07:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/fFNdRubgQVGid70fwvBNNw/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 15:07:42 INFO - Downloaded 989 bytes. 15:07:42 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 15:07:42 INFO - Using the following test package requirements: 15:07:42 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 15:07:42 INFO - u'common': [u'target.common.tests.zip'], 15:07:42 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 15:07:42 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 15:07:42 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 15:07:42 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 15:07:42 INFO - u'mozbase': [u'target.common.tests.zip'], 15:07:42 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 15:07:42 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 15:07:42 INFO - u'web-platform': [u'target.common.tests.zip', 15:07:42 INFO - u'target.web-platform.tests.tar.gz'], 15:07:42 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 15:07:42 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 15:07:42 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/fFNdRubgQVGid70fwvBNNw/artifacts/public/build/target.common.tests.zip 15:07:42 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/fFNdRubgQVGid70fwvBNNw/artifacts/public/build/target.common.tests.zip'}, attempt #1 15:07:42 INFO - Fetch https://queue.taskcluster.net/v1/task/fFNdRubgQVGid70fwvBNNw/artifacts/public/build/target.common.tests.zip into memory 15:07:44 INFO - Content-Length response header: 54979266 15:07:44 INFO - Bytes received: 54979266 15:07:55 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 15:07:55 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/fFNdRubgQVGid70fwvBNNw/artifacts/public/build/target.common.tests.zip 15:07:55 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/fFNdRubgQVGid70fwvBNNw/artifacts/public/build/target.common.tests.zip'}, attempt #1 15:07:55 INFO - Fetch https://queue.taskcluster.net/v1/task/fFNdRubgQVGid70fwvBNNw/artifacts/public/build/target.common.tests.zip into memory 15:07:56 INFO - Content-Length response header: 54979266 15:07:56 INFO - Bytes received: 54979266 15:08:08 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/fFNdRubgQVGid70fwvBNNw/artifacts/public/build/target.talos.tests.zip 15:08:08 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/fFNdRubgQVGid70fwvBNNw/artifacts/public/build/target.talos.tests.zip'}, attempt #1 15:08:08 INFO - Fetch https://queue.taskcluster.net/v1/task/fFNdRubgQVGid70fwvBNNw/artifacts/public/build/target.talos.tests.zip into memory 15:08:08 INFO - Content-Length response header: 14496611 15:08:08 INFO - Bytes received: 14496611 15:08: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')]} 15:08:08 INFO - trying https://queue.taskcluster.net/v1/task/fFNdRubgQVGid70fwvBNNw/artifacts/public/build/target.tar.bz2 15:08:08 INFO - Downloading https://queue.taskcluster.net/v1/task/fFNdRubgQVGid70fwvBNNw/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 15:08:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/fFNdRubgQVGid70fwvBNNw/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 15:08:10 INFO - Downloaded 61070080 bytes. 15:08:10 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/fFNdRubgQVGid70fwvBNNw/artifacts/public/build/target.tar.bz2 15:08:10 INFO - mkdir: /builds/slave/test/properties 15:08:10 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 15:08:10 INFO - Writing to file /builds/slave/test/properties/build_url 15:08:10 INFO - Contents: 15:08:10 INFO - build_url:https://queue.taskcluster.net/v1/task/fFNdRubgQVGid70fwvBNNw/artifacts/public/build/target.tar.bz2 15:08:10 INFO - Running post-action listener: _resource_record_post_action 15:08:10 INFO - Running post-action listener: find_tests_for_verification 15:08:10 INFO - Running post-action listener: set_extra_try_arguments 15:08:10 INFO - [mozharness: 2017-08-25 22:08:10.075184Z] Finished download-and-extract step (success) 15:08:10 INFO - [mozharness: 2017-08-25 22:08:10.075282Z] Running populate-webroot step. 15:08:10 INFO - Running pre-action listener: _resource_record_pre_action 15:08:10 INFO - Running main action method: populate_webroot 15:08:10 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 15:08:10 INFO - 'chromez-stylo-e10s': {'talos_options': ['--stylo'], 15:08:10 INFO - 'tests': ['tresize', 'tcanvasmark']}, 15:08:10 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 15:08:10 INFO - 'dromaeojs-stylo-e10s': {'talos_options': ['--stylo'], 15:08:10 INFO - 'tests': ['dromaeo_css', 'kraken']}, 15:08:10 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 15:08:10 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:08:10 INFO - 'g1-stylo-e10s': {'pagesets_name': 'tp5n.zip', 15:08:10 INFO - 'talos_options': ['--stylo'], 15:08:10 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:08:10 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 15:08:10 INFO - 'tests': ['damp', 'tps']}, 15:08:10 INFO - 'g2-stylo-e10s': {'pagesets_name': 'tp5n.zip', 15:08:10 INFO - 'talos_options': ['--stylo'], 15:08:10 INFO - 'tests': ['damp', 'tps']}, 15:08:10 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 15:08:10 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 15:08:10 INFO - 'g4-stylo-e10s': {'talos_options': ['--stylo'], 15:08:10 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 15:08:10 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 15:08:10 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 15:08:10 INFO - 'g5-stylo-e10s': {'pagesets_name': 'tp5n.zip', 15:08:10 INFO - 'talos_options': ['--stylo'], 15:08:10 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 15:08:10 INFO - 'other-e10s': {'tests': ['a11yr', 15:08:10 INFO - 'ts_paint', 15:08:10 INFO - 'tpaint', 15:08:10 INFO - 'sessionrestore', 15:08:10 INFO - 'sessionrestore_many_windows', 15:08:10 INFO - 'sessionrestore_no_auto_restore', 15:08:10 INFO - 'tabpaint']}, 15:08:10 INFO - 'other-stylo-e10s': {'talos_options': ['--stylo'], 15:08:10 INFO - 'tests': ['a11yr', 15:08:10 INFO - 'ts_paint', 15:08:10 INFO - 'tpaint', 15:08:10 INFO - 'sessionrestore', 15:08:10 INFO - 'sessionrestore_many_windows', 15:08:10 INFO - 'sessionrestore_no_auto_restore', 15:08:10 INFO - 'tabpaint']}, 15:08:10 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 15:08:10 INFO - 'perf-reftest-singletons-e10s': {'tests': ['bloom_basic_singleton']}, 15:08:10 INFO - 'perf-reftest-singletons-stylo-e10s': {'talos_options': ['--stylo'], 15:08:10 INFO - 'tests': ['bloom_basic_singleton']}, 15:08:10 INFO - 'perf-reftest-stylo-e10s': {'talos_options': ['--stylo'], 15:08:10 INFO - 'tests': ['bloom_basic']}, 15:08:10 INFO - 'svgr-e10s': {'tests': ['tsvgx', 15:08:10 INFO - 'tsvgr_opacity', 15:08:10 INFO - 'tart', 15:08:10 INFO - 'tscrollx', 15:08:10 INFO - 'tsvg_static']}, 15:08:10 INFO - 'svgr-stylo-e10s': {'talos_options': ['--stylo'], 15:08:10 INFO - 'tests': ['tsvgx', 15:08:10 INFO - 'tsvgr_opacity', 15:08:10 INFO - 'tart', 15:08:10 INFO - 'tscrollx', 15:08:10 INFO - 'tsvg_static']}, 15:08:10 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 15:08:10 INFO - 'tp5o-stylo-e10s': {'pagesets_name': 'tp5n.zip', 15:08:10 INFO - 'talos_options': ['--stylo'], 15:08:10 INFO - 'tests': ['tp5o']}, 15:08:10 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 15:08:10 INFO - 'talos_options': ['--mitmproxy', 15:08:10 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 15:08:10 INFO - '--firstNonBlankPaint'], 15:08:10 INFO - 'tests': ['tp6_google', 15:08:10 INFO - 'tp6_youtube', 15:08:10 INFO - 'tp6_amazon', 15:08:10 INFO - 'tp6_facebook']}, 15:08:10 INFO - 'tp6-stylo-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 15:08:10 INFO - 'talos_options': ['--stylo', 15:08:10 INFO - '--mitmproxy', 15:08:10 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 15:08:10 INFO - '--firstNonBlankPaint'], 15:08:10 INFO - 'tests': ['tp6_google', 15:08:10 INFO - 'tp6_youtube', 15:08:10 INFO - 'tp6_amazon', 15:08:10 INFO - 'tp6_facebook']}, 15:08:10 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 15:08:10 INFO - 'talos_options': ['--stylo', 15:08:10 INFO - '--stylo-threads=1', 15:08:10 INFO - '--mitmproxy', 15:08:10 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 15:08:10 INFO - '--firstNonBlankPaint'], 15:08:10 INFO - 'tests': ['tp6_google', 15:08:10 INFO - 'tp6_youtube', 15:08:10 INFO - 'tp6_amazon', 15:08:10 INFO - 'tp6_facebook']}, 15:08:10 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 15:08:10 INFO - 'talos_options': ['--xperf_path', 15:08:10 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:08:10 INFO - 'tests': ['tp5n']}, 15:08:10 INFO - 'xperf-stylo-e10s': {'pagesets_name': 'tp5n.zip', 15:08:10 INFO - 'talos_options': ['--stylo', 15:08:10 INFO - '--xperf_path', 15:08:10 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:08:10 INFO - 'tests': ['tp5n']}}} 15:08:10 INFO - Running post-action listener: _resource_record_post_action 15:08:10 INFO - [mozharness: 2017-08-25 22:08:10.089501Z] Finished populate-webroot step (success) 15:08:10 INFO - [mozharness: 2017-08-25 22:08:10.089590Z] Running create-virtualenv step. 15:08:10 INFO - Running pre-action listener: _resource_record_pre_action 15:08:10 INFO - Running main action method: create_virtualenv 15:08:10 INFO - Creating virtualenv /builds/slave/test/build/venv 15:08:10 INFO - Running command: ['virtualenv', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 15:08:10 INFO - Copy/paste: virtualenv --no-site-packages --distribute /builds/slave/test/build/venv 15:08:10 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 15:08:10 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 15:08:10 INFO - New python executable in /builds/slave/test/build/venv/bin/python 15:08:10 INFO - Installing distribute.............................................................................................................................................................................................done. 15:08:10 INFO - Installing pip...............done. 15:08:10 INFO - Return code: 0 15:08:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 15:08:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 15:08:11 INFO - Reading from file tmpfile_stdout 15:08:11 INFO - Output received: 15:08:11 INFO - pip 1.1 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.1-py2.7.egg (python 2.7) 15:08:11 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 15:08: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')]} 15:08:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:08: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')]} 15:08:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:08: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x140f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15daa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x177df90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x177b130>, '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 0x177c030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x177c4c0>, '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-1503698856.952209-1681960764', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:08: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', 'pip>=1.5'] in /builds/slave/test/build 15:08: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 pip>=1.5 15:08:11 INFO - Using env: {'DISPLAY': ':0', 15:08:11 INFO - 'HOME': '/home/cltbld', 15:08:11 INFO - 'LANG': 'en_US.UTF-8', 15:08:11 INFO - 'LANGUAGE': 'en_US:en', 15:08:11 INFO - 'LOGNAME': 'cltbld', 15:08:11 INFO - 'MAIL': '/var/mail/cltbld', 15:08:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:08:11 INFO - 'MOZ_NO_REMOTE': '1', 15:08:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:08:11 INFO - 'NO_EM_RESTART': '1', 15:08:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:08:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:08:11 INFO - 'PWD': '/builds/slave/test', 15:08:11 INFO - 'SHELL': '/bin/bash', 15:08:11 INFO - 'SHLVL': '1', 15:08:11 INFO - 'TERM': 'linux', 15:08:11 INFO - 'TMOUT': '86400', 15:08:11 INFO - 'USER': 'cltbld', 15:08:11 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1503698856.952209-1681960764', 15:08:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:08:11 INFO - '_': '/tools/buildbot/bin/python'} 15:08:12 INFO - Ignoring indexes: http://pypi.python.org/simple/ 15:08:12 INFO - Downloading/unpacking pip>=1.5 15:08:12 INFO - Running setup.py egg_info for package pip 15:08:12 INFO - warning: no files found matching 'pip/cacert.pem' 15:08:12 INFO - warning: no files found matching '*.html' under directory 'docs' 15:08:12 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 15:08:12 INFO - no previously-included directories found matching 'docs/_build/_sources' 15:08:12 INFO - Installing collected packages: pip 15:08:12 INFO - Found existing installation: pip 1.1 15:08:12 INFO - Uninstalling pip: 15:08:12 INFO - Successfully uninstalled pip 15:08:12 INFO - Running setup.py install for pip 15:08:12 INFO - warning: no files found matching 'pip/cacert.pem' 15:08:12 INFO - warning: no files found matching '*.html' under directory 'docs' 15:08:12 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 15:08:12 INFO - no previously-included directories found matching 'docs/_build/_sources' 15:08:12 INFO - Installing pip script to /builds/slave/test/build/venv/bin 15:08:12 INFO - Installing pip2.7 script to /builds/slave/test/build/venv/bin 15:08:12 INFO - Installing pip2 script to /builds/slave/test/build/venv/bin 15:08:12 INFO - Successfully installed pip 15:08:12 INFO - Cleaning up... 15:08:12 INFO - Return code: 0 15:08:12 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 15:08: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')]} 15:08:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:08: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')]} 15:08:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:08: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', '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 0x140f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15daa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x177df90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x177b130>, '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 0x177c030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x177c4c0>, '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-1503698856.952209-1681960764', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:08: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', 'psutil>=3.1.1'] in /builds/slave/test/build 15:08: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 psutil>=3.1.1 15:08:12 INFO - Using env: {'DISPLAY': ':0', 15:08:12 INFO - 'HOME': '/home/cltbld', 15:08:12 INFO - 'LANG': 'en_US.UTF-8', 15:08:12 INFO - 'LANGUAGE': 'en_US:en', 15:08:12 INFO - 'LOGNAME': 'cltbld', 15:08:12 INFO - 'MAIL': '/var/mail/cltbld', 15:08:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:08:12 INFO - 'MOZ_NO_REMOTE': '1', 15:08:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:08:12 INFO - 'NO_EM_RESTART': '1', 15:08:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:08:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:08:12 INFO - 'PWD': '/builds/slave/test', 15:08:12 INFO - 'SHELL': '/bin/bash', 15:08:12 INFO - 'SHLVL': '1', 15:08:12 INFO - 'TERM': 'linux', 15:08:12 INFO - 'TMOUT': '86400', 15:08:12 INFO - 'USER': 'cltbld', 15:08:12 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1503698856.952209-1681960764', 15:08:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:08:12 INFO - '_': '/tools/buildbot/bin/python'} 15:08:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:08:12 INFO - Downloading/unpacking psutil>=3.1.1 15:08: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 15:08: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 15:08: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 15:08: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 15:08:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 15:08:13 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:08:13 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:08:13 INFO - Installing collected packages: psutil 15:08:13 INFO - Running setup.py install for psutil 15:08:13 INFO - building 'psutil._psutil_linux' extension 15:08:13 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 15:08:13 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 15:08:13 INFO - building 'psutil._psutil_posix' extension 15:08:13 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 15:08:13 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 15:08:13 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:08:13 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:08:13 INFO - Successfully installed psutil 15:08:13 INFO - Cleaning up... 15:08:13 INFO - Return code: 0 15:08:13 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 15:08:13 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')]} 15:08:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:08:13 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')]} 15:08:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:08:13 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/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 0x140f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15daa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x177df90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x177b130>, '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 0x177c030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x177c4c0>, '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-1503698856.952209-1681960764', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:08:13 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 15:08:13 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 15:08:13 INFO - Using env: {'DISPLAY': ':0', 15:08:13 INFO - 'HOME': '/home/cltbld', 15:08:13 INFO - 'LANG': 'en_US.UTF-8', 15:08:13 INFO - 'LANGUAGE': 'en_US:en', 15:08:13 INFO - 'LOGNAME': 'cltbld', 15:08:13 INFO - 'MAIL': '/var/mail/cltbld', 15:08:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:08:13 INFO - 'MOZ_NO_REMOTE': '1', 15:08:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:08:13 INFO - 'NO_EM_RESTART': '1', 15:08:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:08:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:08:13 INFO - 'PWD': '/builds/slave/test', 15:08:13 INFO - 'SHELL': '/bin/bash', 15:08:13 INFO - 'SHLVL': '1', 15:08:13 INFO - 'TERM': 'linux', 15:08:13 INFO - 'TMOUT': '86400', 15:08:13 INFO - 'USER': 'cltbld', 15:08:13 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1503698856.952209-1681960764', 15:08:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:08:13 INFO - '_': '/tools/buildbot/bin/python'} 15:08:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:08:13 INFO - Downloading/unpacking mozsystemmonitor==0.3 15:08: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 15:08: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 15:08: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 15:08: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 15:08:14 INFO - Downloading mozsystemmonitor-0.3.tar.gz 15:08:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 15:08:15 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 15:08:15 INFO - Installing collected packages: mozsystemmonitor 15:08:15 INFO - Running setup.py install for mozsystemmonitor 15:08:15 INFO - Successfully installed mozsystemmonitor 15:08:15 INFO - Cleaning up... 15:08:15 INFO - Return code: 0 15:08:15 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 15:08:15 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')]} 15:08:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:08:15 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')]} 15:08:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:08:15 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 0x140f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15daa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x177df90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x177b130>, '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 0x177c030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x177c4c0>, '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-1503698856.952209-1681960764', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:08:15 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 15:08:15 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 15:08:15 INFO - Using env: {'DISPLAY': ':0', 15:08:15 INFO - 'HOME': '/home/cltbld', 15:08:15 INFO - 'LANG': 'en_US.UTF-8', 15:08:15 INFO - 'LANGUAGE': 'en_US:en', 15:08:15 INFO - 'LOGNAME': 'cltbld', 15:08:15 INFO - 'MAIL': '/var/mail/cltbld', 15:08:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:08:15 INFO - 'MOZ_NO_REMOTE': '1', 15:08:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:08:15 INFO - 'NO_EM_RESTART': '1', 15:08:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:08:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:08:15 INFO - 'PWD': '/builds/slave/test', 15:08:15 INFO - 'SHELL': '/bin/bash', 15:08:15 INFO - 'SHLVL': '1', 15:08:15 INFO - 'TERM': 'linux', 15:08:15 INFO - 'TMOUT': '86400', 15:08:15 INFO - 'USER': 'cltbld', 15:08:15 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1503698856.952209-1681960764', 15:08:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:08:15 INFO - '_': '/tools/buildbot/bin/python'} 15:08:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:08:15 INFO - Downloading/unpacking jsonschema==2.5.1 15:08:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:08:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:08:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:08:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:08:16 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 15:08:16 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 15:08:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:08:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:08:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:08:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:08:16 INFO - Downloading functools32-3.2.3-2.tar.gz 15:08:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 15:08:16 INFO - warning: no files found matching '*.txt' 15:08:16 INFO - no previously-included directories found matching 'build' 15:08:16 INFO - no previously-included directories found matching 'dist' 15:08:16 INFO - no previously-included directories found matching '.git*' 15:08:16 INFO - Installing collected packages: jsonschema, functools32 15:08:16 INFO - Running setup.py install for functools32 15:08:16 INFO - warning: no files found matching '*.txt' 15:08:16 INFO - no previously-included directories found matching 'build' 15:08:16 INFO - no previously-included directories found matching 'dist' 15:08:16 INFO - no previously-included directories found matching '.git*' 15:08:16 INFO - Successfully installed jsonschema functools32 15:08:16 INFO - Cleaning up... 15:08:16 INFO - Return code: 0 15:08:16 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 15:08:16 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')]} 15:08:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:08:16 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')]} 15:08:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:08:16 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/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 0x140f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15daa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x177df90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x177b130>, '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 0x177c030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x177c4c0>, '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-1503698856.952209-1681960764', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:08:16 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 15:08:16 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 15:08:16 INFO - Using env: {'DISPLAY': ':0', 15:08:16 INFO - 'HOME': '/home/cltbld', 15:08:16 INFO - 'LANG': 'en_US.UTF-8', 15:08:16 INFO - 'LANGUAGE': 'en_US:en', 15:08:16 INFO - 'LOGNAME': 'cltbld', 15:08:16 INFO - 'MAIL': '/var/mail/cltbld', 15:08:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:08:16 INFO - 'MOZ_NO_REMOTE': '1', 15:08:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:08:16 INFO - 'NO_EM_RESTART': '1', 15:08:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:08:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:08:16 INFO - 'PWD': '/builds/slave/test', 15:08:16 INFO - 'SHELL': '/bin/bash', 15:08:16 INFO - 'SHLVL': '1', 15:08:16 INFO - 'TERM': 'linux', 15:08:16 INFO - 'TMOUT': '86400', 15:08:16 INFO - 'USER': 'cltbld', 15:08:16 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1503698856.952209-1681960764', 15:08:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:08:16 INFO - '_': '/tools/buildbot/bin/python'} 15:08:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:08:17 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 15:08:17 INFO - Cleaning up... 15:08:17 INFO - Return code: 0 15:08:17 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 15:08: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')]} 15:08:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:08: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')]} 15:08:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:08:17 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 0x140f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15daa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x177df90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x177b130>, '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 0x177c030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x177c4c0>, '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-1503698856.952209-1681960764', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:08:17 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 15:08:17 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 15:08:17 INFO - Using env: {'DISPLAY': ':0', 15:08:17 INFO - 'HOME': '/home/cltbld', 15:08:17 INFO - 'LANG': 'en_US.UTF-8', 15:08:17 INFO - 'LANGUAGE': 'en_US:en', 15:08:17 INFO - 'LOGNAME': 'cltbld', 15:08:17 INFO - 'MAIL': '/var/mail/cltbld', 15:08:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:08:17 INFO - 'MOZ_NO_REMOTE': '1', 15:08:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:08:17 INFO - 'NO_EM_RESTART': '1', 15:08:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:08:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:08:17 INFO - 'PWD': '/builds/slave/test', 15:08:17 INFO - 'SHELL': '/bin/bash', 15:08:17 INFO - 'SHLVL': '1', 15:08:17 INFO - 'TERM': 'linux', 15:08:17 INFO - 'TMOUT': '86400', 15:08:17 INFO - 'USER': 'cltbld', 15:08:17 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1503698856.952209-1681960764', 15:08:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:08:17 INFO - '_': '/tools/buildbot/bin/python'} 15:08:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:08:17 INFO - Downloading/unpacking blobuploader==1.2.4 15:08:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:08:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:08:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:08:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:08:18 INFO - Downloading blobuploader-1.2.4.tar.gz 15:08:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 15:08:18 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 15:08:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:08:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:08:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:08:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:08:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 15:08:18 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 15:08:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:08:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:08:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:08:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:08:18 INFO - Downloading docopt-0.6.1.tar.gz 15:08:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 15:08:18 INFO - Installing collected packages: blobuploader, requests, docopt 15:08:18 INFO - Running setup.py install for blobuploader 15:08:19 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 15:08:19 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 15:08:19 INFO - Running setup.py install for requests 15:08:19 INFO - Running setup.py install for docopt 15:08:19 INFO - Successfully installed blobuploader requests docopt 15:08:19 INFO - Cleaning up... 15:08:19 INFO - Return code: 0 15:08:19 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:08:19 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')]} 15:08:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:08:19 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')]} 15:08:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:08:19 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 0x140f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15daa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x177df90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x177b130>, '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 0x177c030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x177c4c0>, '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-1503698856.952209-1681960764', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:08:19 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 15:08:19 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 15:08:19 INFO - Using env: {'DISPLAY': ':0', 15:08:19 INFO - 'HOME': '/home/cltbld', 15:08:19 INFO - 'LANG': 'en_US.UTF-8', 15:08:19 INFO - 'LANGUAGE': 'en_US:en', 15:08:19 INFO - 'LOGNAME': 'cltbld', 15:08:19 INFO - 'MAIL': '/var/mail/cltbld', 15:08:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:08:19 INFO - 'MOZ_NO_REMOTE': '1', 15:08:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:08:19 INFO - 'NO_EM_RESTART': '1', 15:08:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:08:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:08:19 INFO - 'PWD': '/builds/slave/test', 15:08:19 INFO - 'SHELL': '/bin/bash', 15:08:19 INFO - 'SHLVL': '1', 15:08:19 INFO - 'TERM': 'linux', 15:08:19 INFO - 'TMOUT': '86400', 15:08:19 INFO - 'USER': 'cltbld', 15:08:19 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1503698856.952209-1681960764', 15:08:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:08:19 INFO - '_': '/tools/buildbot/bin/python'} 15:08:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:08:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:08:19 INFO - Running setup.py (path:/tmp/pip-NCB_5H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:08:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:08:19 INFO - Running setup.py (path:/tmp/pip-IT0883-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:08:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:08:19 INFO - Running setup.py (path:/tmp/pip-sJp20r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:08:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:08:19 INFO - Running setup.py (path:/tmp/pip-SBEZVQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:08:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:08:20 INFO - Running setup.py (path:/tmp/pip-UkdoTl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:08:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:08:20 INFO - Running setup.py (path:/tmp/pip-krDaks-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:08:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:08:20 INFO - Running setup.py (path:/tmp/pip-dksjVA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:08:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:08:20 INFO - Running setup.py (path:/tmp/pip-W7dbtN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:08:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:08:20 INFO - Running setup.py (path:/tmp/pip-4NStBa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:08:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:08:20 INFO - Running setup.py (path:/tmp/pip-Kahg2p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:08:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:08:20 INFO - Running setup.py (path:/tmp/pip-QOCb8V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:08:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:08:20 INFO - Running setup.py (path:/tmp/pip-p6IBpp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:08:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:08:20 INFO - Running setup.py (path:/tmp/pip-0SHA62-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:08:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:08:20 INFO - Running setup.py (path:/tmp/pip-n9917K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:08:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:08:20 INFO - Running setup.py (path:/tmp/pip-7Jc19d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:08:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:08:20 INFO - Running setup.py (path:/tmp/pip-eTc09S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:08:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:08:20 INFO - Running setup.py (path:/tmp/pip-FO6ARe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:08:20 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 15:08:20 INFO - Running setup.py install for manifestparser 15:08:21 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 15:08:21 INFO - Running setup.py install for mozcrash 15:08:21 INFO - Running setup.py install for mozdebug 15:08:21 INFO - Running setup.py install for mozdevice 15:08:21 INFO - Installing dm script to /builds/slave/test/build/venv/bin 15:08:21 INFO - Running setup.py install for mozfile 15:08:21 INFO - Running setup.py install for mozhttpd 15:08:21 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 15:08:21 INFO - Running setup.py install for mozinfo 15:08:21 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 15:08:21 INFO - Running setup.py install for mozInstall 15:08:21 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 15:08:21 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 15:08:21 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 15:08:21 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 15:08:21 INFO - Running setup.py install for mozleak 15:08:21 INFO - Running setup.py install for mozlog 15:08:21 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 15:08:21 INFO - Running setup.py install for moznetwork 15:08:22 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 15:08:22 INFO - Running setup.py install for mozprocess 15:08:22 INFO - Running setup.py install for mozprofile 15:08:22 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 15:08:22 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 15:08:22 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 15:08:22 INFO - Running setup.py install for mozrunner 15:08:22 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 15:08:22 INFO - Running setup.py install for mozscreenshot 15:08:22 INFO - Running setup.py install for moztest 15:08:22 INFO - Running setup.py install for mozversion 15:08:22 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 15:08:22 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 15:08:22 INFO - Cleaning up... 15:08:22 INFO - Return code: 0 15:08:22 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:08:22 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')]} 15:08:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:08:22 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')]} 15:08:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:08:22 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 0x140f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15daa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x177df90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x177b130>, '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 0x177c030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x177c4c0>, '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-1503698856.952209-1681960764', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:08:22 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 15:08:22 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 15:08:22 INFO - Using env: {'DISPLAY': ':0', 15:08:22 INFO - 'HOME': '/home/cltbld', 15:08:22 INFO - 'LANG': 'en_US.UTF-8', 15:08:22 INFO - 'LANGUAGE': 'en_US:en', 15:08:22 INFO - 'LOGNAME': 'cltbld', 15:08:22 INFO - 'MAIL': '/var/mail/cltbld', 15:08:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:08:22 INFO - 'MOZ_NO_REMOTE': '1', 15:08:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:08:22 INFO - 'NO_EM_RESTART': '1', 15:08:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:08:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:08:22 INFO - 'PWD': '/builds/slave/test', 15:08:22 INFO - 'SHELL': '/bin/bash', 15:08:22 INFO - 'SHLVL': '1', 15:08:22 INFO - 'TERM': 'linux', 15:08:22 INFO - 'TMOUT': '86400', 15:08:22 INFO - 'USER': 'cltbld', 15:08:22 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1503698856.952209-1681960764', 15:08:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:08:22 INFO - '_': '/tools/buildbot/bin/python'} 15:08:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:08:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:08:22 INFO - Running setup.py (path:/tmp/pip-OPkuwp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:08:23 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 15:08:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:08:23 INFO - Running setup.py (path:/tmp/pip-TQ6D5j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:08:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 15:08:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:08:23 INFO - Running setup.py (path:/tmp/pip-iAYVMI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:08:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 15:08:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:08:23 INFO - Running setup.py (path:/tmp/pip-tZIbXJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:08:23 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)) 15:08:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:08:23 INFO - Running setup.py (path:/tmp/pip-lk9bvi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:08:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 15:08:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:08:23 INFO - Running setup.py (path:/tmp/pip-IXf1D8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:08:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 15:08:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:08:23 INFO - Running setup.py (path:/tmp/pip-PTcm_j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:08:23 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)) 15:08:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:08:23 INFO - Running setup.py (path:/tmp/pip-U44n6X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:08:23 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)) 15:08:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:08:23 INFO - Running setup.py (path:/tmp/pip-j6tbLO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:08:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 15:08:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:08:23 INFO - Running setup.py (path:/tmp/pip-pe3tOr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:08:23 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)) 15:08:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:08:23 INFO - Running setup.py (path:/tmp/pip-pWBw6d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:08:23 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 15:08:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:08:23 INFO - Running setup.py (path:/tmp/pip-t8VIf9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:08:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 15:08:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:08:23 INFO - Running setup.py (path:/tmp/pip-jC70RC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:08:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 15:08:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:08:23 INFO - Running setup.py (path:/tmp/pip-WOpMMg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:08:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 15:08:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:08:23 INFO - Running setup.py (path:/tmp/pip-g2Mcuk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:08:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 15:08:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:08:24 INFO - Running setup.py (path:/tmp/pip-4usZOw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:08:24 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 15:08:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:08:24 INFO - Running setup.py (path:/tmp/pip-luDLKP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:08:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 15:08:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 15:08:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 15:08:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 15:08:24 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)) 15:08:24 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)) 15:08:24 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)) 15:08:24 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 15:08:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:08:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:08:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:08:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:08:25 INFO - Downloading blessings-1.6.tar.gz 15:08:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 15:08:25 INFO - Installing collected packages: blessings 15:08:25 INFO - Running setup.py install for blessings 15:08:25 INFO - Successfully installed blessings 15:08:25 INFO - Cleaning up... 15:08:25 INFO - Return code: 0 15:08:25 INFO - Done creating virtualenv /builds/slave/test/build/venv. 15:08:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:08:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:08:25 INFO - Reading from file tmpfile_stdout 15:08:25 INFO - Current package versions: 15:08:25 INFO - argparse == 1.2.1 15:08:25 INFO - blessings == 1.6 15:08:25 INFO - blobuploader == 1.2.4 15:08:25 INFO - docopt == 0.6.1 15:08:25 INFO - functools32 == 3.2.3-2 15:08:25 INFO - jsonschema == 2.5.1 15:08:25 INFO - manifestparser == 1.1 15:08:25 INFO - mozInstall == 1.13 15:08:25 INFO - mozcrash == 1.0 15:08:25 INFO - mozdebug == 0.1 15:08:25 INFO - mozdevice == 0.51 15:08:25 INFO - mozfile == 1.2 15:08:25 INFO - mozhttpd == 0.7 15:08:25 INFO - mozinfo == 0.10 15:08:25 INFO - mozleak == 0.1 15:08:25 INFO - mozlog == 3.5 15:08:25 INFO - moznetwork == 0.27 15:08:25 INFO - mozprocess == 0.25 15:08:25 INFO - mozprofile == 0.28 15:08:25 INFO - mozrunner == 6.13 15:08:25 INFO - mozscreenshot == 0.1 15:08:25 INFO - mozsystemmonitor == 0.3 15:08:25 INFO - moztest == 0.8 15:08:25 INFO - mozversion == 1.4 15:08:25 INFO - psutil == 3.1.1 15:08:25 INFO - requests == 1.2.3 15:08:25 INFO - wsgiref == 0.1.2 15:08:25 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:08:25 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')]} 15:08:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:08:25 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')]} 15:08:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:08:25 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 0x140f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15daa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x177df90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x177b130>, '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 0x177c030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x177c4c0>, '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-1503698856.952209-1681960764', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:08:25 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 15:08:25 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 15:08:25 INFO - Using env: {'DISPLAY': ':0', 15:08:25 INFO - 'HOME': '/home/cltbld', 15:08:25 INFO - 'LANG': 'en_US.UTF-8', 15:08:25 INFO - 'LANGUAGE': 'en_US:en', 15:08:25 INFO - 'LOGNAME': 'cltbld', 15:08:25 INFO - 'MAIL': '/var/mail/cltbld', 15:08:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:08:25 INFO - 'MOZ_NO_REMOTE': '1', 15:08:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:08:25 INFO - 'NO_EM_RESTART': '1', 15:08:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:08:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:08:25 INFO - 'PWD': '/builds/slave/test', 15:08:25 INFO - 'SHELL': '/bin/bash', 15:08:25 INFO - 'SHLVL': '1', 15:08:25 INFO - 'TERM': 'linux', 15:08:25 INFO - 'TMOUT': '86400', 15:08:25 INFO - 'USER': 'cltbld', 15:08:25 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1503698856.952209-1681960764', 15:08:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:08:25 INFO - '_': '/tools/buildbot/bin/python'} 15:08:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:08:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 15:08:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 15:08:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 15:08:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 15:08:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 15:08:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 15:08:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 15:08:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 15:08:25 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 15:08:25 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 15:08:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:08:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:08:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:08:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:08:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 15:08:30 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 15:08:30 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 15:08:30 INFO - Installing collected packages: simplejson 15:08:30 INFO - Running setup.py install for simplejson 15:08:30 INFO - building 'simplejson._speedups' extension 15:08:30 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 15:08:31 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 15:08:31 INFO - Successfully installed simplejson 15:08:31 INFO - Cleaning up... 15:08:31 INFO - Return code: 0 15:08:31 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 15:08:31 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')]} 15:08:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:08:31 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')]} 15:08:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:08:31 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 0x140f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15daa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x177df90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x177b130>, '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 0x177c030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x177c4c0>, '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-1503698856.952209-1681960764', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:08:31 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 15:08:31 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 15:08:31 INFO - Using env: {'DISPLAY': ':0', 15:08:31 INFO - 'HOME': '/home/cltbld', 15:08:31 INFO - 'LANG': 'en_US.UTF-8', 15:08:31 INFO - 'LANGUAGE': 'en_US:en', 15:08:31 INFO - 'LOGNAME': 'cltbld', 15:08:31 INFO - 'MAIL': '/var/mail/cltbld', 15:08:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:08:31 INFO - 'MOZ_NO_REMOTE': '1', 15:08:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:08:31 INFO - 'NO_EM_RESTART': '1', 15:08:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:08:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:08:31 INFO - 'PWD': '/builds/slave/test', 15:08:31 INFO - 'SHELL': '/bin/bash', 15:08:31 INFO - 'SHLVL': '1', 15:08:31 INFO - 'TERM': 'linux', 15:08:31 INFO - 'TMOUT': '86400', 15:08:31 INFO - 'USER': 'cltbld', 15:08:31 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1503698856.952209-1681960764', 15:08:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:08:31 INFO - '_': '/tools/buildbot/bin/python'} 15:08:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:08:31 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 15:08:31 INFO - Cleaning up... 15:08:31 INFO - Return code: 0 15:08:31 INFO - Running post-action listener: _resource_record_post_action 15:08:31 INFO - Running post-action listener: _start_resource_monitoring 15:08:31 INFO - Starting resource monitoring. 15:08:31 INFO - [mozharness: 2017-08-25 22:08:31.404232Z] Finished create-virtualenv step (success) 15:08:31 INFO - [mozharness: 2017-08-25 22:08:31.404754Z] Running install step. 15:08:31 INFO - Running pre-action listener: _resource_record_pre_action 15:08:31 INFO - Running main action method: install 15:08:31 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:08:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:08:31 INFO - Reading from file tmpfile_stdout 15:08:31 INFO - Detecting whether we're running mozinstall >=1.0... 15:08:31 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 15:08:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 15:08:31 INFO - Reading from file tmpfile_stdout 15:08:31 INFO - Output received: 15:08:31 INFO - Usage: mozinstall [options] installer 15:08:31 INFO - Options: 15:08:31 INFO - -h, --help show this help message and exit 15:08:31 INFO - -d DEST, --destination=DEST 15:08:31 INFO - Directory to install application into. [default: 15:08:31 INFO - "/builds/slave/test"] 15:08:31 INFO - --app=APP Application being installed. [default: firefox] 15:08:31 INFO - mkdir: /builds/slave/test/build/application 15:08:31 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/target.tar.bz2', '--destination', '/builds/slave/test/build/application'] 15:08:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 15:08:49 INFO - Reading from file tmpfile_stdout 15:08:49 INFO - Output received: 15:08:49 INFO - /builds/slave/test/build/application/firefox/firefox 15:08:49 INFO - Running post-action listener: _resource_record_post_action 15:08:49 INFO - [mozharness: 2017-08-25 22:08:49.397712Z] Finished install step (success) 15:08:49 INFO - [mozharness: 2017-08-25 22:08:49.397858Z] Running setup-mitmproxy step. 15:08:49 INFO - Running pre-action listener: _resource_record_pre_action 15:08:49 INFO - Running main action method: setup_mitmproxy 15:08:49 INFO - Skipping: mitmproxy is not required 15:08:49 INFO - Running post-action listener: _resource_record_post_action 15:08:49 INFO - [mozharness: 2017-08-25 22:08:49.398391Z] Finished setup-mitmproxy step (success) 15:08:49 INFO - [mozharness: 2017-08-25 22:08:49.398548Z] Running run-tests step. 15:08:49 INFO - Running pre-action listener: _resource_record_pre_action 15:08:49 INFO - Running pre-action listener: _set_gcov_prefix 15:08:49 INFO - Running main action method: run_tests 15:08:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 15:08:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 15:08:49 INFO - Python 2.7.3 15:08:49 INFO - Return code: 0 15:08:49 INFO - grabbing minidump binary from tooltool 15:08:49 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')]} 15:08:49 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 0x177b130>, '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 0x177c030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x177c4c0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 15:08:49 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 15:08:49 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 15:08:49 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 15:08:49 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 15:08:49 INFO - Return code: 0 15:08:49 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 15:08:49 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 15:08:49 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 15:08:49 INFO - ENV: RUST_BACKTRACE is now full 15:08:49 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 15:08:49 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 15:08:49 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/fFNdRubgQVGid70fwvBNNw/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 15:08:49 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/fFNdRubgQVGid70fwvBNNw/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 15:08:49 INFO - Using env: {'DISPLAY': ':0', 15:08:49 INFO - 'HOME': '/home/cltbld', 15:08:49 INFO - 'LANG': 'en_US.UTF-8', 15:08:49 INFO - 'LANGUAGE': 'en_US:en', 15:08:49 INFO - 'LOGNAME': 'cltbld', 15:08:49 INFO - 'MAIL': '/var/mail/cltbld', 15:08:49 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 15:08:49 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 15:08:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:08:49 INFO - 'MOZ_NO_REMOTE': '1', 15:08:49 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 15:08:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:08:49 INFO - 'NO_EM_RESTART': '1', 15:08:49 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:08:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:08:49 INFO - 'PWD': '/builds/slave/test', 15:08:49 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 15:08:49 INFO - 'RUST_BACKTRACE': 'full', 15:08:49 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 15:08:49 INFO - 'SHELL': '/bin/bash', 15:08:49 INFO - 'SHLVL': '1', 15:08:49 INFO - 'STYLO_FORCE_ENABLED': '1', 15:08:49 INFO - 'TERM': 'linux', 15:08:49 INFO - 'TMOUT': '86400', 15:08:49 INFO - 'USER': 'cltbld', 15:08:49 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1503698856.952209-1681960764', 15:08:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:08:49 INFO - '_': '/tools/buildbot/bin/python'} 15:08:49 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/fFNdRubgQVGid70fwvBNNw/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 15:08:49 INFO - mozversion application_buildid: 20170825212112 15:08:49 INFO - mozversion application_changeset: 03d7b6dd65b93afaa6981269f69e9f7cd34224bc 15:08:49 INFO - mozversion application_display_name: Nightly 15:08:49 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 15:08:49 INFO - mozversion application_name: Firefox 15:08:49 INFO - mozversion application_remotingname: firefox 15:08:49 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 15:08:49 INFO - mozversion application_vendor: Mozilla 15:08:49 INFO - mozversion application_version: 57.0a1 15:08:49 INFO - mozversion platform_buildid: 20170825212112 15:08:49 INFO - mozversion platform_changeset: 03d7b6dd65b93afaa6981269f69e9f7cd34224bc 15:08:49 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 15:08:49 INFO - mozversion platform_version: 57.0a1 15:08:49 INFO - using testdate: 1503698929 15:08:49 INFO - actual date: 1503698929 15:08:49 INFO - starting webserver on 'localhost:36339' 15:08:49 INFO - SUITE-START | Running 2 tests 15:08:49 INFO - TEST-START | dromaeo_css 15:08:49 INFO - Initialising browser for dromaeo_css test... 15:08:49 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:36339/getInfo.html -profile /tmp/tmpRBpzbX/profile 15:08:49 INFO - TEST-INFO | started process 22977 (/builds/slave/test/build/application/firefox/firefox http://localhost:36339/getInfo.html) 15:08:55 INFO - TEST-INFO | 22977: exit 0 15:08:55 INFO - Browser initialized. 15:08:55 INFO - Running cycle 1/1 for dromaeo_css test... 15:08:55 INFO - Using env: {'DISPLAY': ':0', 15:08:55 INFO - 'HOME': '/home/cltbld', 15:08:55 INFO - 'JSGC_DISABLE_POISONING': '1', 15:08:55 INFO - 'LANG': 'en_US.UTF-8', 15:08:55 INFO - 'LANGUAGE': 'en_US:en', 15:08:55 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 15:08:55 INFO - 'LOGNAME': 'cltbld', 15:08:55 INFO - 'MAIL': '/var/mail/cltbld', 15:08:55 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 15:08:55 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 15:08:55 INFO - 'MOZ_CRASHREPORTER': '1', 15:08:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:08:55 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 15:08:55 INFO - 'MOZ_NO_REMOTE': '1', 15:08:55 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 15:08:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:08:55 INFO - 'NO_EM_RESTART': '1', 15:08:55 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:08:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:08:55 INFO - 'PWD': '/builds/slave/test', 15:08:55 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 15:08:55 INFO - 'RUST_BACKTRACE': 'full', 15:08:55 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 15:08:55 INFO - 'SHELL': '/bin/bash', 15:08:55 INFO - 'SHLVL': '1', 15:08:55 INFO - 'STYLO_FORCE_ENABLED': '1', 15:08:55 INFO - 'TERM': 'linux', 15:08:55 INFO - 'TMOUT': '86400', 15:08:55 INFO - 'USER': 'cltbld', 15:08:55 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1503698856.952209-1681960764', 15:08:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:08:55 INFO - '_': '/tools/buildbot/bin/python'} 15:08:55 INFO - TEST-INFO | started process 23166 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpRBpzbX/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 15:08:56 INFO - PID 23166 | 15:08:56 INFO - PID 23166 | (/builds/slave/test/build/application/firefox/firefox:23216): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 15:08:56 INFO - PID 23166 | 15:08:56 INFO - PID 23166 | 15:08:56 INFO - PID 23166 | (/builds/slave/test/build/application/firefox/firefox:23276): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 15:08:56 INFO - PID 23166 | 15:08:56 INFO - PID 23166 | __metrics Screen width/height:1600/1200 15:08:56 INFO - PID 23166 | colorDepth:24 15:08:56 INFO - PID 23166 | Browser inner width/height: 1024/768 15:08:56 INFO - PID 23166 | __metrics 15:09:06 INFO - PID 23166 | RSS: Main: 174772224 15:09:06 INFO - PID 23166 | 15:12:05 INFO - PID 23166 | Cycle 1(1): loaded http://localhost:36339/tests/dromaeo/cssquery-dojo.html (next: http://localhost:36339/tests/dromaeo/cssquery-ext.html) 15:12:07 INFO - PID 23166 | RSS: Main: 178479104 15:12:07 INFO - PID 23166 | 15:15:09 INFO - PID 23166 | Cycle 1(1): loaded http://localhost:36339/tests/dromaeo/cssquery-ext.html (next: http://localhost:36339/tests/dromaeo/cssquery-jquery.html) 15:15:09 INFO - PID 23166 | RSS: Main: 174751744 15:15:09 INFO - PID 23166 | 15:18:11 INFO - PID 23166 | Cycle 1(1): loaded http://localhost:36339/tests/dromaeo/cssquery-jquery.html (next: http://localhost:36339/tests/dromaeo/cssquery-mootools.html) 15:18:12 INFO - PID 23166 | RSS: Main: 177188864 15:18:12 INFO - PID 23166 | 15:21:13 INFO - PID 23166 | Cycle 1(1): loaded http://localhost:36339/tests/dromaeo/cssquery-mootools.html (next: http://localhost:36339/tests/dromaeo/cssquery-prototype.html) 15:21:14 INFO - PID 23166 | RSS: Main: 175087616 15:21:14 INFO - PID 23166 | 15:24:18 INFO - PID 23166 | Cycle 1(1): loaded http://localhost:36339/tests/dromaeo/cssquery-prototype.html (next: http://localhost:36339/tests/dromaeo/cssquery-yui.html) 15:24:18 INFO - PID 23166 | RSS: Main: 176795648 15:24:18 INFO - PID 23166 | 15:27:20 INFO - PID 23166 | Cycle 1(1): loaded http://localhost:36339/tests/dromaeo/cssquery-yui.html (next: http://localhost:36339/tests/dromaeo/cssquery-dojo.html) 15:27:20 INFO - PID 23166 | RSS: Main: 179372032 15:27:20 INFO - PID 23166 | 15:27:20 INFO - PID 23166 | __start_tp_report 15:27:20 INFO - PID 23166 | _x_x_mozilla_page_load 15:27:20 INFO - PID 23166 | _x_x_mozilla_page_load_details 15:27:20 INFO - PID 23166 | |i|pagename|runs| 15:27:20 INFO - PID 23166 | |0;dojo.html;3354.865805367784;3371.376295385354;3378.341223461425;3379.138319728469;3394.9490757638623;6261.937380626192;6343.904841427382;6379.553431259814;6409.166808314918;6446.677666116699;6209.130721698965;6307.495400367971;6313.494920406368;6325.051242313655;6350.42846143847;5793;5803.477687008179;5825.097109947944;5837.824865254049;5948.553858460611;5903.055511118222;5913.704314784265;5936.961031819436;5981.461668449839;5997.520198384141;5725.036554997176;5757.453041961007;5858.7656493740415;5931.851703707421;5982.820515384546;5724.914126288109;5743.971280143614;5785.710714464302;5828.125781132864;5854.941450585482;5787.855303617401;5807;5854.912176317359;5859.150423188614;5868.178455016301;6289.119523266746;6294.3705629437145;6355.650439225841;6361.332060133665;6429.774957876499;6739.427148692367;6798.286179951084;6818.4886133540185;6879.415249703781;6911.550749201336;6784.185897692309;6819.079424277708;6834.077399551046;6919.135108111486;6926.168859736814;6284.717187726517;6318.968405157945;6367.808965731036;6375.936240637627;6401.775937842153;6742;6874.621895795679;6906.827329316707;7054.400375967997;7061.752838650623;6689.364510371507;6742.089817874524;6751.729930802811;6766.458683305324;6785.898211526831;6762.222344430355;6812.182538095361;6880.105586273852;6907.689153988083;6909.585424874524;6540.117084193668;6744.156980377453;6771.424428923498;6859.5541289816;6871.793846184622;6703.095082163943;6708.765193218214;6709.865802684017;6712.765053223211;6721.630310332881;5254.868628284247;5271.841844744664;5273.971575542732;5276.234945932818;5276.973615131977;4750.952490475051;4775.403074615673;4796.304535842283;4807.687500312469;4813.927791083137;5942.732577034044;5950.851228719317;6007.969960150172;6031.24609423822;6038.5772995889865;6687.465002799764;6786.491013174032;6855.5886646801355;6935.375816176568;6940.09778728762;5880.323762767336;5885.941140588625;5886.0288052471715;5892.027815410409;5904.143899134601;5769.336526299529;5853.356130825606;5861.765529378862;5863.120531920246;5870.677112758839;6598.802035938834;6669.799906002828;6675.532712710161;6685.665716714145;6686.765963191265;6754.18949726036;6780.355866192901;6802.183737951477;6870.106886104774;6892.138482689664;6435.485161187;6506.02409638539;6554.967225163844;6556.934430655823;6557.868842623217;6494.188226471691;6578.177727784027;6628.767993120217;6631.635260060743;6667.19993600771;6898.482613804085;6920;6927.3419025192525;6932.896006559805;6937.514373993772;6621.5364924454825;6723.226828914738;6724.697388617622;6725.327467253235;6728.226253980855;6592.967035164794;6609.107770450928;6684.264730879502;6694.330566943461;6712.194536655633;6458.192725909262;6537.444317233088;6542.1168142300185;6544.869102617826;6566.310537393696;6515.28331883502;6618.073469714148;6654.268030516542;6658.700358483977;6665.800025999034;6378.585391949694;6390.137331460193;6430.839229019125;6488.837779055561;6521.054447105048 15:27:20 INFO - PID 23166 | |1;ext.html;790.7034861926777;822.194249635357;851.582724465012;864.4942708515516;874.8425283448985;36972.63027369729;37999.81000094999;38083;38249.235015299746;38300.61699383005;35534.644653553456;35664;35680.2863942721;35893.82053089731;35941.101472463204;6852.725890964355;7000.404965577932;7000.859982800341;7002.684879180423;7004.894926576106;6894.24163342032;6996.440284777205;7006.894896576556;7014.438844892396;7018.19290781559;7516.135644400882;7707.229277072304;7711.730089446871;7713.807154821118;7715.8071048223965;7593.430492713041;7668.194839541824;7673.079230492321;7677.193894641094;7687.154413014564;7441.59071251081;7567.394608431312;7651.732189373401;7651.885221721679;7652.120006199302;35286.64713352859;35762.64237357619;35791;35840.283194336225;35886.820565897004;3405.2338223899674;3436.432988556885;3442.896713098611;3443.6900678939014;3444.2078321986082;29404.411911761857;29549.704502955126;29591.408171836658;29591.556126658117;29616.25959351012;5111.7699703513435;5124.282600435942;5132.127538318495;5143.331366922276;5190.091733946544;181839;183967;188532;190008;191697.04151479292;44943.55056449459;45188.77405613017;45283.320750188774;45341.77329113399;45527.77236113865;46820.5317946823;46885;47058;47090.293645595346;47270.52729472661;15389.307481163374;15420.691586168214;15432.382704691687;15435.536933892;15680.529584112495;12964.157329773534;12965.870341296466;12967.610971670865;12981.480740770263;13076.607701768962;13424.060315777997;13433.798493022612;13444.529441469502;13463.192208467328;13577.796333055012;5488.835334939959;5518.53092487135;5540.639858409271;5581.209395302349;5662.546996240373;951.2295041016798;977.1596427072711;985.610683779903;998.9500524973722;1010.7119470950744;20403.591928161353;20712;20856.165753369998;28462.288442788682;29035.274118147216;1076.531708706715;1080.7406222506543;1084.69628504019;1097.237419993097;1103.3600511703194;11541.711457213636;15191.392344306105;15416.306266217824;15598.532044038697;15652.921735391477;230684;232513;232638;232791;232863;51009.489905100476;51358.48641513612;51586.22620660693;51604;51790.48209517932;1427.9428822847178;1441.7909403136487;1446.2190417174818;1453.876420504269;1457.453454954392;26520.14358994852;27028.59457108184;27119.322016948943;27161.72838271592;27305.31736706519;35885.28229435449;36252;36270.63729362673;36285.63714362823;36292.45561316635;202114;204611;204995;205065;205742;33030.669693302756;35076.12309692278;36166.63833361633;36172.09569760777;36214.27571448609;42212;43408.34887476754;43586.128277433636;43606;43979.34030989474;32534;32959.83520082384;33086.338273234884;33132.33735325328;33167.33665326632;32008.67991320057;32083.197920052186;32088.35823283568;32908;33267.66732332743;35810;35866.28267434689;36079;36153.63846361608;36453.27093458169;30915.536266955565;31419.84290078535;31510.68489315169;31582.526262106545;31635.52546711847;23292.301230963098;23555.88222058879;24046.956008739453;24844.751552484966;24936.750632493444 15:27:20 INFO - PID 23166 | |2;jquery.html;553.9639923404978;555.9332880054393;567.5658121537023;573.1202604002854;580.7589850212161;21813.67279490809;22457.775422245773;22659.206927757532;22778.31665050047;22781.77218227817;24991;25567.61648575273;25609.487810243783;25689.87155064222;25747.87126064367;6569.343065693416;6703.597784132968;6706.329367063304;6706.865862682744;6724.697388617499;5938.198343223674;6470.547061705659;6492.123563318963;6591.11020012297;6659.567128136656;6457.225132984048;6464.709088091047;6471.029345598175;6472.255690595571;6475.870482590345;6452.548321617489;6461.870762584769;6476.384743449388;6478.643674597895;6483.675816209195;5969.492593129589;6005.759769609211;6009.369016253318;6012.849678758066;6016.157737916695;28090.157295281173;28490.85754571214;29108.126756197136;29634.110976670734;29752.107436776932;2001.3795723325816;2034.216826521785;2035.236786205173;2037.1953078534045;2037.3378651938178;18625.81374186268;18900.432987010412;19146.138423770964;19210.711839322423;19220.423387298404;2366.171839856054;2376.952460950771;2421.6367544868413;2424.91512797053;2444.10790061628;127759;130148.3492582531;130707.99999999905;131097;131461;13768.449262029406;14320.57038288853;14354.138751674933;14848;14949.981752463278;22858.314250572508;22862.31413057611;22879.428014299774;22887.542249155256;22911.770882291297;9896.356736812084;10142.340747851365;10178.694639160836;10412.531436085394;10449.111825494918;9452.763680907894;9516.38143520669;9537.570809313598;9565.378250413702;9629.32594718377;7499.912512685739;10890.455477226265;10892.183086268562;11268.323900565993;11513.136514761427;3851.78815165163;4105.281575724236;4260.893477663021;4264.33902745075;4420.977895110504;919.7010971434311;931.1573026411108;934.8036912248504;946.7680418297424;948.0898337595847;18569.350072747387;18695.439136825917;18704.158312875952;18861;19183.616327673368;959.9568019439142;1002.6290272599185;1014.8731408573929;1019.6533178719122;1021.5096753558333;10269.845952310721;10334.689959301233;10417.843732344021;10491.265611407129;10617.469126543641;503675;512907;518723;519294;519803;116731.41634291774;116997;118676;118976.40511797559;121152;1160.9709757256137;1216.4989538706996;1217.5495066825154;1231.6428235811513;1232.580922486359;20622.89688551608;21063.684044739035;21232.893835530722;21258.468538286666;21415.036323365173;58401.12398314114;58978.70510647419;60063;60763;61317.080243795484;73891.26108738844;74608.25391746013;74772;74802.62598687189;74947.25052749403;14417.78373324422;14566.41734330615;14738;14752.336144873292;14790.11259324444;21962.560748785254;22085.447863803533;22471.775282246967;22630.77369226287;22785.544289113794;16200.351985920432;17074.2316595751;17426.91286543559;17438.47684569465;17519;14898.25508724581;15377.154256516;15424;15573.299201535732;16047.67904641924;17666.29334826644;17678.82321176823;17809.554761131076;17869;17959.820401795816;14317.140971541325;14483.493077742229;14488.710225795636;14547.41810327575;14587.124772513684;16743.33026678968;16888.831111688727;16889.831101689317;17442.127893605524;17895.642087157925 15:27:20 INFO - PID 23166 | |3;mootools.html;1304.3869381390746;1345.4281930179666;1351.3648585164974;1363.7068030373468;1369.4864425840308;14192.858071419283;14827.851721482783;14843.480478183252;14912.701745965102;14919.254037298118;14274.4290228391;14767.483138090141;15268.08391496511;15286.694266114671;15297.770533442008;2646.841189528625;2700.1494529223232;2704.323919020245;2705.702372738997;2705.8105932584726;2372.264597974625;2577.8324408913454;2627.5533159362953;2719.673639163303;2722.618833363331;2663.1877277430376;2675.919722408331;2691.0984820085196;2691.7039125696156;2693.367058741204;2529.026324864931;2534.087728417768;2535.3027917322697;2642.3262068172685;2672.1983404978428;2641.418887844671;2656.628072069912;2663.653725015755;2675.571908494651;2691.744284292989;14152.858471415257;14386.496472623512;14414.783778243334;14417.927910360486;14435.783463248059;7659.234076592296;7822.6088695564995;7897.763067107996;7913.841723165562;7921.089074756419;5190.636655434121;5382.91925621116;5496.587755918282;5505.6696598204235;5521.834344969658;1809.701399269119;1854.0636978325858;1854.0822292964933;1886.6792645250202;1898.515878451;24627.38431539208;25062.749372506405;25168.622470662955;25185;25295.873520632464;6743.865122697519;7173.6771845267085;7211.639418029077;7215.711371545184;7252.202257751643;16608.501744947673;16669.33322667104;16694.833051669328;16796.412125575545;16895.91552042232;7262.455315851226;7633.885491717629;7669.233076692286;8165.71420000309;8193.139720329398;7172.748953786592;7248.855022899513;7254.383377412873;7268.200497945222;7294.781156565312;5090.185570308733;5180.300659411007;5186.870328241824;5211.765470553834;5217.68693878361;1511.231858725294;1512.659651578386;1533.4939469974881;1540.7534794432836;1542.0978727444347;887.1261807119981;894.5661354243186;900.7342833864026;902.0122965352928;910.6676063236871;7583.431242656823;7633.084029916446;7648.426368022309;7674.53952762836;7809.882851757115;713.0979311171373;722.2668990974165;723.4321057969469;724.6557885004686;726.8291951391419;4667.416572928384;5697.202391665171;5701.743421546041;5840.707964601753;6200.596961197508;19982.70025949583;20867.8956605216;20873.47816304574;20914.16343346249;21010.15959361639;20153.09311081005;20465.795342046687;20498;20659.69010464844;20719.378418647466;10296.948515257376;10520.842187367196;10527.736806579896;10544.578216871392;10563.679540057492;8724.781880452785;8790.780230494289;8832.823343532964;8933.15135062168;8957;17236.224369903135;17508.649827003133;17556.91221543935;18265.178066987282;18447;17743.73384399261;18008.369707060716;18111.909440452713;18253;18413.81586184121;11419.37193454368;11784.292942423483;11813.76372472563;11846;11857.822132668189;13411.664708381979;13546.05177637556;13573.660658483617;13575.456981720621;13575.86424135746;11171.66485005451;11403.771924561628;11422.200445968703;11438.94280528592;11588.420578971187;10753;10819.891801081889;10881.510332035235;11024.173187010845;11086.445677716243;9195.954020229856;9241;9306.208972237166;9306.255499560155;9307.813843722952;6631.270560238467;6674.666266686743;6680.2651708313015;6693.832654183684;6696.430803381767;7288.927110729037;7331.8533629328185;7427.8143046424275;7489.363404110493;7542.622868856425 15:27:20 INFO - PID 23166 | |4;prototype.html;497.41056847635565;500.91734863747484;520.4067363205945;521.5670993075745;530.5569849175938;6326.513269381691;6381.553291269607;6390.233172019352;6397.776077837277;6400.615963042221;6218.751249949996;6229.750809967607;6267.780627678032;6285.528585356105;6318.399752023562;5096.419420734309;5141.383034035921;5161.329027226474;5168.974155129219;5185;5093.516115968977;5235.424103348629;5257.316548848645;5258.421573626898;5266.552343050846;5239.449857764937;5254.111957151699;5275.498827611371;5280.570937368796;5293.914747476758;5093.2105523643895;5265.684058956455;5286.682799032051;5290.153575427951;5302.946970530284;4866.416030076378;4866.489018653026;4889.633277504166;4894.800773810439;4895.9755201224125;6341.936580634227;6345.270293916213;6357.427831495142;6359.682015899187;6368.554201205918;6041.486473649701;6078.419610901154;6092.421219984094;6102.359252278536;6121.204243448367;6862.313768623148;6862.794116176523;6869.175698916162;6882.242953275136;6887.380135787803;5321.574274058066;5343.198520221998;5352.357717073937;5355.758990845421;5393.1101368274185;6858.348456896587;6968;7041.753538626123;7082;7134.500584959055;5487.890242195213;5498.780048798083;5499.560035197254;5499.917501237484;5536.474034966672;5559.527440167551;5600.467955544217;5602.439756024365;5608.915866262009;5616.157576363496;5946.791862284799;5976.671283079386;6020.795840831851;6049.667268300285;6083.6045657032155;6701.626166635828;6790.253072162058;6801.693923773442;6843.794686159423;6866.519343645997;1941.4660968233566;1965.849977762996;1966.301962803213;1976.9308074217333;1981.782003979561;1376.8640871281234;1437.475321507642;1452.6295794572316;1463.758479850834;1466.1056755379211;5873.383294754075;5885.852853678693;5910.143029260819;6007.8197654070445;6022.518198544106;6755.763548275787;6789.388954994074;6801.667183080255;6858.965705171442;6914.55055421396;5899.970500147472;5915.852103697442;5935.940640593625;5947.988841896888;5956.315023772235;3626.655467730561;3654.1230104775195;3664.358737220976;3676.7977761222855;3688.22547265072;6599.373059559334;6634.535582509275;6667.333166708323;6696.799096027127;6727.3763232339425;6941.305869413019;6997.440204783605;6999.30006999296;7031.964840175767;7143.571385716874;6595.142631457879;6699.832504187434;6715.093462382516;6717.932820671731;6734.1918969722965;6915.827104322231;6918.308169183041;6949.7567585134275;6997.965010174917;7004.754833580801;6903.1371078615175;6903.5167538271835;6914.377706006484;6940.687669055005;6945.861082778417;6728.562643428161;6782.321767823376;6813.2846051163915;6819.113515242987;6835.316468353125;5446.537044351275;5462.672239665632;5478.726063696879;5482.972585137049;5531;6649.401553860176;6874.518783685094;6874.896876546756;6952.2352541221435;6992.195897471653;6561.475081993333;6670.199576050905;6722.596644201168;6741.258461569321;6742.157230346207;6665.2334981475815;6689.464842812466;6728.663566821737;6728.899066514105;6734.595924244561;6523.217213934358;6636.668166591748;6654;6657.4674026078765;6706.262311145868;6805.9659701701175;6819.317568512947;6835.855506467081;6862.828429289308;6881.587104773729;6568.934310656832;6595.208574971034;6601.900971485527;6614.90077648826;6627.635480048643 15:27:20 INFO - PID 23166 | |5;yui.html;869.6347534035705;870.8214815962727;894.2845723421261;896.6771962093645;898.7213963671262;18622.25510979561;19381.515462113453;19395.709064364044;19413.223471061177;19436.611267774635;16708.164591770423;17470.12649367533;20942.37172884812;20962.26632067878;21063.894680526577;892.7678803511085;906.8911730592338;907.0747837206046;911.9544022798867;911.9785839859334;875.0942774228674;955.7132860141965;962.2302158273388;974.741693451236;975.8585005174245;1002.4737013068161;1005.4419797012655;1006.3257617396325;1008.7326858382535;1008.7528555503911;1002.0280328081749;1002.7944271424341;1006.079437314856;1006.1900170362856;1011.3931641015405;734.2730696610371;734.6326836581709;734.6987735028613;736.4255880413286;739.7263012685341;19270.325538606223;19394.321198758116;19462.416127516197;19741.309054183177;19756.308529201408;20574.177032918666;20587;20964.790352096436;21068.157273709032;21086.156553737987;16231.188440578042;16273.59316017109;16343.918280408641;16409.753853692084;16446.424375146813;3646.1431563582537;3673.0633688409284;3674.412094064937;3675.1363429594026;3676.2647470506004;114599;115585.84414155835;115925.42037289844;116574;117152;14902.403903843724;15359.539213823604;15475.535733928;15479.148646824533;15483.22583870802;28024.71975280262;29176.416471670447;29416.85291573571;29522.11433656994;29544.261393465335;8179.509229446252;8238.176182381714;8241.711540096188;8350.958245208734;8373.371997100241;3945.309570825094;4025.75845449274;4052.5947405259826;4060.411240370189;4061.3095773718537;4661.883452913704;4756.072565849695;4756.9286460703115;4763.118823017753;5362.758675859518;1035.492608621785;1054.093479607537;1065.8934106589434;1067.9359238445718;1071.1163290285544;639.8688268904864;652.2271108736163;656.7799787071289;660.0890770736353;674.1270055278426;10787;10828.296160749684;11176.161787865942;11635.418229088511;11673.299602023906;651.9967400163064;655.7344275568403;656.0651072222064;662.9204495460575;665.6904539389208;5453.454654534515;5486.31421072366;5516.724163791875;5691.004074286983;5693.68684722336;109046.45476772565;110264.4486777561;113006;114356.42821785838;114839.42580287045;91532;94159.52920235493;94247;97747.51126244324;98873;81981.59009204915;82523;85735.57132214424;87109;87684.56157719171;11512.079033677453;11673.007794337576;12294.077944154404;12496.375181240719;12504.374781261082;39556.60443395529;39889.20221595494;40150.59849401469;40660.59339406568;42893.785531073394;69061.65469172622;69559.65220173867;69870.30129698638;71941.6402917982;72813.63593182;19005.904970475058;19028.429147125607;19192.808071919102;19472.707909381654;19504.60990780205;20794.48013799667;21794.346169614302;21959;22145.889270553544;22401.207903367365;17567.472975810746;18087.728684070014;18308.359207427675;18446.538836529195;18644.440666780018;16425.425110121087;16598.66802663964;17596.120193990504;18862;19774.209031638573;16746.330146793993;16848;16999.235034423233;17035.31858725637;17287.827121729126;12167.695807604881;12429.689257768629;13022.739545209231;13345.599632011055;13616.727665446437;13300.46798128064;13632.863671363159;13867.375968081258;13896.305184740924;13943.790843137158 15:27:20 INFO - PID 23166 | __end_tp_report 15:27:20 INFO - PID 23166 | __start_cc_report 15:27:20 INFO - PID 23166 | _x_x_mozilla_cycle_collect,375 15:27:20 INFO - PID 23166 | __end_cc_report 15:27:20 INFO - PID 23166 | __startTimestamp1503700040701__endTimestamp 15:27:20 INFO - PID 23166 | 15:27:20 INFO - PID 23166 | ------- Summary: start ------- 15:27:20 INFO - PID 23166 | Number of tests: 6 15:27:20 INFO - PID 23166 | 15:27:20 INFO - PID 23166 | [#0] dojo.html Cycles:165 Average:6266.71 Median:6506.02 stddev:720.27 (11.1%) stddev-sans-first:685.30 15:27:20 INFO - PID 23166 | Values: 3354.9 3371.4 3378.3 3379.1 3394.9 6261.9 6343.9 6379.6 6409.2 6446.7 6209.1 6307.5 6313.5 6325.1 6350.4 5793.0 5803.5 5825.1 5837.8 5948.6 5903.1 5913.7 5937.0 5981.5 5997.5 5725.0 5757.5 5858.8 5931.9 5982.8 5724.9 5744.0 5785.7 5828.1 5854.9 5787.9 5807.0 5854.9 5859.2 5868.2 6289.1 6294.4 6355.7 6361.3 6429.8 6739.4 6798.3 6818.5 6879.4 6911.6 6784.2 6819.1 6834.1 6919.1 6926.2 6284.7 6319.0 6367.8 6375.9 6401.8 6742.0 6874.6 6906.8 7054.4 7061.8 6689.4 6742.1 6751.7 6766.5 6785.9 6762.2 6812.2 6880.1 6907.7 6909.6 6540.1 6744.2 6771.4 6859.6 6871.8 6703.1 6708.8 6709.9 6712.8 6721.6 5254.9 5271.8 5274.0 5276.2 5277.0 4751.0 4775.4 4796.3 4807.7 4813.9 5942.7 5950.9 6008.0 6031.2 6038.6 6687.5 6786.5 6855.6 6935.4 6940.1 5880.3 5885.9 5886.0 5892.0 5904.1 5769.3 5853.4 5861.8 5863.1 5870.7 6598.8 6669.8 6675.5 6685.7 6686.8 6754.2 6780.4 6802.2 6870.1 6892.1 6435.5 6506.0 6555.0 6556.9 6557.9 6494.2 6578.2 6628.8 6631.6 6667.2 6898.5 6920.0 6927.3 6932.9 6937.5 6621.5 6723.2 6724.7 6725.3 6728.2 6593.0 6609.1 6684.3 6694.3 6712.2 6458.2 6537.4 6542.1 6544.9 6566.3 6515.3 6618.1 6654.3 6658.7 6665.8 6378.6 6390.1 6430.8 6488.8 6521.1 15:27:20 INFO - PID 23166 | 15:27:20 INFO - PID 23166 | [#1] ext.html Cycles:180 Average:37265.44 Median:35672.14 stddev:54041.32 (151.5%) stddev-sans-first:54123.52 15:27:20 INFO - PID 23166 | Values: 790.7 822.2 851.6 864.5 874.8 36972.6 37999.8 38083.0 38249.2 38300.6 35534.6 35664.0 35680.3 35893.8 35941.1 6852.7 7000.4 7000.9 7002.7 7004.9 6894.2 6996.4 7006.9 7014.4 7018.2 7516.1 7707.2 7711.7 7713.8 7715.8 7593.4 7668.2 7673.1 7677.2 7687.2 7441.6 7567.4 7651.7 7651.9 7652.1 35286.6 35762.6 35791.0 35840.3 35886.8 3405.2 3436.4 3442.9 3443.7 3444.2 29404.4 29549.7 29591.4 29591.6 29616.3 5111.8 5124.3 5132.1 5143.3 5190.1 181839.0 183967.0 188532.0 190008.0 191697.0 44943.6 45188.8 45283.3 45341.8 45527.8 46820.5 46885.0 47058.0 47090.3 47270.5 15389.3 15420.7 15432.4 15435.5 15680.5 12964.2 12965.9 12967.6 12981.5 13076.6 13424.1 13433.8 13444.5 13463.2 13577.8 5488.8 5518.5 5540.6 5581.2 5662.5 951.2 977.2 985.6 999.0 1010.7 20403.6 20712.0 20856.2 28462.3 29035.3 1076.5 1080.7 1084.7 1097.2 1103.4 11541.7 15191.4 15416.3 15598.5 15652.9 230684.0 232513.0 232638.0 232791.0 232863.0 51009.5 51358.5 51586.2 51604.0 51790.5 1427.9 1441.8 1446.2 1453.9 1457.5 26520.1 27028.6 27119.3 27161.7 27305.3 35885.3 36252.0 36270.6 36285.6 36292.5 202114.0 204611.0 204995.0 205065.0 205742.0 33030.7 35076.1 36166.6 36172.1 36214.3 42212.0 43408.3 43586.1 43606.0 43979.3 32534.0 32959.8 33086.3 33132.3 33167.3 32008.7 32083.2 32088.4 32908.0 33267.7 35810.0 35866.3 36079.0 36153.6 36453.3 30915.5 31419.8 31510.7 31582.5 31635.5 23292.3 23555.9 24047.0 24844.8 24936.8 15:27:20 INFO - PID 23166 | 15:27:20 INFO - PID 23166 | [#2] jquery.html Cycles:180 Average:35430.78 Median:22464.78 stddev:86316.32 (384.2%) stddev-sans-first:86518.74 15:27:20 INFO - PID 23166 | Values: 554.0 555.9 567.6 573.1 580.8 21813.7 22457.8 22659.2 22778.3 22781.8 24991.0 25567.6 25609.5 25689.9 25747.9 6569.3 6703.6 6706.3 6706.9 6724.7 5938.2 6470.5 6492.1 6591.1 6659.6 6457.2 6464.7 6471.0 6472.3 6475.9 6452.5 6461.9 6476.4 6478.6 6483.7 5969.5 6005.8 6009.4 6012.8 6016.2 28090.2 28490.9 29108.1 29634.1 29752.1 2001.4 2034.2 2035.2 2037.2 2037.3 18625.8 18900.4 19146.1 19210.7 19220.4 2366.2 2377.0 2421.6 2424.9 2444.1 127759.0 130148.3 130708.0 131097.0 131461.0 13768.4 14320.6 14354.1 14848.0 14950.0 22858.3 22862.3 22879.4 22887.5 22911.8 9896.4 10142.3 10178.7 10412.5 10449.1 9452.8 9516.4 9537.6 9565.4 9629.3 7499.9 10890.5 10892.2 11268.3 11513.1 3851.8 4105.3 4260.9 4264.3 4421.0 919.7 931.2 934.8 946.8 948.1 18569.4 18695.4 18704.2 18861.0 19183.6 960.0 1002.6 1014.9 1019.7 1021.5 10269.8 10334.7 10417.8 10491.3 10617.5 503675.0 512907.0 518723.0 519294.0 519803.0 116731.4 116997.0 118676.0 118976.4 121152.0 1161.0 1216.5 1217.5 1231.6 1232.6 20622.9 21063.7 21232.9 21258.5 21415.0 58401.1 58978.7 60063.0 60763.0 61317.1 73891.3 74608.3 74772.0 74802.6 74947.3 14417.8 14566.4 14738.0 14752.3 14790.1 21962.6 22085.4 22471.8 22630.8 22785.5 16200.4 17074.2 17426.9 17438.5 17519.0 14898.3 15377.2 15424.0 15573.3 16047.7 17666.3 17678.8 17809.6 17869.0 17959.8 14317.1 14483.5 14488.7 14547.4 14587.1 16743.3 16888.8 16889.8 17442.1 17895.6 15:27:20 INFO - PID 23166 | 15:27:20 INFO - PID 23166 | [#3] mootools.html Cycles:180 Average:9077.40 Median:2634.49 stddev:6355.42 (241.2%) stddev-sans-first:6346.41 15:27:20 INFO - PID 23166 | Values: 1304.4 1345.4 1351.4 1363.7 1369.5 14192.9 14827.9 14843.5 14912.7 14919.3 14274.4 14767.5 15268.1 15286.7 15297.8 2646.8 2700.1 2704.3 2705.7 2705.8 2372.3 2577.8 2627.6 2719.7 2722.6 2663.2 2675.9 2691.1 2691.7 2693.4 2529.0 2534.1 2535.3 2642.3 2672.2 2641.4 2656.6 2663.7 2675.6 2691.7 14152.9 14386.5 14414.8 14417.9 14435.8 7659.2 7822.6 7897.8 7913.8 7921.1 5190.6 5382.9 5496.6 5505.7 5521.8 1809.7 1854.1 1854.1 1886.7 1898.5 24627.4 25062.7 25168.6 25185.0 25295.9 6743.9 7173.7 7211.6 7215.7 7252.2 16608.5 16669.3 16694.8 16796.4 16895.9 7262.5 7633.9 7669.2 8165.7 8193.1 7172.7 7248.9 7254.4 7268.2 7294.8 5090.2 5180.3 5186.9 5211.8 5217.7 1511.2 1512.7 1533.5 1540.8 1542.1 887.1 894.6 900.7 902.0 910.7 7583.4 7633.1 7648.4 7674.5 7809.9 713.1 722.3 723.4 724.7 726.8 4667.4 5697.2 5701.7 5840.7 6200.6 19982.7 20867.9 20873.5 20914.2 21010.2 20153.1 20465.8 20498.0 20659.7 20719.4 10296.9 10520.8 10527.7 10544.6 10563.7 8724.8 8790.8 8832.8 8933.2 8957.0 17236.2 17508.6 17556.9 18265.2 18447.0 17743.7 18008.4 18111.9 18253.0 18413.8 11419.4 11784.3 11813.8 11846.0 11857.8 13411.7 13546.1 13573.7 13575.5 13575.9 11171.7 11403.8 11422.2 11438.9 11588.4 10753.0 10819.9 10881.5 11024.2 11086.4 9196.0 9241.0 9306.2 9306.3 9307.8 6631.3 6674.7 6680.3 6693.8 6696.4 7288.9 7331.9 7427.8 7489.4 7542.6 15:27:20 INFO - PID 23166 | 15:27:20 INFO - PID 23166 | [#4] prototype.html Cycles:180 Average:5754.85 Median:6334.22 stddev:1553.13 (24.5%) stddev-sans-first:1506.52 15:27:20 INFO - PID 23166 | Values: 497.4 500.9 520.4 521.6 530.6 6326.5 6381.6 6390.2 6397.8 6400.6 6218.8 6229.8 6267.8 6285.5 6318.4 5096.4 5141.4 5161.3 5169.0 5185.0 5093.5 5235.4 5257.3 5258.4 5266.6 5239.4 5254.1 5275.5 5280.6 5293.9 5093.2 5265.7 5286.7 5290.2 5302.9 4866.4 4866.5 4889.6 4894.8 4896.0 6341.9 6345.3 6357.4 6359.7 6368.6 6041.5 6078.4 6092.4 6102.4 6121.2 6862.3 6862.8 6869.2 6882.2 6887.4 5321.6 5343.2 5352.4 5355.8 5393.1 6858.3 6968.0 7041.8 7082.0 7134.5 5487.9 5498.8 5499.6 5499.9 5536.5 5559.5 5600.5 5602.4 5608.9 5616.2 5946.8 5976.7 6020.8 6049.7 6083.6 6701.6 6790.3 6801.7 6843.8 6866.5 1941.5 1965.8 1966.3 1976.9 1981.8 1376.9 1437.5 1452.6 1463.8 1466.1 5873.4 5885.9 5910.1 6007.8 6022.5 6755.8 6789.4 6801.7 6859.0 6914.6 5900.0 5915.9 5935.9 5948.0 5956.3 3626.7 3654.1 3664.4 3676.8 3688.2 6599.4 6634.5 6667.3 6696.8 6727.4 6941.3 6997.4 6999.3 7032.0 7143.6 6595.1 6699.8 6715.1 6717.9 6734.2 6915.8 6918.3 6949.8 6998.0 7004.8 6903.1 6903.5 6914.4 6940.7 6945.9 6728.6 6782.3 6813.3 6819.1 6835.3 5446.5 5462.7 5478.7 5483.0 5531.0 6649.4 6874.5 6874.9 6952.2 6992.2 6561.5 6670.2 6722.6 6741.3 6742.2 6665.2 6689.5 6728.7 6728.9 6734.6 6523.2 6636.7 6654.0 6657.5 6706.3 6806.0 6819.3 6835.9 6862.8 6881.6 6568.9 6595.2 6601.9 6614.9 6627.6 15:27:20 INFO - PID 23166 | 15:27:20 INFO - PID 23166 | [#5] yui.html Cycles:180 Average:23279.95 Median:20952.32 stddev:31276.26 (149.3%) stddev-sans-first:31318.73 15:27:20 INFO - PID 23166 | Values: 869.6 870.8 894.3 896.7 898.7 18622.3 19381.5 19395.7 19413.2 19436.6 16708.2 17470.1 20942.4 20962.3 21063.9 892.8 906.9 907.1 912.0 912.0 875.1 955.7 962.2 974.7 975.9 1002.5 1005.4 1006.3 1008.7 1008.8 1002.0 1002.8 1006.1 1006.2 1011.4 734.3 734.6 734.7 736.4 739.7 19270.3 19394.3 19462.4 19741.3 19756.3 20574.2 20587.0 20964.8 21068.2 21086.2 16231.2 16273.6 16343.9 16409.8 16446.4 3646.1 3673.1 3674.4 3675.1 3676.3 114599.0 115585.8 115925.4 116574.0 117152.0 14902.4 15359.5 15475.5 15479.1 15483.2 28024.7 29176.4 29416.9 29522.1 29544.3 8179.5 8238.2 8241.7 8351.0 8373.4 3945.3 4025.8 4052.6 4060.4 4061.3 4661.9 4756.1 4756.9 4763.1 5362.8 1035.5 1054.1 1065.9 1067.9 1071.1 639.9 652.2 656.8 660.1 674.1 10787.0 10828.3 11176.2 11635.4 11673.3 652.0 655.7 656.1 662.9 665.7 5453.5 5486.3 5516.7 5691.0 5693.7 109046.5 110264.4 113006.0 114356.4 114839.4 91532.0 94159.5 94247.0 97747.5 98873.0 81981.6 82523.0 85735.6 87109.0 87684.6 11512.1 11673.0 12294.1 12496.4 12504.4 39556.6 39889.2 40150.6 40660.6 42893.8 69061.7 69559.7 69870.3 71941.6 72813.6 19005.9 19028.4 19192.8 19472.7 19504.6 20794.5 21794.3 21959.0 22145.9 22401.2 17567.5 18087.7 18308.4 18446.5 18644.4 16425.4 16598.7 17596.1 18862.0 19774.2 16746.3 16848.0 16999.2 17035.3 17287.8 12167.7 12429.7 13022.7 13345.6 13616.7 13300.5 13632.9 13867.4 13896.3 13943.8 15:27:20 INFO - PID 23166 | -------- Summary: end -------- 15:27:20 INFO - PID 23166 | 15:27:21 INFO - TEST-INFO | 23166: exit 0 15:27:21 INFO - TEST-OK | dromaeo_css | took 1111621ms 15:27:21 INFO - TEST-START | kraken 15:27:21 INFO - Initialising browser for kraken test... 15:27:21 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:36339/getInfo.html -profile /tmp/tmpK1C8i0/profile 15:27:21 INFO - TEST-INFO | started process 23590 (/builds/slave/test/build/application/firefox/firefox http://localhost:36339/getInfo.html) 15:27:26 INFO - TEST-INFO | 23590: exit 0 15:27:26 INFO - Browser initialized. 15:27:26 INFO - Running cycle 1/1 for kraken test... 15:27:26 INFO - Using env: {'DISPLAY': ':0', 15:27:26 INFO - 'HOME': '/home/cltbld', 15:27:26 INFO - 'JSGC_DISABLE_POISONING': '1', 15:27:26 INFO - 'LANG': 'en_US.UTF-8', 15:27:26 INFO - 'LANGUAGE': 'en_US:en', 15:27:26 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 15:27:26 INFO - 'LOGNAME': 'cltbld', 15:27:26 INFO - 'MAIL': '/var/mail/cltbld', 15:27:26 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 15:27:26 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 15:27:26 INFO - 'MOZ_CRASHREPORTER': '1', 15:27:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:27:26 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 15:27:26 INFO - 'MOZ_NO_REMOTE': '1', 15:27:26 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 15:27:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:27:26 INFO - 'NO_EM_RESTART': '1', 15:27:26 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:27:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:27:26 INFO - 'PWD': '/builds/slave/test', 15:27:26 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 15:27:26 INFO - 'RUST_BACKTRACE': 'full', 15:27:26 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 15:27:26 INFO - 'SHELL': '/bin/bash', 15:27:26 INFO - 'SHLVL': '1', 15:27:26 INFO - 'STYLO_FORCE_ENABLED': '1', 15:27:26 INFO - 'TERM': 'linux', 15:27:26 INFO - 'TMOUT': '86400', 15:27:26 INFO - 'USER': 'cltbld', 15:27:26 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1503698856.952209-1681960764', 15:27:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:27:26 INFO - '_': '/tools/buildbot/bin/python'} 15:27:26 INFO - TEST-INFO | started process 23773 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpK1C8i0/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 15:27:27 INFO - PID 23773 | 15:27:27 INFO - PID 23773 | (/builds/slave/test/build/application/firefox/firefox:23822): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 15:27:27 INFO - PID 23773 | 15:27:28 INFO - PID 23773 | 15:27:28 INFO - PID 23773 | (/builds/slave/test/build/application/firefox/firefox:23883): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 15:27:28 INFO - PID 23773 | 15:27:28 INFO - PID 23773 | __metrics Screen width/height:1600/1200 15:27:28 INFO - PID 23773 | colorDepth:24 15:27:28 INFO - PID 23773 | Browser inner width/height: 1024/768 15:27:28 INFO - PID 23773 | __metrics 15:27:38 INFO - PID 23773 | RSS: Main: 174473216 15:27:38 INFO - PID 23773 | 15:27:40 INFO - PID 23773 | Cycle 1(1): loaded http://localhost:36339/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:36339/tests/kraken/driver.html?testName=audio-beat-detection) 15:27:41 INFO - PID 23773 | RSS: Main: 179822592 15:27:41 INFO - PID 23773 | 15:27:44 INFO - PID 23773 | Cycle 1(1): loaded http://localhost:36339/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:36339/tests/kraken/driver.html?testName=audio-dft) 15:27:45 INFO - PID 23773 | RSS: Main: 182222848 15:27:45 INFO - PID 23773 | 15:27:48 INFO - PID 23773 | Cycle 1(1): loaded http://localhost:36339/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:36339/tests/kraken/driver.html?testName=audio-fft) 15:27:48 INFO - PID 23773 | RSS: Main: 175337472 15:27:48 INFO - PID 23773 | 15:27:51 INFO - PID 23773 | Cycle 1(1): loaded http://localhost:36339/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:36339/tests/kraken/driver.html?testName=audio-oscillator) 15:27:51 INFO - PID 23773 | RSS: Main: 175751168 15:27:51 INFO - PID 23773 | 15:27:53 INFO - PID 23773 | Cycle 1(1): loaded http://localhost:36339/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:36339/tests/kraken/driver.html?testName=imaging-gaussian-blur) 15:27:54 INFO - PID 23773 | RSS: Main: 175988736 15:27:54 INFO - PID 23773 | 15:27:57 INFO - PID 23773 | Cycle 1(1): loaded http://localhost:36339/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:36339/tests/kraken/driver.html?testName=imaging-darkroom) 15:27:58 INFO - PID 23773 | RSS: Main: 177373184 15:27:58 INFO - PID 23773 | 15:28:01 INFO - PID 23773 | Cycle 1(1): loaded http://localhost:36339/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:36339/tests/kraken/driver.html?testName=imaging-desaturate) 15:28:02 INFO - PID 23773 | RSS: Main: 177246208 15:28:02 INFO - PID 23773 | 15:28:05 INFO - PID 23773 | Cycle 1(1): loaded http://localhost:36339/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:36339/tests/kraken/driver.html?testName=json-parse-financial) 15:28:06 INFO - PID 23773 | RSS: Main: 177647616 15:28:06 INFO - PID 23773 | 15:28:07 INFO - PID 23773 | Cycle 1(1): loaded http://localhost:36339/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:36339/tests/kraken/driver.html?testName=json-stringify-tinderbox) 15:28:08 INFO - PID 23773 | RSS: Main: 177799168 15:28:08 INFO - PID 23773 | 15:28:10 INFO - PID 23773 | Cycle 1(1): loaded http://localhost:36339/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:36339/tests/kraken/driver.html?testName=stanford-crypto-aes) 15:28:10 INFO - PID 23773 | RSS: Main: 178003968 15:28:10 INFO - PID 23773 | 15:28:13 INFO - PID 23773 | Cycle 1(1): loaded http://localhost:36339/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:36339/tests/kraken/driver.html?testName=stanford-crypto-ccm) 15:28:13 INFO - PID 23773 | RSS: Main: 177532928 15:28:13 INFO - PID 23773 | 15:28:16 INFO - PID 23773 | Cycle 1(1): loaded http://localhost:36339/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:36339/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 15:28:17 INFO - PID 23773 | RSS: Main: 177704960 15:28:17 INFO - PID 23773 | 15:28:20 INFO - PID 23773 | Cycle 1(1): loaded http://localhost:36339/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:36339/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 15:28:20 INFO - PID 23773 | RSS: Main: 178094080 15:28:20 INFO - PID 23773 | 15:28:22 INFO - PID 23773 | Cycle 1(1): loaded http://localhost:36339/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:36339/tests/kraken/driver.html?testName=ai-astar) 15:28:22 INFO - PID 23773 | RSS: Main: 179773440 15:28:22 INFO - PID 23773 | 15:28:22 INFO - PID 23773 | __start_tp_report 15:28:22 INFO - PID 23773 | _x_x_mozilla_page_load 15:28:22 INFO - PID 23773 | _x_x_mozilla_page_load_details 15:28:22 INFO - PID 23773 | |i|pagename|runs| 15:28:22 INFO - PID 23773 | |0;ai-astar;98;107;100;106;111;107;107;97;108;111 15:28:22 INFO - PID 23773 | |1;audio-beat-detection;152;115;142;182;122;148;148;121;186;119 15:28:22 INFO - PID 23773 | |2;audio-dft;163;168;161;160;162;162;172;160;168;164 15:28:22 INFO - PID 23773 | |3;audio-fft;75;74;76;166;75;74;74;82;154;75 15:28:22 INFO - PID 23773 | |4;audio-oscillator;78;79;140;82;78;79;125;80;79;142 15:28:22 INFO - PID 23773 | |5;imaging-gaussian-blur;114;114;119;115;115;114;114;118;118;113 15:28:22 INFO - PID 23773 | |6;imaging-darkroom;148;149;150;151;151;149;149;150;150;149 15:28:22 INFO - PID 23773 | |7;imaging-desaturate;93;94;98;95;95;94;96;94;94;100 15:28:22 INFO - PID 23773 | |8;json-parse-financial;52;52;56;56;51;52;51;51;50;52 15:28:22 INFO - PID 23773 | |9;json-stringify-tinderbox;56;64;55;56;60;62;56;57;61;56 15:28:22 INFO - PID 23773 | |10;stanford-crypto-aes;73;76;74;79;72;77;74;73;74;75 15:28:22 INFO - PID 23773 | |11;stanford-crypto-ccm;116;129;130;118;123;127;124;114;128;160 15:28:22 INFO - PID 23773 | |12;stanford-crypto-pbkdf2;177;179;169;172;172;182;190;169;173;176 15:28:22 INFO - PID 23773 | |13;stanford-crypto-sha256-iterative;68;67;67;66;67;66;71;69;67;67 15:28:22 INFO - PID 23773 | __end_tp_report 15:28:22 INFO - PID 23773 | __start_cc_report 15:28:22 INFO - PID 23773 | _x_x_mozilla_cycle_collect,1000 15:28:22 INFO - PID 23773 | __end_cc_report 15:28:22 INFO - PID 23773 | __startTimestamp1503700102964__endTimestamp 15:28:22 INFO - PID 23773 | 15:28:22 INFO - PID 23773 | ------- Summary: start ------- 15:28:22 INFO - PID 23773 | Number of tests: 14 15:28:22 INFO - PID 23773 | 15:28:22 INFO - PID 23773 | [#0] ai-astar Cycles:10 Average:105.20 Median:109.50 stddev:5.07 (4.6%) stddev-sans-first:4.66 15:28:22 INFO - PID 23773 | Values: 98.0 107.0 100.0 106.0 111.0 107.0 107.0 97.0 108.0 111.0 15:28:22 INFO - PID 23773 | 15:28:22 INFO - PID 23773 | [#1] audio-beat-detection Cycles:10 Average:143.50 Median:148.00 stddev:25.35 (17.1%) stddev-sans-first:26.70 15:28:22 INFO - PID 23773 | Values: 152.0 115.0 142.0 182.0 122.0 148.0 148.0 121.0 186.0 119.0 15:28:22 INFO - PID 23773 | 15:28:22 INFO - PID 23773 | [#2] audio-dft Cycles:10 Average:164.00 Median:163.50 stddev:4.03 (2.5%) stddev-sans-first:4.26 15:28:22 INFO - PID 23773 | Values: 163.0 168.0 161.0 160.0 162.0 162.0 172.0 160.0 168.0 164.0 15:28:22 INFO - PID 23773 | 15:28:22 INFO - PID 23773 | [#3] audio-fft Cycles:10 Average:92.50 Median:75.00 stddev:35.77 (47.7%) stddev-sans-first:37.37 15:28:22 INFO - PID 23773 | Values: 75.0 74.0 76.0 166.0 75.0 74.0 74.0 82.0 154.0 75.0 15:28:22 INFO - PID 23773 | 15:28:22 INFO - PID 23773 | [#4] audio-oscillator Cycles:10 Average:96.20 Median:79.00 stddev:27.61 (34.9%) stddev-sans-first:28.49 15:28:22 INFO - PID 23773 | Values: 78.0 79.0 140.0 82.0 78.0 79.0 125.0 80.0 79.0 142.0 15:28:22 INFO - PID 23773 | 15:28:22 INFO - PID 23773 | [#5] imaging-gaussian-blur Cycles:10 Average:115.40 Median:115.00 stddev:2.12 (1.8%) stddev-sans-first:2.19 15:28:22 INFO - PID 23773 | Values: 114.0 114.0 119.0 115.0 115.0 114.0 114.0 118.0 118.0 113.0 15:28:22 INFO - PID 23773 | 15:28:22 INFO - PID 23773 | [#6] imaging-darkroom Cycles:10 Average:149.60 Median:150.00 stddev:0.97 (0.6%) stddev-sans-first:0.83 15:28:22 INFO - PID 23773 | Values: 148.0 149.0 150.0 151.0 151.0 149.0 149.0 150.0 150.0 149.0 15:28:22 INFO - PID 23773 | 15:28:22 INFO - PID 23773 | [#7] imaging-desaturate Cycles:10 Average:95.30 Median:94.50 stddev:2.16 (2.3%) stddev-sans-first:2.13 15:28:22 INFO - PID 23773 | Values: 93.0 94.0 98.0 95.0 95.0 94.0 96.0 94.0 94.0 100.0 15:28:22 INFO - PID 23773 | 15:28:22 INFO - PID 23773 | [#8] json-parse-financial Cycles:10 Average:52.30 Median:52.00 stddev:2.06 (4.0%) stddev-sans-first:2.18 15:28:22 INFO - PID 23773 | Values: 52.0 52.0 56.0 56.0 51.0 52.0 51.0 51.0 50.0 52.0 15:28:22 INFO - PID 23773 | 15:28:22 INFO - PID 23773 | [#9] json-stringify-tinderbox Cycles:10 Average:58.30 Median:58.50 stddev:3.16 (5.4%) stddev-sans-first:3.24 15:28:22 INFO - PID 23773 | Values: 56.0 64.0 55.0 56.0 60.0 62.0 56.0 57.0 61.0 56.0 15:28:22 INFO - PID 23773 | 15:28:22 INFO - PID 23773 | [#10] stanford-crypto-aes Cycles:10 Average:74.70 Median:74.50 stddev:2.11 (2.8%) stddev-sans-first:2.15 15:28:22 INFO - PID 23773 | Values: 73.0 76.0 74.0 79.0 72.0 77.0 74.0 73.0 74.0 75.0 15:28:22 INFO - PID 23773 | 15:28:22 INFO - PID 23773 | [#11] stanford-crypto-ccm Cycles:10 Average:126.90 Median:127.50 stddev:12.91 (10.1%) stddev-sans-first:13.07 15:28:22 INFO - PID 23773 | Values: 116.0 129.0 130.0 118.0 123.0 127.0 124.0 114.0 128.0 160.0 15:28:22 INFO - PID 23773 | 15:28:22 INFO - PID 23773 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:175.90 Median:176.50 stddev:6.51 (3.7%) stddev-sans-first:6.89 15:28:22 INFO - PID 23773 | Values: 177.0 179.0 169.0 172.0 172.0 182.0 190.0 169.0 173.0 176.0 15:28:22 INFO - PID 23773 | 15:28:22 INFO - PID 23773 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.50 Median:67.00 stddev:1.51 (2.3%) stddev-sans-first:1.59 15:28:22 INFO - PID 23773 | Values: 68.0 67.0 67.0 66.0 67.0 66.0 71.0 69.0 67.0 67.0 15:28:22 INFO - PID 23773 | -------- Summary: end -------- 15:28:22 INFO - PID 23773 | 15:28:23 INFO - PID 23773 | 15:28:23 INFO - PID 23773 | ###!!! [Parent][MessageChannel] Error: (msgtype=0x150082,name=PBrowser::Msg_Destroy) Closed channel: cannot send/recv 15:28:23 INFO - PID 23773 | 15:28:23 INFO - PID 23773 | 15:28:23 INFO - PID 23773 | ###!!! [Child][MessageChannel] Error: (msgtype=0x150001,name=PBrowser::Msg_AsyncMessage) Closed channel: cannot send/recv 15:28:23 INFO - PID 23773 | 15:28:23 INFO - PID 23773 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 15:28:23 INFO - TEST-INFO | 23773: exit 0 15:28:23 INFO - TEST-OK | kraken | took 62337ms 15:28:23 INFO - SUITE-END | took 1173s 15:28:24 INFO - Completed test suite (00:19:34) 15:28:24 INFO - javascript benchmark 15:28:24 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8548.049017695681, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3354.865805367784, 3371.376295385354, 3378.341223461425, 3379.138319728469, 3394.9490757638623, 6261.937380626192, 6343.904841427382, 6379.553431259814, 6409.166808314918, 6446.677666116699, 6209.130721698965, 6307.495400367971, 6313.494920406368, 6325.051242313655, 6350.42846143847, 5793.0, 5803.477687008179, 5825.097109947944, 5837.824865254049, 5948.553858460611, 5903.055511118222, 5913.704314784265, 5936.961031819436, 5981.461668449839, 5997.520198384141, 5725.036554997176, 5757.453041961007, 5858.7656493740415, 5931.851703707421, 5982.820515384546, 5724.914126288109, 5743.971280143614, 5785.710714464302, 5828.125781132864, 5854.941450585482, 5787.855303617401, 5807.0, 5854.912176317359, 5859.150423188614, 5868.178455016301, 6289.119523266746, 6294.3705629437145, 6355.650439225841, 6361.332060133665, 6429.774957876499, 6739.427148692367, 6798.286179951084, 6818.4886133540185, 6879.415249703781, 6911.550749201336, 6784.185897692309, 6819.079424277708, 6834.077399551046, 6919.135108111486, 6926.168859736814, 6284.717187726517, 6318.968405157945, 6367.808965731036, 6375.936240637627, 6401.775937842153, 6742.0, 6874.621895795679, 6906.827329316707, 7054.400375967997, 7061.752838650623, 6689.364510371507, 6742.089817874524, 6751.729930802811, 6766.458683305324, 6785.898211526831, 6762.222344430355, 6812.182538095361, 6880.105586273852, 6907.689153988083, 6909.585424874524, 6540.117084193668, 6744.156980377453, 6771.424428923498, 6859.5541289816, 6871.793846184622, 6703.095082163943, 6708.765193218214, 6709.865802684017, 6712.765053223211, 6721.630310332881, 5254.868628284247, 5271.841844744664, 5273.971575542732, 5276.234945932818, 5276.973615131977, 4750.952490475051, 4775.403074615673, 4796.304535842283, 4807.687500312469, 4813.927791083137, 5942.732577034044, 5950.851228719317, 6007.969960150172, 6031.24609423822, 6038.5772995889865, 6687.465002799764, 6786.491013174032, 6855.5886646801355, 6935.375816176568, 6940.09778728762, 5880.323762767336, 5885.941140588625, 5886.0288052471715, 5892.027815410409, 5904.143899134601, 5769.336526299529, 5853.356130825606, 5861.765529378862, 5863.120531920246, 5870.677112758839, 6598.802035938834, 6669.799906002828, 6675.532712710161, 6685.665716714145, 6686.765963191265, 6754.18949726036, 6780.355866192901, 6802.183737951477, 6870.106886104774, 6892.138482689664, 6435.485161187, 6506.02409638539, 6554.967225163844, 6556.934430655823, 6557.868842623217, 6494.188226471691, 6578.177727784027, 6628.767993120217, 6631.635260060743, 6667.19993600771, 6898.482613804085, 6920.0, 6927.3419025192525, 6932.896006559805, 6937.514373993772, 6621.5364924454825, 6723.226828914738, 6724.697388617622, 6725.327467253235, 6728.226253980855, 6592.967035164794, 6609.107770450928, 6684.264730879502, 6694.330566943461, 6712.194536655633, 6458.192725909262, 6537.444317233088, 6542.1168142300185, 6544.869102617826, 6566.310537393696, 6515.28331883502, 6618.073469714148, 6654.268030516542, 6658.700358483977, 6665.800025999034, 6378.585391949694, 6390.137331460193, 6430.839229019125, 6488.837779055561, 6521.054447105048], "value": 6215.450618356954, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [790.7034861926777, 822.194249635357, 851.582724465012, 864.4942708515516, 874.8425283448985, 36972.63027369729, 37999.81000094999, 38083.0, 38249.235015299746, 38300.61699383005, 35534.644653553456, 35664.0, 35680.2863942721, 35893.82053089731, 35941.101472463204, 6852.725890964355, 7000.404965577932, 7000.859982800341, 7002.684879180423, 7004.894926576106, 6894.24163342032, 6996.440284777205, 7006.894896576556, 7014.438844892396, 7018.19290781559, 7516.135644400882, 7707.229277072304, 7711.730089446871, 7713.807154821118, 7715.8071048223965, 7593.430492713041, 7668.194839541824, 7673.079230492321, 7677.193894641094, 7687.154413014564, 7441.59071251081, 7567.394608431312, 7651.732189373401, 7651.885221721679, 7652.120006199302, 35286.64713352859, 35762.64237357619, 35791.0, 35840.283194336225, 35886.820565897004, 3405.2338223899674, 3436.432988556885, 3442.896713098611, 3443.6900678939014, 3444.2078321986082, 29404.411911761857, 29549.704502955126, 29591.408171836658, 29591.556126658117, 29616.25959351012, 5111.7699703513435, 5124.282600435942, 5132.127538318495, 5143.331366922276, 5190.091733946544, 181839.0, 183967.0, 188532.0, 190008.0, 191697.04151479292, 44943.55056449459, 45188.77405613017, 45283.320750188774, 45341.77329113399, 45527.77236113865, 46820.5317946823, 46885.0, 47058.0, 47090.293645595346, 47270.52729472661, 15389.307481163374, 15420.691586168214, 15432.382704691687, 15435.536933892, 15680.529584112495, 12964.157329773534, 12965.870341296466, 12967.610971670865, 12981.480740770263, 13076.607701768962, 13424.060315777997, 13433.798493022612, 13444.529441469502, 13463.192208467328, 13577.796333055012, 5488.835334939959, 5518.53092487135, 5540.639858409271, 5581.209395302349, 5662.546996240373, 951.2295041016798, 977.1596427072711, 985.610683779903, 998.9500524973722, 1010.7119470950744, 20403.591928161353, 20712.0, 20856.165753369998, 28462.288442788682, 29035.274118147216, 1076.531708706715, 1080.7406222506543, 1084.69628504019, 1097.237419993097, 1103.3600511703194, 11541.711457213636, 15191.392344306105, 15416.306266217824, 15598.532044038697, 15652.921735391477, 230684.0, 232513.0, 232638.0, 232791.0, 232863.0, 51009.489905100476, 51358.48641513612, 51586.22620660693, 51604.0, 51790.48209517932, 1427.9428822847178, 1441.7909403136487, 1446.2190417174818, 1453.876420504269, 1457.453454954392, 26520.14358994852, 27028.59457108184, 27119.322016948943, 27161.72838271592, 27305.31736706519, 35885.28229435449, 36252.0, 36270.63729362673, 36285.63714362823, 36292.45561316635, 202114.0, 204611.0, 204995.0, 205065.0, 205742.0, 33030.669693302756, 35076.12309692278, 36166.63833361633, 36172.09569760777, 36214.27571448609, 42212.0, 43408.34887476754, 43586.128277433636, 43606.0, 43979.34030989474, 32534.0, 32959.83520082384, 33086.338273234884, 33132.33735325328, 33167.33665326632, 32008.67991320057, 32083.197920052186, 32088.35823283568, 32908.0, 33267.66732332743, 35810.0, 35866.28267434689, 36079.0, 36153.63846361608, 36453.27093458169, 30915.536266955565, 31419.84290078535, 31510.68489315169, 31582.526262106545, 31635.52546711847, 23292.301230963098, 23555.88222058879, 24046.956008739453, 24844.751552484966, 24936.750632493444], "value": 16906.000828748485, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [553.9639923404978, 555.9332880054393, 567.5658121537023, 573.1202604002854, 580.7589850212161, 21813.67279490809, 22457.775422245773, 22659.206927757532, 22778.31665050047, 22781.77218227817, 24991.0, 25567.61648575273, 25609.487810243783, 25689.87155064222, 25747.87126064367, 6569.343065693416, 6703.597784132968, 6706.329367063304, 6706.865862682744, 6724.697388617499, 5938.198343223674, 6470.547061705659, 6492.123563318963, 6591.11020012297, 6659.567128136656, 6457.225132984048, 6464.709088091047, 6471.029345598175, 6472.255690595571, 6475.870482590345, 6452.548321617489, 6461.870762584769, 6476.384743449388, 6478.643674597895, 6483.675816209195, 5969.492593129589, 6005.759769609211, 6009.369016253318, 6012.849678758066, 6016.157737916695, 28090.157295281173, 28490.85754571214, 29108.126756197136, 29634.110976670734, 29752.107436776932, 2001.3795723325816, 2034.216826521785, 2035.236786205173, 2037.1953078534045, 2037.3378651938178, 18625.81374186268, 18900.432987010412, 19146.138423770964, 19210.711839322423, 19220.423387298404, 2366.171839856054, 2376.952460950771, 2421.6367544868413, 2424.91512797053, 2444.10790061628, 127759.0, 130148.3492582531, 130707.99999999905, 131097.0, 131461.0, 13768.449262029406, 14320.57038288853, 14354.138751674933, 14848.0, 14949.981752463278, 22858.314250572508, 22862.31413057611, 22879.428014299774, 22887.542249155256, 22911.770882291297, 9896.356736812084, 10142.340747851365, 10178.694639160836, 10412.531436085394, 10449.111825494918, 9452.763680907894, 9516.38143520669, 9537.570809313598, 9565.378250413702, 9629.32594718377, 7499.912512685739, 10890.455477226265, 10892.183086268562, 11268.323900565993, 11513.136514761427, 3851.78815165163, 4105.281575724236, 4260.893477663021, 4264.33902745075, 4420.977895110504, 919.7010971434311, 931.1573026411108, 934.8036912248504, 946.7680418297424, 948.0898337595847, 18569.350072747387, 18695.439136825917, 18704.158312875952, 18861.0, 19183.616327673368, 959.9568019439142, 1002.6290272599185, 1014.8731408573929, 1019.6533178719122, 1021.5096753558333, 10269.845952310721, 10334.689959301233, 10417.843732344021, 10491.265611407129, 10617.469126543641, 503675.0, 512907.0, 518723.0, 519294.0, 519803.0, 116731.41634291774, 116997.0, 118676.0, 118976.40511797559, 121152.0, 1160.9709757256137, 1216.4989538706996, 1217.5495066825154, 1231.6428235811513, 1232.580922486359, 20622.89688551608, 21063.684044739035, 21232.893835530722, 21258.468538286666, 21415.036323365173, 58401.12398314114, 58978.70510647419, 60063.0, 60763.0, 61317.080243795484, 73891.26108738844, 74608.25391746013, 74772.0, 74802.62598687189, 74947.25052749403, 14417.78373324422, 14566.41734330615, 14738.0, 14752.336144873292, 14790.11259324444, 21962.560748785254, 22085.447863803533, 22471.775282246967, 22630.77369226287, 22785.544289113794, 16200.351985920432, 17074.2316595751, 17426.91286543559, 17438.47684569465, 17519.0, 14898.25508724581, 15377.154256516, 15424.0, 15573.299201535732, 16047.67904641924, 17666.29334826644, 17678.82321176823, 17809.554761131076, 17869.0, 17959.820401795816, 14317.140971541325, 14483.493077742229, 14488.710225795636, 14547.41810327575, 14587.124772513684, 16743.33026678968, 16888.831111688727, 16889.831101689317, 17442.127893605524, 17895.642087157925], "value": 12064.099843415986, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1304.3869381390746, 1345.4281930179666, 1351.3648585164974, 1363.7068030373468, 1369.4864425840308, 14192.858071419283, 14827.851721482783, 14843.480478183252, 14912.701745965102, 14919.254037298118, 14274.4290228391, 14767.483138090141, 15268.08391496511, 15286.694266114671, 15297.770533442008, 2646.841189528625, 2700.1494529223232, 2704.323919020245, 2705.702372738997, 2705.8105932584726, 2372.264597974625, 2577.8324408913454, 2627.5533159362953, 2719.673639163303, 2722.618833363331, 2663.1877277430376, 2675.919722408331, 2691.0984820085196, 2691.7039125696156, 2693.367058741204, 2529.026324864931, 2534.087728417768, 2535.3027917322697, 2642.3262068172685, 2672.1983404978428, 2641.418887844671, 2656.628072069912, 2663.653725015755, 2675.571908494651, 2691.744284292989, 14152.858471415257, 14386.496472623512, 14414.783778243334, 14417.927910360486, 14435.783463248059, 7659.234076592296, 7822.6088695564995, 7897.763067107996, 7913.841723165562, 7921.089074756419, 5190.636655434121, 5382.91925621116, 5496.587755918282, 5505.6696598204235, 5521.834344969658, 1809.701399269119, 1854.0636978325858, 1854.0822292964933, 1886.6792645250202, 1898.515878451, 24627.38431539208, 25062.749372506405, 25168.622470662955, 25185.0, 25295.873520632464, 6743.865122697519, 7173.6771845267085, 7211.639418029077, 7215.711371545184, 7252.202257751643, 16608.501744947673, 16669.33322667104, 16694.833051669328, 16796.412125575545, 16895.91552042232, 7262.455315851226, 7633.885491717629, 7669.233076692286, 8165.71420000309, 8193.139720329398, 7172.748953786592, 7248.855022899513, 7254.383377412873, 7268.200497945222, 7294.781156565312, 5090.185570308733, 5180.300659411007, 5186.870328241824, 5211.765470553834, 5217.68693878361, 1511.231858725294, 1512.659651578386, 1533.4939469974881, 1540.7534794432836, 1542.0978727444347, 887.1261807119981, 894.5661354243186, 900.7342833864026, 902.0122965352928, 910.6676063236871, 7583.431242656823, 7633.084029916446, 7648.426368022309, 7674.53952762836, 7809.882851757115, 713.0979311171373, 722.2668990974165, 723.4321057969469, 724.6557885004686, 726.8291951391419, 4667.416572928384, 5697.202391665171, 5701.743421546041, 5840.707964601753, 6200.596961197508, 19982.70025949583, 20867.8956605216, 20873.47816304574, 20914.16343346249, 21010.15959361639, 20153.09311081005, 20465.795342046687, 20498.0, 20659.69010464844, 20719.378418647466, 10296.948515257376, 10520.842187367196, 10527.736806579896, 10544.578216871392, 10563.679540057492, 8724.781880452785, 8790.780230494289, 8832.823343532964, 8933.15135062168, 8957.0, 17236.224369903135, 17508.649827003133, 17556.91221543935, 18265.178066987282, 18447.0, 17743.73384399261, 18008.369707060716, 18111.909440452713, 18253.0, 18413.81586184121, 11419.37193454368, 11784.292942423483, 11813.76372472563, 11846.0, 11857.822132668189, 13411.664708381979, 13546.05177637556, 13573.660658483617, 13575.456981720621, 13575.86424135746, 11171.66485005451, 11403.771924561628, 11422.200445968703, 11438.94280528592, 11588.420578971187, 10753.0, 10819.891801081889, 10881.510332035235, 11024.173187010845, 11086.445677716243, 9195.954020229856, 9241.0, 9306.208972237166, 9306.255499560155, 9307.813843722952, 6631.270560238467, 6674.666266686743, 6680.2651708313015, 6693.832654183684, 6696.430803381767, 7288.927110729037, 7331.8533629328185, 7427.8143046424275, 7489.363404110493, 7542.622868856425], "value": 6504.902983369774, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [497.41056847635565, 500.91734863747484, 520.4067363205945, 521.5670993075745, 530.5569849175938, 6326.513269381691, 6381.553291269607, 6390.233172019352, 6397.776077837277, 6400.615963042221, 6218.751249949996, 6229.750809967607, 6267.780627678032, 6285.528585356105, 6318.399752023562, 5096.419420734309, 5141.383034035921, 5161.329027226474, 5168.974155129219, 5185.0, 5093.516115968977, 5235.424103348629, 5257.316548848645, 5258.421573626898, 5266.552343050846, 5239.449857764937, 5254.111957151699, 5275.498827611371, 5280.570937368796, 5293.914747476758, 5093.2105523643895, 5265.684058956455, 5286.682799032051, 5290.153575427951, 5302.946970530284, 4866.416030076378, 4866.489018653026, 4889.633277504166, 4894.800773810439, 4895.9755201224125, 6341.936580634227, 6345.270293916213, 6357.427831495142, 6359.682015899187, 6368.554201205918, 6041.486473649701, 6078.419610901154, 6092.421219984094, 6102.359252278536, 6121.204243448367, 6862.313768623148, 6862.794116176523, 6869.175698916162, 6882.242953275136, 6887.380135787803, 5321.574274058066, 5343.198520221998, 5352.357717073937, 5355.758990845421, 5393.1101368274185, 6858.348456896587, 6968.0, 7041.753538626123, 7082.0, 7134.500584959055, 5487.890242195213, 5498.780048798083, 5499.560035197254, 5499.917501237484, 5536.474034966672, 5559.527440167551, 5600.467955544217, 5602.439756024365, 5608.915866262009, 5616.157576363496, 5946.791862284799, 5976.671283079386, 6020.795840831851, 6049.667268300285, 6083.6045657032155, 6701.626166635828, 6790.253072162058, 6801.693923773442, 6843.794686159423, 6866.519343645997, 1941.4660968233566, 1965.849977762996, 1966.301962803213, 1976.9308074217333, 1981.782003979561, 1376.8640871281234, 1437.475321507642, 1452.6295794572316, 1463.758479850834, 1466.1056755379211, 5873.383294754075, 5885.852853678693, 5910.143029260819, 6007.8197654070445, 6022.518198544106, 6755.763548275787, 6789.388954994074, 6801.667183080255, 6858.965705171442, 6914.55055421396, 5899.970500147472, 5915.852103697442, 5935.940640593625, 5947.988841896888, 5956.315023772235, 3626.655467730561, 3654.1230104775195, 3664.358737220976, 3676.7977761222855, 3688.22547265072, 6599.373059559334, 6634.535582509275, 6667.333166708323, 6696.799096027127, 6727.3763232339425, 6941.305869413019, 6997.440204783605, 6999.30006999296, 7031.964840175767, 7143.571385716874, 6595.142631457879, 6699.832504187434, 6715.093462382516, 6717.932820671731, 6734.1918969722965, 6915.827104322231, 6918.308169183041, 6949.7567585134275, 6997.965010174917, 7004.754833580801, 6903.1371078615175, 6903.5167538271835, 6914.377706006484, 6940.687669055005, 6945.861082778417, 6728.562643428161, 6782.321767823376, 6813.2846051163915, 6819.113515242987, 6835.316468353125, 5446.537044351275, 5462.672239665632, 5478.726063696879, 5482.972585137049, 5531.0, 6649.401553860176, 6874.518783685094, 6874.896876546756, 6952.2352541221435, 6992.195897471653, 6561.475081993333, 6670.199576050905, 6722.596644201168, 6741.258461569321, 6742.157230346207, 6665.2334981475815, 6689.464842812466, 6728.663566821737, 6728.899066514105, 6734.595924244561, 6523.217213934358, 6636.668166591748, 6654.0, 6657.4674026078765, 6706.262311145868, 6805.9659701701175, 6819.317568512947, 6835.855506467081, 6862.828429289308, 6881.587104773729, 6568.934310656832, 6595.208574971034, 6601.900971485527, 6614.90077648826, 6627.635480048643], "value": 5303.798492595663, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [869.6347534035705, 870.8214815962727, 894.2845723421261, 896.6771962093645, 898.7213963671262, 18622.25510979561, 19381.515462113453, 19395.709064364044, 19413.223471061177, 19436.611267774635, 16708.164591770423, 17470.12649367533, 20942.37172884812, 20962.26632067878, 21063.894680526577, 892.7678803511085, 906.8911730592338, 907.0747837206046, 911.9544022798867, 911.9785839859334, 875.0942774228674, 955.7132860141965, 962.2302158273388, 974.741693451236, 975.8585005174245, 1002.4737013068161, 1005.4419797012655, 1006.3257617396325, 1008.7326858382535, 1008.7528555503911, 1002.0280328081749, 1002.7944271424341, 1006.079437314856, 1006.1900170362856, 1011.3931641015405, 734.2730696610371, 734.6326836581709, 734.6987735028613, 736.4255880413286, 739.7263012685341, 19270.325538606223, 19394.321198758116, 19462.416127516197, 19741.309054183177, 19756.308529201408, 20574.177032918666, 20587.0, 20964.790352096436, 21068.157273709032, 21086.156553737987, 16231.188440578042, 16273.59316017109, 16343.918280408641, 16409.753853692084, 16446.424375146813, 3646.1431563582537, 3673.0633688409284, 3674.412094064937, 3675.1363429594026, 3676.2647470506004, 114599.0, 115585.84414155835, 115925.42037289844, 116574.0, 117152.0, 14902.403903843724, 15359.539213823604, 15475.535733928, 15479.148646824533, 15483.22583870802, 28024.71975280262, 29176.416471670447, 29416.85291573571, 29522.11433656994, 29544.261393465335, 8179.509229446252, 8238.176182381714, 8241.711540096188, 8350.958245208734, 8373.371997100241, 3945.309570825094, 4025.75845449274, 4052.5947405259826, 4060.411240370189, 4061.3095773718537, 4661.883452913704, 4756.072565849695, 4756.9286460703115, 4763.118823017753, 5362.758675859518, 1035.492608621785, 1054.093479607537, 1065.8934106589434, 1067.9359238445718, 1071.1163290285544, 639.8688268904864, 652.2271108736163, 656.7799787071289, 660.0890770736353, 674.1270055278426, 10787.0, 10828.296160749684, 11176.161787865942, 11635.418229088511, 11673.299602023906, 651.9967400163064, 655.7344275568403, 656.0651072222064, 662.9204495460575, 665.6904539389208, 5453.454654534515, 5486.31421072366, 5516.724163791875, 5691.004074286983, 5693.68684722336, 109046.45476772565, 110264.4486777561, 113006.0, 114356.42821785838, 114839.42580287045, 91532.0, 94159.52920235493, 94247.0, 97747.51126244324, 98873.0, 81981.59009204915, 82523.0, 85735.57132214424, 87109.0, 87684.56157719171, 11512.079033677453, 11673.007794337576, 12294.077944154404, 12496.375181240719, 12504.374781261082, 39556.60443395529, 39889.20221595494, 40150.59849401469, 40660.59339406568, 42893.785531073394, 69061.65469172622, 69559.65220173867, 69870.30129698638, 71941.6402917982, 72813.63593182, 19005.904970475058, 19028.429147125607, 19192.808071919102, 19472.707909381654, 19504.60990780205, 20794.48013799667, 21794.346169614302, 21959.0, 22145.889270553544, 22401.207903367365, 17567.472975810746, 18087.728684070014, 18308.359207427675, 18446.538836529195, 18644.440666780018, 16425.425110121087, 16598.66802663964, 17596.120193990504, 18862.0, 19774.209031638573, 16746.330146793993, 16848.0, 16999.235034423233, 17035.31858725637, 17287.827121729126, 12167.695807604881, 12429.689257768629, 13022.739545209231, 13345.599632011055, 13616.727665446437, 13300.46798128064, 13632.863671363159, 13867.375968081258, 13896.305184740924, 13943.790843137158], "value": 8919.524425640251, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1517.3000000000002, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [98.0, 107.0, 100.0, 106.0, 111.0, 107.0, 107.0, 97.0, 108.0, 111.0], "value": 105.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 115.0, 142.0, 182.0, 122.0, 148.0, 148.0, 121.0, 186.0, 119.0], "value": 143.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 168.0, 161.0, 160.0, 162.0, 162.0, 172.0, 160.0, 168.0, 164.0], "value": 164.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 74.0, 76.0, 166.0, 75.0, 74.0, 74.0, 82.0, 154.0, 75.0], "value": 92.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 79.0, 140.0, 82.0, 78.0, 79.0, 125.0, 80.0, 79.0, 142.0], "value": 96.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 114.0, 119.0, 115.0, 115.0, 114.0, 114.0, 118.0, 118.0, 113.0], "value": 115.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 149.0, 150.0, 151.0, 151.0, 149.0, 149.0, 150.0, 150.0, 149.0], "value": 149.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 94.0, 98.0, 95.0, 95.0, 94.0, 96.0, 94.0, 94.0, 100.0], "value": 95.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [52.0, 52.0, 56.0, 56.0, 51.0, 52.0, 51.0, 51.0, 50.0, 52.0], "value": 52.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 64.0, 55.0, 56.0, 60.0, 62.0, 56.0, 57.0, 61.0, 56.0], "value": 58.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 76.0, 74.0, 79.0, 72.0, 77.0, 74.0, 73.0, 74.0, 75.0], "value": 74.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 129.0, 130.0, 118.0, 123.0, 127.0, 124.0, 114.0, 128.0, 160.0], "value": 126.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [177.0, 179.0, 169.0, 172.0, 172.0, 182.0, 190.0, 169.0, 173.0, 176.0], "value": 175.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 67.0, 67.0, 66.0, 67.0, 66.0, 71.0, 69.0, 67.0, 67.0], "value": 67.5, "unit": "score"}]}]} 15:28:24 INFO - Return code: 0 15:28:24 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 15:28:24 INFO - # TBPL SUCCESS # 15:28:24 INFO - Running post-action listener: _package_coverage_data 15:28:24 INFO - Running post-action listener: _resource_record_post_action 15:28:24 INFO - [mozharness: 2017-08-25 22:28:24.224231Z] Finished run-tests step (success) 15:28:24 INFO - Running post-run listener: _resource_record_post_run 15:28:24 INFO - Total resource usage - Wall time: 1192s; CPU: 13.0%; Read bytes: 217088; Write bytes: 428498944; Read time: 48; Write time: 300808 15:28:24 INFO - TinderboxPrint: CPU usage
13.1% 15:28:24 INFO - TinderboxPrint: I/O read bytes / time
217,088 / 48 15:28:24 INFO - TinderboxPrint: I/O write bytes / time
428,498,944 / 300,808 15:28:24 INFO - TinderboxPrint: CPU idle
8,254.6 (86.9%) 15:28:24 INFO - TinderboxPrint: CPU user
1,199.8 (12.6%) 15:28:24 INFO - TinderboxPrint: Swap in / out
0 / 0 15:28:24 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 105680896; Read time: 0; Write time: 84012 15:28:24 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 15:28:24 INFO - run-tests - Wall time: 1175s; CPU: 13.0%; Read bytes: 217088; Write bytes: 322818048; Read time: 48; Write time: 216796 15:28:24 INFO - Running post-run listener: _upload_blobber_files 15:28:24 INFO - Blob upload gear active. 15:28:24 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 15:28:24 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 15:28:24 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'] 15:28:24 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 15:28:25 INFO - (blobuploader) - INFO - Open directory for files ... 15:28:25 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 15:28:25 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:28:25 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:28:26 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 15:28:26 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:28:26 INFO - (blobuploader) - INFO - Done attempting. 15:28:26 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 15:28:26 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:28:26 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:28:27 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 15:28:27 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:28:27 INFO - (blobuploader) - INFO - Done attempting. 15:28:27 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 15:28:27 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:28:27 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:28:28 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 15:28:28 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:28:28 INFO - (blobuploader) - INFO - Done attempting. 15:28:28 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 15:28:28 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:28:28 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:28:31 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 15:28:31 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:28:31 INFO - (blobuploader) - INFO - Done attempting. 15:28:31 INFO - (blobuploader) - INFO - Iteration through files over. 15:28:31 INFO - Return code: 0 15:28:31 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 15:28:31 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 15:28:31 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/70c62b50893aa0c541f83b33abea1fea7e40f358492409a979517f40a97fde126e8ab0f58cf6f5d6487b77c987c6ff3ddfeeff4e61e83a6f7fbfa583ed8401c3", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6b1d2884eb238de802fa73cc97a3bb7880522ef4ceac1d56f7cd1f57411a98ceffbdf3f6569f0e2c8b28a17d7cc134fa2660547a178c122ef21cfa08f9b3ad49", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/73deb63bf4c961d14664bc1237925b271d61b615cbe08b35c5758e996e82c82ca5a1a7fc57f3c815e04cd2777d0b22457bbc191dc6b71e030a96b784600f1e3f", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e2103b7a7465e5352f21e73e623d73e3f1e3d51dd4b67adde2b1c51517520655fc8597f6b7e20f9c748c7b7245b0c130ed5024db9fe9e20edcc7c7f9c2ac14d7"} 15:28:31 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 15:28:31 INFO - Writing to file /builds/slave/test/properties/blobber_files 15:28:31 INFO - Contents: 15:28:31 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/70c62b50893aa0c541f83b33abea1fea7e40f358492409a979517f40a97fde126e8ab0f58cf6f5d6487b77c987c6ff3ddfeeff4e61e83a6f7fbfa583ed8401c3", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6b1d2884eb238de802fa73cc97a3bb7880522ef4ceac1d56f7cd1f57411a98ceffbdf3f6569f0e2c8b28a17d7cc134fa2660547a178c122ef21cfa08f9b3ad49", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/73deb63bf4c961d14664bc1237925b271d61b615cbe08b35c5758e996e82c82ca5a1a7fc57f3c815e04cd2777d0b22457bbc191dc6b71e030a96b784600f1e3f", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e2103b7a7465e5352f21e73e623d73e3f1e3d51dd4b67adde2b1c51517520655fc8597f6b7e20f9c748c7b7245b0c130ed5024db9fe9e20edcc7c7f9c2ac14d7"} 15:28:31 INFO - Running post-run listener: copy_logs_to_upload_dir 15:28:31 INFO - Copying logs to upload dir... 15:28:31 INFO - mkdir: /builds/slave/test/build/upload/logs 15:28:31 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1252.041585 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 52 secs) (at 2017-08-25 15:28:31.913603) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-08-25 15:28:31.918375) ========= 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-1503698856.952209-1681960764 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/70c62b50893aa0c541f83b33abea1fea7e40f358492409a979517f40a97fde126e8ab0f58cf6f5d6487b77c987c6ff3ddfeeff4e61e83a6f7fbfa583ed8401c3", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6b1d2884eb238de802fa73cc97a3bb7880522ef4ceac1d56f7cd1f57411a98ceffbdf3f6569f0e2c8b28a17d7cc134fa2660547a178c122ef21cfa08f9b3ad49", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/73deb63bf4c961d14664bc1237925b271d61b615cbe08b35c5758e996e82c82ca5a1a7fc57f3c815e04cd2777d0b22457bbc191dc6b71e030a96b784600f1e3f", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e2103b7a7465e5352f21e73e623d73e3f1e3d51dd4b67adde2b1c51517520655fc8597f6b7e20f9c748c7b7245b0c130ed5024db9fe9e20edcc7c7f9c2ac14d7"} build_url:https://queue.taskcluster.net/v1/task/fFNdRubgQVGid70fwvBNNw/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011437 build_url: 'https://queue.taskcluster.net/v1/task/fFNdRubgQVGid70fwvBNNw/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/70c62b50893aa0c541f83b33abea1fea7e40f358492409a979517f40a97fde126e8ab0f58cf6f5d6487b77c987c6ff3ddfeeff4e61e83a6f7fbfa583ed8401c3", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6b1d2884eb238de802fa73cc97a3bb7880522ef4ceac1d56f7cd1f57411a98ceffbdf3f6569f0e2c8b28a17d7cc134fa2660547a178c122ef21cfa08f9b3ad49", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/73deb63bf4c961d14664bc1237925b271d61b615cbe08b35c5758e996e82c82ca5a1a7fc57f3c815e04cd2777d0b22457bbc191dc6b71e030a96b784600f1e3f", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e2103b7a7465e5352f21e73e623d73e3f1e3d51dd4b67adde2b1c51517520655fc8597f6b7e20f9c748c7b7245b0c130ed5024db9fe9e20edcc7c7f9c2ac14d7"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-08-25 15:28:31.948169) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-08-25 15:28:31.948500) ========= 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-1503698856.952209-1681960764 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004517 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-08-25 15:28:32.030943) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-08-25 15:28:32.031266) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-08-25 15:28:32.031563) ========= ========= Total master_lag: 0.20 =========