builder: mozilla-central_ubuntu64_hw_stylo_test-dromaeojs-e10s slave: talos-linux64-ix-035 starttime: 1500218549.74 results: success (0) revision: c1185e615e55949151f20c66d55b0e7e62034adb ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-07-16 08:22:29.736165) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-07-16 08:22:29.736652) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-07-16 08:22:29.736973) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-07-16 08:22:29.769531) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-07-16 08:22:29.769834) ========= 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=ed14279e38b05397cf4aa391000001a4-1500218451.411980-622583467 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-07-16 08:22:32-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 37.4M=0s 2017-07-16 08:22:32 (37.4 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.133232 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-07-16 08:22:29.919932) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-07-16 08:22:29.920286) ========= 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=ed14279e38b05397cf4aa391000001a4-1500218451.411980-622583467 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015767 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-07-16 08:22:29.974704) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-07-16 08:22:29.975081) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev c1185e615e55949151f20c66d55b0e7e62034adb --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 c1185e615e55949151f20c66d55b0e7e62034adb --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=ed14279e38b05397cf4aa391000001a4-1500218451.411980-622583467 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-07-16 08:22:32,520 truncating revision to first 12 chars 2017-07-16 08:22:32,520 Setting DEBUG logging. 2017-07-16 08:22:32,520 attempt 1/10 2017-07-16 08:22:32,520 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/c1185e615e55?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-07-16 08:22:32,991 unpacking tar archive at: mozilla-central-c1185e615e55/testing/mozharness/ program finished with exit code 0 elapsedTime=0.767343 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-07-16 08:22:30.760792) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-07-16 08:22:30.761189) ========= script_repo_revision: c1185e615e55949151f20c66d55b0e7e62034adb ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-07-16 08:22:30.761661) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-07-16 08:22:30.761983) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-07-16 08:22:30.802290) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 44 secs) (at 2017-07-16 08:22:30.802626) ========= /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=ed14279e38b05397cf4aa391000001a4-1500218451.411980-622583467 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 08:22:33 INFO - MultiFileLogger online at 20170716 08:22:33 in /builds/slave/test 08:22:33 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 08:22:33 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:22:33 INFO - {'append_to_log': False, 08:22:33 INFO - 'base_work_dir': '/builds/slave/test', 08:22:33 INFO - 'blob_upload_branch': 'Firefox', 08:22:33 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:22:33 INFO - 'branch': 'Firefox', 08:22:33 INFO - 'buildbot_json_path': 'buildprops.json', 08:22:33 INFO - 'code_coverage': False, 08:22:33 INFO - 'config_files': ('talos/linux_config.py',), 08:22:33 INFO - 'default_actions': ('clobber', 08:22:33 INFO - 'read-buildbot-config', 08:22:33 INFO - 'download-and-extract', 08:22:33 INFO - 'populate-webroot', 08:22:33 INFO - 'create-virtualenv', 08:22:33 INFO - 'install', 08:22:33 INFO - 'setup-mitmproxy', 08:22:33 INFO - 'run-tests'), 08:22:33 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:22:33 INFO - 'disable_ccov_upload': False, 08:22:33 INFO - 'download_minidump_stackwalk': True, 08:22:33 INFO - 'download_symbols': 'ondemand', 08:22:33 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:22:33 INFO - 'tooltool.py': '/tools/tooltool.py', 08:22:33 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:22:33 INFO - '/tools/misc-python/virtualenv.py')}, 08:22:33 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:22:33 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:22:33 INFO - 'gecko_profile': False, 08:22:33 INFO - 'gecko_profile_interval': 0, 08:22:33 INFO - 'installer_path': 'installer.exe', 08:22:33 INFO - 'log_level': 'info', 08:22:33 INFO - 'log_name': 'talos', 08:22:33 INFO - 'log_to_console': True, 08:22:33 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 08:22:33 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 08:22:33 INFO - 'opt_config_files': (), 08:22:33 INFO - 'pip_index': False, 08:22:33 INFO - 'suite': 'dromaeojs-e10s', 08:22:33 INFO - 'system_bits': '32', 08:22:33 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:22:33 INFO - 'title': 'talos-linux64-ix-035', 08:22:33 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:22:33 INFO - 'use_talos_json': True, 08:22:33 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:22:33 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:22:33 INFO - 'work_dir': 'build'} 08:22:33 INFO - [mozharness: 2017-07-16 15:22:33.450277Z] Running clobber step. 08:22:33 INFO - Running pre-action listener: _resource_record_pre_action 08:22:33 INFO - Running main action method: clobber 08:22:33 INFO - rmtree: /builds/slave/test/build 08:22:33 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:22:34 INFO - Running post-action listener: _resource_record_post_action 08:22:34 INFO - [mozharness: 2017-07-16 15:22:34.505798Z] Finished clobber step (success) 08:22:34 INFO - [mozharness: 2017-07-16 15:22:34.505900Z] Running read-buildbot-config step. 08:22:34 INFO - Running pre-action listener: _resource_record_pre_action 08:22:34 INFO - Running main action method: read_buildbot_config 08:22:34 INFO - Using buildbot properties: 08:22:34 INFO - { 08:22:34 INFO - "project": "", 08:22:34 INFO - "product": "firefox", 08:22:34 INFO - "who": "archaeopteryx@coole-files.de", 08:22:34 INFO - "installer_path": "public/build/target.tar.bz2", 08:22:34 INFO - "builddir": "mozilla-central_ubuntu64_hw_stylo_test-dromaeojs-e10s", 08:22:34 INFO - "repository": "https://hg.mozilla.org/mozilla-central/", 08:22:34 INFO - "buildername": "Ubuntu HW 12.04 x64 stylo mozilla-central talos dromaeojs-e10s", 08:22:34 INFO - "stage_platform": "linux64-stylo", 08:22:34 INFO - "basedir": "/builds/slave/test", 08:22:34 INFO - "buildnumber": 213, 08:22:34 INFO - "platform": "ubuntu64_hw_stylo", 08:22:34 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 08:22:34 INFO - "slavebuilddir": "test", 08:22:34 INFO - "taskId": "GiN5uBk6RHWwTPJUzIjPYw", 08:22:34 INFO - "branch": "mozilla-central", 08:22:34 INFO - "script_repo_revision": "production", 08:22:34 INFO - "revision": "c1185e615e55949151f20c66d55b0e7e62034adb", 08:22:34 INFO - "slavename": "talos-linux64-ix-035", 08:22:34 INFO - "repo_path": "mozilla-central" 08:22:34 INFO - } 08:22:34 INFO - Finding installer, test and symbols from parent task. 08:22:34 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/GiN5uBk6RHWwTPJUzIjPYw'}, attempt #1 08:22:34 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/GiN5uBk6RHWwTPJUzIjPYw'}, attempt #1 08:22:35 INFO - Task dependencies: NDpJWzxyReSiqoum8vZ_XA 08:22:35 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/NDpJWzxyReSiqoum8vZ_XA'}, attempt #1 08:22:35 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/NDpJWzxyReSiqoum8vZ_XA/artifacts/public/build/target.tar.bz2 08:22:35 INFO - Set test_url: https://queue.taskcluster.net/v1/task/NDpJWzxyReSiqoum8vZ_XA/artifacts/public/build/test_packages.json 08:22:35 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/NDpJWzxyReSiqoum8vZ_XA/artifacts/public/build/target.crashreporter-symbols.zip 08:22:35 INFO - Running post-action listener: _resource_record_post_action 08:22:35 INFO - [mozharness: 2017-07-16 15:22:35.880653Z] Finished read-buildbot-config step (success) 08:22:35 INFO - [mozharness: 2017-07-16 15:22:35.880874Z] Running download-and-extract step. 08:22:35 INFO - Running pre-action listener: _resource_record_pre_action 08:22:35 INFO - Running main action method: download_and_extract 08:22:35 INFO - mkdir: /builds/slave/test/build/tests 08:22:35 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')]} 08:22:35 INFO - trying https://queue.taskcluster.net/v1/task/NDpJWzxyReSiqoum8vZ_XA/artifacts/public/build/target.test_packages.json 08:22:35 INFO - Downloading https://queue.taskcluster.net/v1/task/NDpJWzxyReSiqoum8vZ_XA/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 08:22:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/NDpJWzxyReSiqoum8vZ_XA/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 08:22:36 INFO - Downloaded 989 bytes. 08:22:36 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 08:22:36 INFO - Using the following test package requirements: 08:22:36 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 08:22:36 INFO - u'common': [u'target.common.tests.zip'], 08:22:36 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 08:22:36 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 08:22:36 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 08:22:36 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 08:22:36 INFO - u'mozbase': [u'target.common.tests.zip'], 08:22:36 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 08:22:36 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 08:22:36 INFO - u'web-platform': [u'target.common.tests.zip', 08:22:36 INFO - u'target.web-platform.tests.tar.gz'], 08:22:36 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 08:22:36 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 08:22:36 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/NDpJWzxyReSiqoum8vZ_XA/artifacts/public/build/target.common.tests.zip 08:22:36 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/NDpJWzxyReSiqoum8vZ_XA/artifacts/public/build/target.common.tests.zip'}, attempt #1 08:22:36 INFO - Fetch https://queue.taskcluster.net/v1/task/NDpJWzxyReSiqoum8vZ_XA/artifacts/public/build/target.common.tests.zip into memory 08:22:37 INFO - Content-Length response header: 72753092 08:22:37 INFO - Bytes received: 72753092 08:22:48 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 08:22:48 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/NDpJWzxyReSiqoum8vZ_XA/artifacts/public/build/target.common.tests.zip 08:22:48 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/NDpJWzxyReSiqoum8vZ_XA/artifacts/public/build/target.common.tests.zip'}, attempt #1 08:22:48 INFO - Fetch https://queue.taskcluster.net/v1/task/NDpJWzxyReSiqoum8vZ_XA/artifacts/public/build/target.common.tests.zip into memory 08:22:50 INFO - Content-Length response header: 72753092 08:22:50 INFO - Bytes received: 72753092 08:23:02 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/NDpJWzxyReSiqoum8vZ_XA/artifacts/public/build/target.talos.tests.zip 08:23:02 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/NDpJWzxyReSiqoum8vZ_XA/artifacts/public/build/target.talos.tests.zip'}, attempt #1 08:23:02 INFO - Fetch https://queue.taskcluster.net/v1/task/NDpJWzxyReSiqoum8vZ_XA/artifacts/public/build/target.talos.tests.zip into memory 08:23:03 INFO - Content-Length response header: 14495033 08:23:03 INFO - Bytes received: 14495033 08:23:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:23:03 INFO - trying https://queue.taskcluster.net/v1/task/NDpJWzxyReSiqoum8vZ_XA/artifacts/public/build/target.tar.bz2 08:23:03 INFO - Downloading https://queue.taskcluster.net/v1/task/NDpJWzxyReSiqoum8vZ_XA/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 08:23:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/NDpJWzxyReSiqoum8vZ_XA/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 08:23:04 INFO - Downloaded 61961412 bytes. 08:23:04 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/NDpJWzxyReSiqoum8vZ_XA/artifacts/public/build/target.tar.bz2 08:23:04 INFO - mkdir: /builds/slave/test/properties 08:23:04 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:23:04 INFO - Writing to file /builds/slave/test/properties/build_url 08:23:04 INFO - Contents: 08:23:04 INFO - build_url:https://queue.taskcluster.net/v1/task/NDpJWzxyReSiqoum8vZ_XA/artifacts/public/build/target.tar.bz2 08:23:04 INFO - Running post-action listener: _resource_record_post_action 08:23:04 INFO - Running post-action listener: set_extra_try_arguments 08:23:04 INFO - [mozharness: 2017-07-16 15:23:04.866756Z] Finished download-and-extract step (success) 08:23:04 INFO - [mozharness: 2017-07-16 15:23:04.866873Z] Running populate-webroot step. 08:23:04 INFO - Running pre-action listener: _resource_record_pre_action 08:23:04 INFO - Running main action method: populate_webroot 08:23:04 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:23:04 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:23:04 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:23:04 INFO - '--tppagecycles', 08:23:04 INFO - '7'], 08:23:04 INFO - 'tests': ['tsvgm']}}, 08:23:04 INFO - 'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 08:23:04 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 08:23:04 INFO - 'tests': ['dromaeo_css', 'kraken']}, 08:23:04 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 08:23:04 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 08:23:04 INFO - 'talos_options': ['--disable-e10s'], 08:23:04 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:23:04 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 08:23:04 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:23:04 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 08:23:04 INFO - 'talos_options': ['--disable-e10s'], 08:23:04 INFO - 'tests': ['damp', 'tps']}, 08:23:04 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 08:23:04 INFO - 'tests': ['damp', 'tps']}, 08:23:04 INFO - 'g3': {'talos_options': ['--disable-e10s'], 08:23:04 INFO - 'tests': ['dromaeo_dom']}, 08:23:04 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:23:04 INFO - 'g4': {'talos_options': ['--disable-e10s'], 08:23:04 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 08:23:04 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 08:23:04 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 08:23:04 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 08:23:04 INFO - 'other': {'talos_options': ['--disable-e10s'], 08:23:04 INFO - 'tests': ['a11yr', 08:23:04 INFO - 'ts_paint', 08:23:04 INFO - 'tpaint', 08:23:04 INFO - 'sessionrestore', 08:23:04 INFO - 'sessionrestore_no_auto_restore', 08:23:04 INFO - 'tabpaint']}, 08:23:04 INFO - 'other-e10s': {'tests': ['a11yr', 08:23:04 INFO - 'ts_paint', 08:23:04 INFO - 'tpaint', 08:23:04 INFO - 'sessionrestore', 08:23:04 INFO - 'sessionrestore_many_windows', 08:23:04 INFO - 'sessionrestore_no_auto_restore', 08:23:04 INFO - 'tabpaint']}, 08:23:04 INFO - 'other-e10s_l64': {'tests': ['a11yr', 08:23:04 INFO - 'ts_paint', 08:23:04 INFO - 'tpaint', 08:23:04 INFO - 'sessionrestore', 08:23:04 INFO - 'sessionrestore_many_windows', 08:23:04 INFO - 'sessionrestore_no_auto_restore', 08:23:04 INFO - 'tabpaint']}, 08:23:04 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 08:23:04 INFO - 'ts_paint', 08:23:04 INFO - 'tpaint', 08:23:04 INFO - 'sessionrestore', 08:23:04 INFO - 'sessionrestore_many_windows', 08:23:04 INFO - 'sessionrestore_no_auto_restore', 08:23:04 INFO - 'tabpaint']}, 08:23:04 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 08:23:04 INFO - 'tests': ['a11yr', 08:23:04 INFO - 'ts_paint', 08:23:04 INFO - 'tpaint', 08:23:04 INFO - 'sessionrestore', 08:23:04 INFO - 'sessionrestore_no_auto_restore', 08:23:04 INFO - 'tabpaint']}, 08:23:04 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 08:23:04 INFO - 'tests': ['a11yr', 08:23:04 INFO - 'ts_paint', 08:23:04 INFO - 'tpaint', 08:23:04 INFO - 'sessionrestore', 08:23:04 INFO - 'sessionrestore_no_auto_restore', 08:23:04 INFO - 'tabpaint']}, 08:23:04 INFO - 'perf-reftest': {'tests': ['bloom_basic']}, 08:23:04 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 08:23:04 INFO - 'perf-reftest-singletons-e10s': {'tests': ['bloom_basic_singleton']}, 08:23:04 INFO - 'quantum-pageload-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 08:23:04 INFO - 'talos_options': ['--mitmproxy', 08:23:04 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 08:23:04 INFO - '--firstNonBlankPaint'], 08:23:04 INFO - 'tests': ['quantum_pageload_google', 08:23:04 INFO - 'quantum_pageload_youtube', 08:23:04 INFO - 'quantum_pageload_amazon', 08:23:04 INFO - 'quantum_pageload_facebook']}, 08:23:04 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 08:23:04 INFO - 'tests': ['tsvgx', 08:23:04 INFO - 'tsvgr_opacity', 08:23:04 INFO - 'tart', 08:23:04 INFO - 'tscrollx', 08:23:04 INFO - 'cart', 08:23:04 INFO - 'tsvg_static']}, 08:23:04 INFO - 'svgr-e10s': {'tests': ['tsvgx', 08:23:04 INFO - 'tsvgr_opacity', 08:23:04 INFO - 'tart', 08:23:04 INFO - 'tscrollx', 08:23:04 INFO - 'cart', 08:23:04 INFO - 'tsvg_static']}, 08:23:04 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 08:23:04 INFO - 'talos_options': ['--disable-e10s'], 08:23:04 INFO - 'tests': ['tp5o']}, 08:23:04 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 08:23:04 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 08:23:04 INFO - 'talos_options': ['--disable-e10s', 08:23:04 INFO - '--xperf_path', 08:23:04 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:23:04 INFO - 'tests': ['tp5n']}, 08:23:04 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 08:23:04 INFO - 'talos_options': ['--xperf_path', 08:23:04 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:23:04 INFO - 'tests': ['tp5n']}}, 08:23:04 INFO - 'talos.zip': {'path': '', 08:23:04 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:23:04 INFO - Running post-action listener: _resource_record_post_action 08:23:04 INFO - [mozharness: 2017-07-16 15:23:04.883483Z] Finished populate-webroot step (success) 08:23:04 INFO - [mozharness: 2017-07-16 15:23:04.883575Z] Running create-virtualenv step. 08:23:04 INFO - Running pre-action listener: _resource_record_pre_action 08:23:04 INFO - Running main action method: create_virtualenv 08:23:04 INFO - Creating virtualenv /builds/slave/test/build/venv 08:23:04 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 08:23:04 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:23:04 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 08:23:04 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:23:04 INFO - Using real prefix '/usr' 08:23:04 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:23:05 INFO - Installing distribute.............................................................................................................................................................................................done. 08:23:07 INFO - Installing pip.................done. 08:23:07 INFO - Return code: 0 08:23:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 08:23:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 08:23:07 INFO - Reading from file tmpfile_stdout 08:23:07 INFO - Output received: 08:23:07 INFO - pip 1.5.5 from /builds/slave/test/build/venv/local/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 08:23:07 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:23:07 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')]} 08:23:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:23:07 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')]} 08:23:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:23:07 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 0x22401f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x240ca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25b1b60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25aed00>, '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 0x25afc00>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25b0090>, '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': 'ed14279e38b05397cf4aa391000001a4-1500218451.411980-622583467', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:23:07 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 08:23:07 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 08:23:07 INFO - Using env: {'DISPLAY': ':0', 08:23:07 INFO - 'HOME': '/home/cltbld', 08:23:07 INFO - 'LANG': 'en_US.UTF-8', 08:23:07 INFO - 'LANGUAGE': 'en_US:en', 08:23:07 INFO - 'LOGNAME': 'cltbld', 08:23:07 INFO - 'MAIL': '/var/mail/cltbld', 08:23:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:23:07 INFO - 'MOZ_NO_REMOTE': '1', 08:23:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:23:07 INFO - 'NO_EM_RESTART': '1', 08:23:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:23:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:23:07 INFO - 'PWD': '/builds/slave/test', 08:23:07 INFO - 'SHELL': '/bin/bash', 08:23:07 INFO - 'SHLVL': '1', 08:23:07 INFO - 'TERM': 'linux', 08:23:07 INFO - 'TMOUT': '86400', 08:23:07 INFO - 'USER': 'cltbld', 08:23:07 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1500218451.411980-622583467', 08:23:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:23:07 INFO - '_': '/tools/buildbot/bin/python'} 08:23:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:23:07 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 08:23:07 INFO - Cleaning up... 08:23:07 INFO - Return code: 0 08:23:07 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 08:23:07 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')]} 08:23:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:23:07 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')]} 08:23:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:23:07 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 0x22401f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x240ca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25b1b60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25aed00>, '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 0x25afc00>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25b0090>, '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': 'ed14279e38b05397cf4aa391000001a4-1500218451.411980-622583467', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:23:07 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 08:23:07 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 08:23:07 INFO - Using env: {'DISPLAY': ':0', 08:23:07 INFO - 'HOME': '/home/cltbld', 08:23:07 INFO - 'LANG': 'en_US.UTF-8', 08:23:07 INFO - 'LANGUAGE': 'en_US:en', 08:23:07 INFO - 'LOGNAME': 'cltbld', 08:23:07 INFO - 'MAIL': '/var/mail/cltbld', 08:23:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:23:07 INFO - 'MOZ_NO_REMOTE': '1', 08:23:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:23:07 INFO - 'NO_EM_RESTART': '1', 08:23:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:23:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:23:07 INFO - 'PWD': '/builds/slave/test', 08:23:07 INFO - 'SHELL': '/bin/bash', 08:23:07 INFO - 'SHLVL': '1', 08:23:07 INFO - 'TERM': 'linux', 08:23:07 INFO - 'TMOUT': '86400', 08:23:07 INFO - 'USER': 'cltbld', 08:23:07 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1500218451.411980-622583467', 08:23:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:23:07 INFO - '_': '/tools/buildbot/bin/python'} 08:23:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:23:08 INFO - Downloading/unpacking psutil>=3.1.1 08:23:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:23:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:23:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:23:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:23:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:23:09 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:23:09 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:23:09 INFO - Installing collected packages: psutil 08:23:09 INFO - Running setup.py install for psutil 08:23:09 INFO - building 'psutil._psutil_linux' extension 08:23:09 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 08:23:09 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 08:23:09 INFO - building 'psutil._psutil_posix' extension 08:23:09 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 08:23:09 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 08:23:09 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:23:09 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:23:09 INFO - Successfully installed psutil 08:23:09 INFO - Cleaning up... 08:23:09 INFO - Return code: 0 08:23:09 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 08:23:09 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')]} 08:23:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:23:09 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')]} 08:23:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:23:09 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 0x22401f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x240ca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25b1b60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25aed00>, '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 0x25afc00>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25b0090>, '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': 'ed14279e38b05397cf4aa391000001a4-1500218451.411980-622583467', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:23:09 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 08:23:09 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 08:23:09 INFO - Using env: {'DISPLAY': ':0', 08:23:09 INFO - 'HOME': '/home/cltbld', 08:23:09 INFO - 'LANG': 'en_US.UTF-8', 08:23:09 INFO - 'LANGUAGE': 'en_US:en', 08:23:09 INFO - 'LOGNAME': 'cltbld', 08:23:09 INFO - 'MAIL': '/var/mail/cltbld', 08:23:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:23:09 INFO - 'MOZ_NO_REMOTE': '1', 08:23:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:23:09 INFO - 'NO_EM_RESTART': '1', 08:23:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:23:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:23:09 INFO - 'PWD': '/builds/slave/test', 08:23:09 INFO - 'SHELL': '/bin/bash', 08:23:09 INFO - 'SHLVL': '1', 08:23:09 INFO - 'TERM': 'linux', 08:23:09 INFO - 'TMOUT': '86400', 08:23:09 INFO - 'USER': 'cltbld', 08:23:09 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1500218451.411980-622583467', 08:23:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:23:09 INFO - '_': '/tools/buildbot/bin/python'} 08:23:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:23:10 INFO - Downloading/unpacking mozsystemmonitor==0.3 08:23:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:23:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:23:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:23:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:23:11 INFO - Downloading mozsystemmonitor-0.3.tar.gz 08:23:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:23:11 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 08:23:11 INFO - Installing collected packages: mozsystemmonitor 08:23:11 INFO - Running setup.py install for mozsystemmonitor 08:23:11 INFO - Successfully installed mozsystemmonitor 08:23:11 INFO - Cleaning up... 08:23:11 INFO - Return code: 0 08:23:11 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 08:23: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')]} 08:23:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:23: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')]} 08:23:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:23: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', '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 0x22401f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x240ca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25b1b60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25aed00>, '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 0x25afc00>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25b0090>, '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': 'ed14279e38b05397cf4aa391000001a4-1500218451.411980-622583467', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:23: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', 'jsonschema==2.5.1'] in /builds/slave/test/build 08:23: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 jsonschema==2.5.1 08:23:11 INFO - Using env: {'DISPLAY': ':0', 08:23:11 INFO - 'HOME': '/home/cltbld', 08:23:11 INFO - 'LANG': 'en_US.UTF-8', 08:23:11 INFO - 'LANGUAGE': 'en_US:en', 08:23:11 INFO - 'LOGNAME': 'cltbld', 08:23:11 INFO - 'MAIL': '/var/mail/cltbld', 08:23:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:23:11 INFO - 'MOZ_NO_REMOTE': '1', 08:23:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:23:11 INFO - 'NO_EM_RESTART': '1', 08:23:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:23:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:23:11 INFO - 'PWD': '/builds/slave/test', 08:23:11 INFO - 'SHELL': '/bin/bash', 08:23:11 INFO - 'SHLVL': '1', 08:23:11 INFO - 'TERM': 'linux', 08:23:11 INFO - 'TMOUT': '86400', 08:23:11 INFO - 'USER': 'cltbld', 08:23:11 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1500218451.411980-622583467', 08:23:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:23:11 INFO - '_': '/tools/buildbot/bin/python'} 08:23:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:23:11 INFO - Downloading/unpacking jsonschema==2.5.1 08:23:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:23:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:23:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:23:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:23:12 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:23:12 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 08:23: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 08:23: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 08:23: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 08:23: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 08:23:12 INFO - Downloading functools32-3.2.3-2.tar.gz 08:23:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 08:23:12 INFO - warning: no files found matching '*.txt' 08:23:12 INFO - no previously-included directories found matching 'build' 08:23:12 INFO - no previously-included directories found matching 'dist' 08:23:12 INFO - no previously-included directories found matching '.git*' 08:23:12 INFO - Installing collected packages: jsonschema, functools32 08:23:12 INFO - Running setup.py install for functools32 08:23:12 INFO - warning: no files found matching '*.txt' 08:23:12 INFO - no previously-included directories found matching 'build' 08:23:12 INFO - no previously-included directories found matching 'dist' 08:23:12 INFO - no previously-included directories found matching '.git*' 08:23:12 INFO - Successfully installed jsonschema functools32 08:23:12 INFO - Cleaning up... 08:23:12 INFO - Return code: 0 08:23:12 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 08:23: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')]} 08:23:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:23: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')]} 08:23:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:23: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', '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 0x22401f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x240ca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25b1b60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25aed00>, '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 0x25afc00>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25b0090>, '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': 'ed14279e38b05397cf4aa391000001a4-1500218451.411980-622583467', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:23: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', 'functools32==3.2.3-2'] in /builds/slave/test/build 08:23: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 functools32==3.2.3-2 08:23:13 INFO - Using env: {'DISPLAY': ':0', 08:23:13 INFO - 'HOME': '/home/cltbld', 08:23:13 INFO - 'LANG': 'en_US.UTF-8', 08:23:13 INFO - 'LANGUAGE': 'en_US:en', 08:23:13 INFO - 'LOGNAME': 'cltbld', 08:23:13 INFO - 'MAIL': '/var/mail/cltbld', 08:23:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:23:13 INFO - 'MOZ_NO_REMOTE': '1', 08:23:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:23:13 INFO - 'NO_EM_RESTART': '1', 08:23:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:23:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:23:13 INFO - 'PWD': '/builds/slave/test', 08:23:13 INFO - 'SHELL': '/bin/bash', 08:23:13 INFO - 'SHLVL': '1', 08:23:13 INFO - 'TERM': 'linux', 08:23:13 INFO - 'TMOUT': '86400', 08:23:13 INFO - 'USER': 'cltbld', 08:23:13 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1500218451.411980-622583467', 08:23:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:23:13 INFO - '_': '/tools/buildbot/bin/python'} 08:23:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:23:13 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 08:23:13 INFO - Cleaning up... 08:23:13 INFO - Return code: 0 08:23:13 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:23: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')]} 08:23:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:23: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')]} 08:23:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:23: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', '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 0x22401f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x240ca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25b1b60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25aed00>, '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 0x25afc00>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25b0090>, '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': 'ed14279e38b05397cf4aa391000001a4-1500218451.411980-622583467', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:23: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 08:23: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 blobuploader==1.2.4 08:23:13 INFO - Using env: {'DISPLAY': ':0', 08:23:13 INFO - 'HOME': '/home/cltbld', 08:23:13 INFO - 'LANG': 'en_US.UTF-8', 08:23:13 INFO - 'LANGUAGE': 'en_US:en', 08:23:13 INFO - 'LOGNAME': 'cltbld', 08:23:13 INFO - 'MAIL': '/var/mail/cltbld', 08:23:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:23:13 INFO - 'MOZ_NO_REMOTE': '1', 08:23:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:23:13 INFO - 'NO_EM_RESTART': '1', 08:23:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:23:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:23:13 INFO - 'PWD': '/builds/slave/test', 08:23:13 INFO - 'SHELL': '/bin/bash', 08:23:13 INFO - 'SHLVL': '1', 08:23:13 INFO - 'TERM': 'linux', 08:23:13 INFO - 'TMOUT': '86400', 08:23:13 INFO - 'USER': 'cltbld', 08:23:13 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1500218451.411980-622583467', 08:23:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:23:13 INFO - '_': '/tools/buildbot/bin/python'} 08:23:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:23:13 INFO - Downloading/unpacking blobuploader==1.2.4 08:23: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 08:23: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 08:23: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 08:23: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 08:23:14 INFO - Downloading blobuploader-1.2.4.tar.gz 08:23:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:23:14 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:23:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:23:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:23:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:23:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:23:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:23:14 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:23:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:23:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:23:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:23:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:23:15 INFO - Downloading docopt-0.6.1.tar.gz 08:23:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:23:15 INFO - Installing collected packages: blobuploader, requests, docopt 08:23:15 INFO - Running setup.py install for blobuploader 08:23:15 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:23:15 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:23:15 INFO - Running setup.py install for requests 08:23:15 INFO - Running setup.py install for docopt 08:23:15 INFO - Successfully installed blobuploader requests docopt 08:23:15 INFO - Cleaning up... 08:23:15 INFO - Return code: 0 08:23:15 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:23: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')]} 08:23:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:23: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')]} 08:23:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:23:15 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 0x22401f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x240ca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25b1b60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25aed00>, '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 0x25afc00>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25b0090>, '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': 'ed14279e38b05397cf4aa391000001a4-1500218451.411980-622583467', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:23:15 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 08:23:15 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 08:23:15 INFO - Using env: {'DISPLAY': ':0', 08:23:15 INFO - 'HOME': '/home/cltbld', 08:23:15 INFO - 'LANG': 'en_US.UTF-8', 08:23:15 INFO - 'LANGUAGE': 'en_US:en', 08:23:15 INFO - 'LOGNAME': 'cltbld', 08:23:15 INFO - 'MAIL': '/var/mail/cltbld', 08:23:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:23:15 INFO - 'MOZ_NO_REMOTE': '1', 08:23:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:23:15 INFO - 'NO_EM_RESTART': '1', 08:23:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:23:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:23:15 INFO - 'PWD': '/builds/slave/test', 08:23:15 INFO - 'SHELL': '/bin/bash', 08:23:15 INFO - 'SHLVL': '1', 08:23:15 INFO - 'TERM': 'linux', 08:23:15 INFO - 'TMOUT': '86400', 08:23:15 INFO - 'USER': 'cltbld', 08:23:15 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1500218451.411980-622583467', 08:23:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:23:15 INFO - '_': '/tools/buildbot/bin/python'} 08:23:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:23:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:23:16 INFO - Running setup.py (path:/tmp/pip-XiaOv7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:23:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:23:16 INFO - Running setup.py (path:/tmp/pip-vhffjX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:23:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:23:16 INFO - Running setup.py (path:/tmp/pip-AvP1Hp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:23:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:23:16 INFO - Running setup.py (path:/tmp/pip-OCeyFt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:23:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:23:16 INFO - Running setup.py (path:/tmp/pip-FMNpNA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:23:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:23:16 INFO - Running setup.py (path:/tmp/pip-cWIPIP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:23:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:23:16 INFO - Running setup.py (path:/tmp/pip-crQF4q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:23:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:23:16 INFO - Running setup.py (path:/tmp/pip-3AZel5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:23:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:23:16 INFO - Running setup.py (path:/tmp/pip-yQ_w_s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:23:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:23:16 INFO - Running setup.py (path:/tmp/pip-C0k9px-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:23:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:23:16 INFO - Running setup.py (path:/tmp/pip-SlTF3T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:23:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:23:16 INFO - Running setup.py (path:/tmp/pip-1LjINV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:23:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:23:16 INFO - Running setup.py (path:/tmp/pip-BhN8lx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:23:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:23:17 INFO - Running setup.py (path:/tmp/pip-eR_EDi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:23:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:23:17 INFO - Running setup.py (path:/tmp/pip-L1ZKN4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:23:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:23:17 INFO - Running setup.py (path:/tmp/pip-dOC8g2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:23:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:23:17 INFO - Running setup.py (path:/tmp/pip-HSY02o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:23:17 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:23:17 INFO - Running setup.py install for manifestparser 08:23:17 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:23:17 INFO - Running setup.py install for mozcrash 08:23:17 INFO - Running setup.py install for mozdebug 08:23:17 INFO - Running setup.py install for mozdevice 08:23:17 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:23:17 INFO - Running setup.py install for mozfile 08:23:17 INFO - Running setup.py install for mozhttpd 08:23:17 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:23:17 INFO - Running setup.py install for mozinfo 08:23:18 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:23:18 INFO - Running setup.py install for mozInstall 08:23:18 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:23:18 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:23:18 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:23:18 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:23:18 INFO - Running setup.py install for mozleak 08:23:18 INFO - Running setup.py install for mozlog 08:23:18 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:23:18 INFO - Running setup.py install for moznetwork 08:23:18 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:23:18 INFO - Running setup.py install for mozprocess 08:23:18 INFO - Running setup.py install for mozprofile 08:23:18 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:23:18 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:23:18 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:23:18 INFO - Running setup.py install for mozrunner 08:23:18 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:23:18 INFO - Running setup.py install for mozscreenshot 08:23:18 INFO - Running setup.py install for moztest 08:23:19 INFO - Running setup.py install for mozversion 08:23:19 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:23:19 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:23:19 INFO - Cleaning up... 08:23:19 INFO - Return code: 0 08:23:19 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:23: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')]} 08:23:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:23: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')]} 08:23:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:23:19 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 0x22401f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x240ca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25b1b60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25aed00>, '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 0x25afc00>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25b0090>, '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': 'ed14279e38b05397cf4aa391000001a4-1500218451.411980-622583467', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:23:19 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 08:23:19 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 08:23:19 INFO - Using env: {'DISPLAY': ':0', 08:23:19 INFO - 'HOME': '/home/cltbld', 08:23:19 INFO - 'LANG': 'en_US.UTF-8', 08:23:19 INFO - 'LANGUAGE': 'en_US:en', 08:23:19 INFO - 'LOGNAME': 'cltbld', 08:23:19 INFO - 'MAIL': '/var/mail/cltbld', 08:23:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:23:19 INFO - 'MOZ_NO_REMOTE': '1', 08:23:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:23:19 INFO - 'NO_EM_RESTART': '1', 08:23:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:23:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:23:19 INFO - 'PWD': '/builds/slave/test', 08:23:19 INFO - 'SHELL': '/bin/bash', 08:23:19 INFO - 'SHLVL': '1', 08:23:19 INFO - 'TERM': 'linux', 08:23:19 INFO - 'TMOUT': '86400', 08:23:19 INFO - 'USER': 'cltbld', 08:23:19 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1500218451.411980-622583467', 08:23:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:23:19 INFO - '_': '/tools/buildbot/bin/python'} 08:23:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:23:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:23:19 INFO - Running setup.py (path:/tmp/pip-hTg76T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:23:19 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 08:23:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:23:19 INFO - Running setup.py (path:/tmp/pip-zVBcTP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:23:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:23:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:23:19 INFO - Running setup.py (path:/tmp/pip-8NIzae-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:23:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 08:23:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:23:19 INFO - Running setup.py (path:/tmp/pip-U8PuAN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:23:19 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)) 08:23:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:23:19 INFO - Running setup.py (path:/tmp/pip-VfmOPg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:23:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 08:23:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:23:19 INFO - Running setup.py (path:/tmp/pip-7kOct_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:23:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 08:23:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:23:19 INFO - Running setup.py (path:/tmp/pip-8lLRjX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:23:19 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)) 08:23:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:23:19 INFO - Running setup.py (path:/tmp/pip-dN3pZJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:23:19 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)) 08:23:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:23:19 INFO - Running setup.py (path:/tmp/pip-0aP33R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:23:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 08:23:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:23:20 INFO - Running setup.py (path:/tmp/pip-P4da51-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:23:20 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)) 08:23:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:23:20 INFO - Running setup.py (path:/tmp/pip-X5_44k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:23:20 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 08:23:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:23:20 INFO - Running setup.py (path:/tmp/pip-p38Cfc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:23:20 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)) 08:23:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:23:20 INFO - Running setup.py (path:/tmp/pip-KKN_0C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:23:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 08:23:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:23:20 INFO - Running setup.py (path:/tmp/pip-CMF0m6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:23:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 08:23:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:23:20 INFO - Running setup.py (path:/tmp/pip-g_qQ1R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:23:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 08:23:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:23:20 INFO - Running setup.py (path:/tmp/pip-wbsT6g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:23:20 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 08:23:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:23:20 INFO - Running setup.py (path:/tmp/pip-frL9jy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:23:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 08:23:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:23:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:23:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 08:23:20 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)) 08:23:20 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)) 08:23:20 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)) 08:23:20 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:23:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:23:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:23:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:23:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:23:21 INFO - Downloading blessings-1.6.tar.gz 08:23:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:23:21 INFO - Installing collected packages: blessings 08:23:21 INFO - Running setup.py install for blessings 08:23:21 INFO - Successfully installed blessings 08:23:21 INFO - Cleaning up... 08:23:21 INFO - Return code: 0 08:23:21 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:23:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:23:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:23:22 INFO - Reading from file tmpfile_stdout 08:23:22 INFO - Current package versions: 08:23:22 INFO - argparse == 1.2.1 08:23:22 INFO - blessings == 1.6 08:23:22 INFO - blobuploader == 1.2.4 08:23:22 INFO - docopt == 0.6.1 08:23:22 INFO - functools32 == 3.2.3-2 08:23:22 INFO - jsonschema == 2.5.1 08:23:22 INFO - manifestparser == 1.1 08:23:22 INFO - mozInstall == 1.13 08:23:22 INFO - mozcrash == 1.0 08:23:22 INFO - mozdebug == 0.1 08:23:22 INFO - mozdevice == 0.51 08:23:22 INFO - mozfile == 1.2 08:23:22 INFO - mozhttpd == 0.7 08:23:22 INFO - mozinfo == 0.10 08:23:22 INFO - mozleak == 0.1 08:23:22 INFO - mozlog == 3.5 08:23:22 INFO - moznetwork == 0.27 08:23:22 INFO - mozprocess == 0.25 08:23:22 INFO - mozprofile == 0.28 08:23:22 INFO - mozrunner == 6.13 08:23:22 INFO - mozscreenshot == 0.1 08:23:22 INFO - mozsystemmonitor == 0.3 08:23:22 INFO - moztest == 0.8 08:23:22 INFO - mozversion == 1.4 08:23:22 INFO - psutil == 3.1.1 08:23:22 INFO - requests == 1.2.3 08:23:22 INFO - wsgiref == 0.1.2 08:23:22 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:23: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')]} 08:23:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:23: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')]} 08:23:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:23:22 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 0x22401f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x240ca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25b1b60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25aed00>, '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 0x25afc00>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25b0090>, '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': 'ed14279e38b05397cf4aa391000001a4-1500218451.411980-622583467', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:23:22 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 08:23:22 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 08:23:22 INFO - Using env: {'DISPLAY': ':0', 08:23:22 INFO - 'HOME': '/home/cltbld', 08:23:22 INFO - 'LANG': 'en_US.UTF-8', 08:23:22 INFO - 'LANGUAGE': 'en_US:en', 08:23:22 INFO - 'LOGNAME': 'cltbld', 08:23:22 INFO - 'MAIL': '/var/mail/cltbld', 08:23:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:23:22 INFO - 'MOZ_NO_REMOTE': '1', 08:23:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:23:22 INFO - 'NO_EM_RESTART': '1', 08:23:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:23:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:23:22 INFO - 'PWD': '/builds/slave/test', 08:23:22 INFO - 'SHELL': '/bin/bash', 08:23:22 INFO - 'SHLVL': '1', 08:23:22 INFO - 'TERM': 'linux', 08:23:22 INFO - 'TMOUT': '86400', 08:23:22 INFO - 'USER': 'cltbld', 08:23:22 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1500218451.411980-622583467', 08:23:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:23:22 INFO - '_': '/tools/buildbot/bin/python'} 08:23:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:23:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 08:23:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 08:23:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 08:23:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 08:23:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 08:23:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 08:23:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 08:23:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 08:23:22 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 08:23:22 INFO - Downloading/unpacking marionette-driver>=1.4.0 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 08:23:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:23:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:23:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:23:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:23:23 INFO - Downloading marionette_driver-1.4.0.tar.gz 08:23:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/marionette-driver/setup.py) egg_info for package marionette-driver 08:23:23 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 11)) 08:23:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:23:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:23:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:23:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:23:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 08:23:23 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 08:23:23 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 08:23:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner>=6.9 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from marionette-driver>=1.4.0->-r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 08:23:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice>=0.37 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozrunner>=6.9->marionette-driver>=1.4.0->-r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 08:23:23 INFO - Installing collected packages: marionette-driver, simplejson 08:23:23 INFO - Running setup.py install for marionette-driver 08:23:23 INFO - Running setup.py install for simplejson 08:23:23 INFO - building 'simplejson._speedups' extension 08:23:23 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 08:23:24 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 08:23:24 INFO - Successfully installed marionette-driver simplejson 08:23:24 INFO - Cleaning up... 08:23:24 INFO - Return code: 0 08:23:24 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 08:23:24 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')]} 08:23:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:23:24 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')]} 08:23:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:23:24 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 0x22401f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x240ca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25b1b60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25aed00>, '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 0x25afc00>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25b0090>, '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': 'ed14279e38b05397cf4aa391000001a4-1500218451.411980-622583467', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:23:24 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 08:23:24 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 08:23:24 INFO - Using env: {'DISPLAY': ':0', 08:23:24 INFO - 'HOME': '/home/cltbld', 08:23:24 INFO - 'LANG': 'en_US.UTF-8', 08:23:24 INFO - 'LANGUAGE': 'en_US:en', 08:23:24 INFO - 'LOGNAME': 'cltbld', 08:23:24 INFO - 'MAIL': '/var/mail/cltbld', 08:23:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:23:24 INFO - 'MOZ_NO_REMOTE': '1', 08:23:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:23:24 INFO - 'NO_EM_RESTART': '1', 08:23:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:23:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:23:24 INFO - 'PWD': '/builds/slave/test', 08:23:24 INFO - 'SHELL': '/bin/bash', 08:23:24 INFO - 'SHLVL': '1', 08:23:24 INFO - 'TERM': 'linux', 08:23:24 INFO - 'TMOUT': '86400', 08:23:24 INFO - 'USER': 'cltbld', 08:23:24 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1500218451.411980-622583467', 08:23:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:23:24 INFO - '_': '/tools/buildbot/bin/python'} 08:23:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:23:25 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 08:23:25 INFO - Cleaning up... 08:23:25 INFO - Return code: 0 08:23:25 INFO - Running post-action listener: _resource_record_post_action 08:23:25 INFO - Running post-action listener: _start_resource_monitoring 08:23:25 INFO - Starting resource monitoring. 08:23:25 INFO - [mozharness: 2017-07-16 15:23:25.170052Z] Finished create-virtualenv step (success) 08:23:25 INFO - [mozharness: 2017-07-16 15:23:25.170606Z] Running install step. 08:23:25 INFO - Running pre-action listener: _resource_record_pre_action 08:23:25 INFO - Running main action method: install 08:23:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:23:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:23:25 INFO - Reading from file tmpfile_stdout 08:23:25 INFO - Detecting whether we're running mozinstall >=1.0... 08:23:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:23:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:23:25 INFO - Reading from file tmpfile_stdout 08:23:25 INFO - Output received: 08:23:25 INFO - Usage: mozinstall [options] installer 08:23:25 INFO - Options: 08:23:25 INFO - -h, --help show this help message and exit 08:23:25 INFO - -d DEST, --destination=DEST 08:23:25 INFO - Directory to install application into. [default: 08:23:25 INFO - "/builds/slave/test"] 08:23:25 INFO - --app=APP Application being installed. [default: firefox] 08:23:25 INFO - mkdir: /builds/slave/test/build/application 08:23:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/target.tar.bz2', '--destination', '/builds/slave/test/build/application'] 08:23:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 08:23:43 INFO - Reading from file tmpfile_stdout 08:23:43 INFO - Output received: 08:23:43 INFO - /builds/slave/test/build/application/firefox/firefox 08:23:43 INFO - Running post-action listener: _resource_record_post_action 08:23:43 INFO - [mozharness: 2017-07-16 15:23:43.422206Z] Finished install step (success) 08:23:43 INFO - [mozharness: 2017-07-16 15:23:43.422460Z] Running setup-mitmproxy step. 08:23:43 INFO - Running pre-action listener: _resource_record_pre_action 08:23:43 INFO - Running main action method: setup_mitmproxy 08:23:43 INFO - Skipping: mitmproxy is not required 08:23:43 INFO - Running post-action listener: _resource_record_post_action 08:23:43 INFO - [mozharness: 2017-07-16 15:23:43.423614Z] Finished setup-mitmproxy step (success) 08:23:43 INFO - [mozharness: 2017-07-16 15:23:43.423836Z] Running run-tests step. 08:23:43 INFO - Running pre-action listener: _resource_record_pre_action 08:23:43 INFO - Running pre-action listener: _set_gcov_prefix 08:23:43 INFO - Running main action method: run_tests 08:23:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:23:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:23:43 INFO - Python 2.7.3 08:23:43 INFO - Return code: 0 08:23:43 INFO - grabbing minidump binary from tooltool 08:23:43 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')]} 08:23:43 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25aed00>, '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 0x25afc00>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25b0090>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:23:43 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 08:23:43 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 08:23:43 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 08:23:43 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:23:43 INFO - Return code: 0 08:23:43 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 08:23:43 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:23:43 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:23:43 INFO - ENV: RUST_BACKTRACE is now 1 08:23:43 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 08:23:43 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:23:43 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/NDpJWzxyReSiqoum8vZ_XA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-035', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 08:23:43 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/NDpJWzxyReSiqoum8vZ_XA/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-035 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 08:23:43 INFO - Using env: {'DISPLAY': ':0', 08:23:43 INFO - 'HOME': '/home/cltbld', 08:23:43 INFO - 'LANG': 'en_US.UTF-8', 08:23:43 INFO - 'LANGUAGE': 'en_US:en', 08:23:43 INFO - 'LOGNAME': 'cltbld', 08:23:43 INFO - 'MAIL': '/var/mail/cltbld', 08:23:43 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:23:43 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 08:23:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:23:43 INFO - 'MOZ_NO_REMOTE': '1', 08:23:43 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:23:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:23:43 INFO - 'NO_EM_RESTART': '1', 08:23:43 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:23:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:23:43 INFO - 'PWD': '/builds/slave/test', 08:23:43 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:23:43 INFO - 'RUST_BACKTRACE': '1', 08:23:43 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 08:23:43 INFO - 'SHELL': '/bin/bash', 08:23:43 INFO - 'SHLVL': '1', 08:23:43 INFO - 'TERM': 'linux', 08:23:43 INFO - 'TMOUT': '86400', 08:23:43 INFO - 'USER': 'cltbld', 08:23:43 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1500218451.411980-622583467', 08:23:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:23:43 INFO - '_': '/tools/buildbot/bin/python'} 08:23:43 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/NDpJWzxyReSiqoum8vZ_XA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-035', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 08:23:43 INFO - mozversion application_buildid: 20170716143154 08:23:43 INFO - mozversion application_changeset: c1185e615e55949151f20c66d55b0e7e62034adb 08:23:43 INFO - mozversion application_display_name: Nightly 08:23:43 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:23:43 INFO - mozversion application_name: Firefox 08:23:43 INFO - mozversion application_remotingname: firefox 08:23:43 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 08:23:43 INFO - mozversion application_vendor: Mozilla 08:23:43 INFO - mozversion application_version: 56.0a1 08:23:43 INFO - mozversion platform_buildid: 20170716143154 08:23:43 INFO - mozversion platform_changeset: c1185e615e55949151f20c66d55b0e7e62034adb 08:23:43 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 08:23:43 INFO - mozversion platform_version: 56.0a1 08:23:43 INFO - using testdate: 1500218623 08:23:43 INFO - actual date: 1500218623 08:23:43 INFO - starting webserver on 'localhost:48690' 08:23:43 INFO - SUITE-START | Running 2 tests 08:23:43 INFO - TEST-START | dromaeo_css 08:23:43 INFO - Initialising browser for dromaeo_css test... 08:23:43 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:48690/getInfo.html -profile /tmp/tmp_GB7fY/profile 08:23:43 INFO - TEST-INFO | started process 8516 (/builds/slave/test/build/application/firefox/firefox http://localhost:48690/getInfo.html) 08:23:50 INFO - TEST-INFO | 8516: exit 0 08:23:50 INFO - Browser initialized. 08:23:50 INFO - Running cycle 1/1 for dromaeo_css test... 08:23:50 INFO - TEST-INFO | started process 8739 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp_GB7fY/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 08:24:01 INFO - PID 8739 | RSS: Main: 169852928 08:24:01 INFO - PID 8739 | 08:26:59 INFO - PID 8739 | Cycle 1(1): loaded http://localhost:48690/tests/dromaeo/cssquery-dojo.html (next: http://localhost:48690/tests/dromaeo/cssquery-ext.html) 08:27:01 INFO - PID 8739 | RSS: Main: 177688576 08:27:01 INFO - PID 8739 | 08:30:03 INFO - PID 8739 | Cycle 1(1): loaded http://localhost:48690/tests/dromaeo/cssquery-ext.html (next: http://localhost:48690/tests/dromaeo/cssquery-jquery.html) 08:30:03 INFO - PID 8739 | RSS: Main: 176656384 08:30:03 INFO - PID 8739 | 08:33:05 INFO - PID 8739 | Cycle 1(1): loaded http://localhost:48690/tests/dromaeo/cssquery-jquery.html (next: http://localhost:48690/tests/dromaeo/cssquery-mootools.html) 08:33:05 INFO - PID 8739 | RSS: Main: 178692096 08:33:05 INFO - PID 8739 | 08:36:07 INFO - PID 8739 | Cycle 1(1): loaded http://localhost:48690/tests/dromaeo/cssquery-mootools.html (next: http://localhost:48690/tests/dromaeo/cssquery-prototype.html) 08:36:08 INFO - PID 8739 | RSS: Main: 176934912 08:36:08 INFO - PID 8739 | 08:39:11 INFO - PID 8739 | Cycle 1(1): loaded http://localhost:48690/tests/dromaeo/cssquery-prototype.html (next: http://localhost:48690/tests/dromaeo/cssquery-yui.html) 08:39:12 INFO - PID 8739 | RSS: Main: 176246784 08:39:12 INFO - PID 8739 | 08:42:14 INFO - PID 8739 | Cycle 1(1): loaded http://localhost:48690/tests/dromaeo/cssquery-yui.html (next: http://localhost:48690/tests/dromaeo/cssquery-dojo.html) 08:42:14 INFO - PID 8739 | RSS: Main: 179798016 08:42:14 INFO - PID 8739 | 08:42:14 INFO - PID 8739 | __start_tp_report 08:42:14 INFO - PID 8739 | _x_x_mozilla_page_load 08:42:14 INFO - PID 8739 | _x_x_mozilla_page_load_details 08:42:14 INFO - PID 8739 | |i|pagename|runs| 08:42:14 INFO - PID 8739 | |0;dojo.html;3007.609010828595;3051.7558595312375;3060.877564897404;3074.431230222409;3094.39659266443;5900.409959004098;5955.464008239263;5962.314333851608;5974.761009559618;5982.670953097589;5933.762649494015;5991.880162396749;6085.361037091108;6101.420365065312;6112.510999120071;5510.366307874586;5587.636803607773;5622.409646987069;5651.943480565183;5653.4911857932775;5544.667319960815;5593.412691667378;5620.100783874581;5641.548676105922;5653;5322.65402748822;5404.864878378033;5505.366882808468;5575.024370735126;5618.775248990056;5457.345118585795;5471.781128754885;5512.118061110244;5514.420985796473;5534.4742249486235;5375.543078838304;5437.13005919055;5439.129739241703;5443.918341224885;5455.563554915637;5886.352501224862;5887.941120588782;5889.79385721502;5890.2342695449315;5913;6355.142055822451;6365.267994180682;6378.138951241569;6392.073149393358;6404.807855764335;6412.679366031726;6423.96788016057;6444.387783160592;6455.741770329181;6470.838229044264;5857.76568937242;5949.25634295713;5951.434613711691;5996.430339117776;6000.159977603095;6517;6580.76967306142;6588.604683718992;6637.568558043712;6673.666316684146;6295.874082518324;6299.055141728686;6365.904511432333;6387.584806987531;6389.7763578274535;6322.178116844781;6389.2652344980925;6405.19935008124;6412.615243085336;6416.582922110048;6267.633918610039;6301.653409062454;6326.49388048955;6361.840953976188;6375.71309291083;5340.866478338073;6236.314005459396;6409.455196308366;6478.611283323015;6513.869722605521;5176;5238.842834714965;5243.580513558906;5247.2129180623215;5256.2904007959205;4409.845655402046;4436.179306828247;4499.032707967803;4506.954930450719;4522.0277640307495;5504.119340905436;5521.116621340566;5527.613067085346;5533.750981205775;5540.418256083134;5267.420583735786;6348.111264422984;6375.936240637627;6404.775832845828;6463.935360646427;5532.7786888524815;5538.252335934678;5590.608657393944;5609.5792815539;5623.381428042912;5630.155476678449;5636.464535869086;5656.519195868397;5688.744006519716;5702.45826646468;6153.96923015391;6223.937760622336;6229.345918678564;6241.032639940817;6286.811395658137;6373.649449280334;6407.583507072025;6408.743650253938;6429.260635027032;6447.484201263981;6151.815445536641;6207.131001659862;6218.19163508741;6227.346128656607;6233.96883015582;6276.1213430118905;6280.403361680633;6284.962981108066;6298.71655775482;6314.62112273265;6386.233651961795;6392.3927226913365;6428.100065990671;6468.741250349934;6554.951207806728;6227.875442491216;6233.283172435046;6234.688265586793;6322.114903913363;6342.524310676626;6197.25632924052;6198.039303907902;6199.845003874939;6273.560850740404;6299.8975179342515;6068.423499767515;6127.142200091902;6169.198004259418;6169.784057557964;6216.347283535164;5321.973390133025;6072.635641861502;6161.353057928853;6165.0444181152;6168.25980882297;5856.531477481876;5976.163337132892;6005.6396616203165;6005.879882402415;6135.6932153393045 08:42:14 INFO - PID 8739 | |1;ext.html;691.1809505735704;776.2509178642616;802.6227672993692;803.7066470738181;847.4322204123233;41076.79461602691;41385.79307103464;41601;41618.791906040504;41752.58247417525;38834.4174837377;39008.21983560327;39018.60981390185;39045;39293.214135717266;6898.689558969859;6972.337627925364;6975.372216500514;7019.964900175492;7030.121234845645;6868.965655171743;6924.549904256207;6933.0293758873795;6947.7220911163495;6969.19854216764;6962.965185174067;6964.094667693193;6979.09271794666;6996.230414654409;7002.194747604014;6899.206591242021;6954.478414118936;7001.579905205704;7006.948957656341;7012.228654847962;6362.872742545123;6364.172657554488;6382.936170638281;6392;6394.680265986682;33956.32087358239;34265.143371415914;34314;34345.48481772775;34626.48060279098;3318.8174650394217;3342.7660063795543;3355.882544110969;3410.4031794436123;3487.773294735834;32130.196745081324;32139;32221.6777832221;32268.35463290721;32359;4845.588125009378;4895.755212239374;4928.26076088586;4935.975320123376;4976.104301225778;183972;185448;185562;187322.06338968355;187824;44042;49489.75255123773;49937.75031124821;50265;50276.74861625741;51562.22656660153;51750;51762.741186293824;51839.48160518422;51865.74067129716;16119.355225790838;16236.1070141141;16261.349546018264;16289.104099274417;16299;13363.064585479118;13478.056536042383;13518.526851560346;13530.45878164882;13563.186208827501;13869.791953120712;14020.439182432792;14088.85911140896;14111.576652700436;14118.082324648865;5623.606347555632;5709.885802283931;5854.648721076749;5869.148973398918;5919.792807251725;952.8284908716497;993.4337427666305;1013.3919648211014;1019.108280254777;1028.8713910761155;22448;22539.211127610455;22610;22827.657585135905;22991.7700822993;1053.2311412668641;1083.1605505732962;1108.0969010256615;1114.8940850619178;1116.4919961417536;11849.94203941311;11963.58127465552;12088.456019479145;12098.516059357704;12279;225034;225556;226761;226842;227005;54162.729186354605;54633.1805022925;54643.180352294745;54718;54940.72529637406;1471.4408524760522;1474.0787008119926;1494.624945050556;1513.9015963962306;1516.8558986896228;21691.39741340959;21909;22306.661600304033;22420.32739017832;23103.19138830133;37638.2472350546;37672.43491347687;37747;37805.81097094497;37847.81076094712;190719;191230;195761;195954;196328;34768.30463390768;37369.25261494809;37433.25133497369;38976.80511597424;39146;46963.530364695915;48785;49027.264591031875;49402.505974941225;49716;32651.510227346134;34054.14864628305;34632.48051279182;34719.65280347265;35302.117447064025;33870.8306458476;34245.82877085599;34291.65708342884;34696;35061.47407788834;38679.80660096682;38751.03122421962;38920;38986.80506597449;39031;31580.526292105176;32425.675743242267;33191.83404082964;33650;33705.494417583264;23947;24158.63762043606;24180.87909560441;24255.75744242535;24499.877500612383 08:42:14 INFO - PID 8739 | |2;jquery.html;567.3277166557627;573.8594044459109;575.1774961804617;577.6072270855816;586.5131940489395;22716.54566908661;23650.64524032141;23678.881605591992;23715.644265336035;23744.40638984022;25237.62143567848;26133.738662613367;27333.726662733367;27369.315767105832;27807;6586.110875031869;6718.6304753238555;6730.629815360153;6763.763268285611;6769.864602707943;6599.9770035644315;6646.93353066468;6663.9333606663795;6670.099536562575;6672.733090676367;6027.698615069229;6340.23917129945;6558.049082882979;6598;6616.0406741022525;6526;6528.902066469007;6560.507961902877;6561.114249576318;6584.078229047937;6070.271567411939;6105.053716673922;6135.907961380538;6137.079438084278;6143.692815359214;28778.568321475195;29780;30177.849110754527;30247.546286805715;30424.84787576048;1941.5146213446637;1945.1733013469218;1965.8918759468224;1970.2808474906699;1974.812392822694;18723.812761872345;19058.714119288084;19236.519087022796;19242.90378548112;19318.32385866488;2294.2543673306077;2300.666403371502;2382.0114652419225;2396.916107936231;2405.8436201646837;140265.29867350598;143987;144748.2762586191;144797.2760136203;145236;14027.85972140286;14801;14883.255837208097;15267.312970916335;15914.52256432309;24392.26823195307;24426;24477.63283550748;24486.87756561206;24568.140115095885;9781.119699226962;10042.19662427004;10087.142592879687;10256.461530770295;10421.53103110362;9032.206473281107;9181.127792859668;9363.110504502061;9458.290628202913;9551.808963820684;8899.199072083544;9319.534023298807;9384.202342800801;9484.383515071637;9584.993575674593;2704.7971402144917;2705.891764329405;2789.972100278971;2871.7128287171536;2932.7213914678073;936.8969413364524;937.7468083617522;975.1662328708852;985.4924713772413;992.270681049428;19520.31678891232;20172.495687607632;20228.595428091357;20241.39275821698;20311.695324570144;1010.9494525273707;1025.7128004158847;1041.8228901086834;1049.2655141400896;1049.270756824;11060.446977651085;11208.27146235492;11267.32396056223;13034.80447793284;13922;498081;501637;507676;519151;519695;115933;116568;116592;117335.41332293455;120031;1239.3307613888398;1278.5844600504688;1285.7878450055823;1286.897048236139;1291.547958214636;20200.393988180378;20427.897860510602;20675.793242067386;20991.370258892257;21325;53736.462635373144;54768.904621908136;55929.161062584906;56005.719971399885;56473.43526564682;67819.66090169517;71350.28649713437;71678;72015.63992180006;72484.27515724776;14562.053466524641;14720.263986800832;15274.236288185324;15310.234488275764;15524.30140643651;23675.171369002;23715.64426533569;24127.63808542838;24317.51364972726;24537.877310613334;18547.165377557772;18803;18953.241870325033;19008.42974710761;19238.903805480884;14560.344784484936;14807.925960370128;15254.313555890234;15414.537563873102;15960.122193279482;19097.427077187705;19227.711584325967;19228.26945574905;19231.230750770374;19300.613987720448;15201.239938003277;15216.695666086838;15221.771673424686;15244.695106098037;15342.76985845191;17203.91398043052;18811;19042.33351832679;19055;19073.809261907205 08:42:14 INFO - PID 8739 | |3;mootools.html;1378.5312993582181;1396.0158088547569;1408.1269612840035;1421.4101148023572;1427.5003748687957;13460.59618211454;14058.64853378666;14067.08563943343;14090.154590724564;14102.36539355729;13520.661983450418;14012.089214201069;14028.368723407446;14077.014608977375;14105.153690778561;2595.3900833304206;2628.921132366032;2631.158029430583;2646.9205923822315;2670.4659068186343;2333.57995560799;2359.539889721505;2376.5246950609862;2380.1788383007834;2382.380581048931;2419.479811840463;2422.1643532981093;2437.366284765965;2471.02394554151;2476.5170791695627;2429.0283886445477;2443.596806526921;2445.6942882139733;2445.8532488050773;2446.694163229596;2352.1414683640346;2356.78788908999;2364.408897775556;2368.988155059231;2370.1585936992465;13180.86819131806;13459.865401346056;13480.05639605228;13490.93254533731;13491.797623035662;6772.796816095476;7074.6816393262425;7076.823079423004;7091.716331346792;7096.787096387065;4676.415448068991;4801.879953001168;4932.8273510427325;4933.235348520985;4933.80264789408;1821.6994195957652;1857.071464267866;1881.2851116575614;1892.706630472279;1919.9040047997544;20389.286374976804;20617.381478555668;20776;20882;21601.891990540105;5259.237410575445;5440.755166017539;6344.143540621957;6619.073329733841;6746.156730408699;17575.384861529787;18050;18105.275788968556;18123.54691132732;18221.817781822276;7258.056452661121;7475.401967842559;7515.286047825448;7545.962270188724;7557.962210188914;6684.966575167093;6714.328567143247;6765.05289259504;6788.796336109925;6838;5244.711540865213;5348.117560602457;5373.408925018245;5425.593080518976;5447.863803404867;1646.6130459342046;1706.6416052629088;1722.070082155622;1738.1483073294248;1744.825517448245;850.4727069217125;875.7416562114191;883.7127933421664;889.5018789477913;890.0876601483532;6953.443724502129;7052.294770522906;7055.400290975324;7123.572585644878;7197.244289349647;680.2007641021878;714.5676865496404;723.7430712097236;724.3480867219545;725.3109545931386;4282.6359759420175;4554.7039442436135;4859.975700121477;4883.804647814119;5166.638335316492;17992.730109048374;18575.53561160982;18686.906565467358;18725.157367918477;18822.623547528972;17264.74102888458;18382.448526544224;18452.169652365676;19217.32739354116;19410.22359105648;9722.173615242784;10304.742381440525;10486.00382963602;10571.36571805694;10690.198235132397;7673;8025.839483210187;8149.755507334789;8432.114627963976;8513.574321284035;15104.169270690218;15325.6168595786;15595;15905.125218113115;16026.11856347912;15276.388944442542;16415.83584164143;16565.58586035359;16771.077590732628;16924.66150676955;10836.13310935139;10972.890271097187;10975.231733778559;10981.450927453436;10993.065589424989;11686.18196726221;12065.517379304729;12142.392880356123;12217.083718720954;12295.69260768488;10075.949620251851;10257.538410771383;10347.94826025865;10660.040596346365;10670.146388288764;9540.809183816424;9857.852132217879;9953.203743700342;9974.002599739968;10144.188464922641;8720.127987201482;8913.732588022369;8917.643294268157;8919.241864441596;8993.640254390013;6730.427913627396;7043.436525078084;7095.503314767917;7187.412531488555;7192;7177.102862142232;7239.167495737847;7250.274972502708;7327.596982165819;7340.926590734024 08:42:14 INFO - PID 8739 | |4;prototype.html;483.3643758457628;500.9255147708166;515.3789683431465;516.6435159739777;528.8096285337278;6085.20892284003;6085.665288409135;6093.598472351351;6113.174721412608;6192.597481163722;5861.267341582302;5957.52339812815;5982.162497250389;6009.639421634705;6066.726997285122;4850.199717046692;4878;4885.6808661661335;4900.240462728265;4941.061198372297;4791.904161916777;4829.1307564638355;4853.830115945942;4889.633277504184;4898.232498638258;4846.418429788413;4862.6839255448285;4862.951370486286;4895.437024742165;4904.48502907195;4568.614130434787;4815.3258543803895;4826.565609095198;4880.243562247857;4891.217405215184;4305.677074219446;4314.697971142022;4325.632321252698;4355.455568053993;4386.627136693353;5788.450097240755;5836.88326233473;5851.76592936282;5885.588008839383;5918.8816223675285;5431.4840090191365;5507.366652834935;5561.4716601922755;5572.164175373686;5605.887882242332;6332.430081292659;6339.556231063827;6350.80947571569;6401.551891367606;6476;4780.976095119537;4783.832565860213;4798.136335459616;4817.277408388734;4825.710457372534;6640.80077597668;6717.63053032083;6719.529632925697;6821.99999999995;6833.897491537631;4948.208286674115;4974.751262436864;4980.492654148002;4994.575461085776;5027.824026159067;4929.211326187793;4967.230079337708;4995.725235112031;4997.3253610762085;5031.295618613397;5476.424975377608;5528.86177845549;5549.5837812164245;5562.833115006556;5572.749226284745;6379.681015949184;6407.551471397051;6467.676616169173;6472.514561407913;6502.512311576651;1737.4700716281402;1748.475457362786;1752.2728067851954;1760.3662681434673;1760.6830770461183;1118.4687273545;1202.290648517379;1211.2913945342073;1216.6191372791945;1218.1959906461693;5460;5591.832245032656;5647.745851436695;5653.293338332708;5671.412004638708;6482.35176482348;6550.148480697479;6555.704993275314;6556.934430655632;6581.14445122131;5641.633293835887;5693.089105743061;5699.629524080921;5719.656820590778;5719.742611582489;3425.195079156446;3425.783846734423;3496.423090190141;3500.562429696288;3509.3332266869215;6322.336154703782;6344.968275158594;6373.840653983688;6402;6493.51298652603;6611.371919667624;6691.297413771484;6768.5938843668555;6821.863562728718;6856.485763567753;6327.425004872232;6353.4599559038;6379.904301435482;6392.137061496732;6419.51853610981;6489.5781774184525;6547.738090476328;6555.508336874849;6592;6620.205575330991;6430.967845160744;6433.871322573429;6480.805575832733;6502.154719886574;6614.140161779131;6322.8735425290315;6377.904331434939;6380.585261957958;6384.17005789263;6420.967895160495;4827.758612069452;4827.806887724451;4847.321375007431;4889.753112956173;4891.119598472309;6495.967520162369;6584.901226481702;6608.570442921195;6634.601923884582;6679.131712877489;6345.587536810092;6349.428551430394;6375.936240637534;6381.361863813581;6390.64851433157;6399.168108145911;6405.295417503978;6415.358464153547;6420.935790642034;6450.322916041957;6294.622322660655;6319.431251187415;6364.586301890362;6369.267534233622;6417.454516366161;6289.584843410196;6377.7767778127545;6399.992003758226;6428.325025872216;6462;5823.592348535732;5837.6497410155525;5908.763649453974;6066.9696651518225;6188.226471691039 08:42:14 INFO - PID 8739 | |5;yui.html;879.5734068976548;880.3133555826454;890.35449299258;898.0390981649633;901.31950377465;17591;17700.114994250285;17729.55676108098;17952.461426157202;17994.460166195004;14991.850081499182;15364.61588460289;15398.538043858702;15426.074435533848;16225.513234602951;1019.8266294729896;1020.2501161646184;1022.7698767777265;1024.2778840917172;1025.021104844875;1040.5317607076809;1043.1967385113496;1047.3297089862494;1049.034887903131;1051.384939810212;1099.4008265495324;1101.3281898042187;1102.944852757363;1107.7507560798836;1113.6269349767797;1067.8505009298703;1072.8498010278568;1073.951672174754;1094.2395035450365;1094.2887123369794;786.0331791896;791.9010123734533;795.1928792275845;795.2286282306154;796.5419883566914;16977.83022169775;17163.91418042902;17202.1398930053;17234.052127133004;17240;18070.18684159216;19090.80909190918;19131.904340478348;19144.425667230007;19248.80751192498;15365.846341536666;16088.758668619863;16144.112073835935;16197.4330898418;16303.755443668237;3280.950785738216;3301.5212794144954;3301.8349082546015;3302.4881143422567;3305.1406634275263;105186;109062.45468772684;109571.45214273957;110072.4496377513;110732.4463377686;12878.549250776177;12981.286029268482;13001.349932503526;13026.088173827931;13192.868071319355;28092;28843.711562884102;29090;29447.85276073606;29509.26226844346;8032.839343213103;8261.504309741435;8494.575271236414;8534.573271336409;8586.22723954847;4082.4284600156;4178.206140833293;4189.958100419018;4207.915841683149;4212.052288235122;4833.73414462208;4842.733649649233;4878.829240976549;4924.72913989734;4954.47977962316;992.3450522655013;1001.3991605037065;1002.2032484174953;1005.0552480668294;1006.7281833904805;644.4135836388957;649.5777744466135;665.5308007854451;671.4896678524357;681.7954613615896;11614.477348519336;11629.24409913353;11839.704007399883;11856.347900865363;12545.811812822814;653.1117679955257;677.4478799778165;681.2438193605094;688.0711040095831;690.8860038093759;5163.789574576442;5291.788328466895;5343.893122137535;5355.437679043722;5378.408375078739;97153;104248;104509;106134.46932765287;111328.44335778432;91129;92025.53987230021;92631.53684231536;94665.52667236619;97204.51397742965;73675.26324736791;76540.61729691316;77314.22685773183;79243;83003.58498207471;10616.946915265375;10883.455827208449;10983.176261780558;11276.154288428237;11281.774364512828;34670;35172.29655406929;35563.64436355707;35805;37167.442488362154;45868.622286626836;46348.53651463442;47255.763721181174;47320.76339618418;48689.75655121702;15537.533873983799;15656.608584785472;15781.68436631238;15792.60518487047;15808.36766529372;17467.47597572075;17800.109994500483;17821.10894455298;17910.925344479372;18089.36687215941;15036;15106.697866042838;16110.919445403168;16163.75754363709;16199;16927.830721693117;17939;17996.64006719832;18025.188866500775;18248.817511824713;17010.957249898896;17743.20155593027;17977.370792022215;18017.909910450362;18282.542936426165;11919.702007449883;11927.10546708983;11985.760284794429;12145.271283723005;12158.75682486363;12303.507859685513;12379.257244565355;12396.566120185751;12400.441980110736;12419.130660853654 08:42:14 INFO - PID 8739 | __end_tp_report 08:42:14 INFO - PID 8739 | __start_cc_report 08:42:14 INFO - PID 8739 | _x_x_mozilla_cycle_collect,348 08:42:14 INFO - PID 8739 | __end_cc_report 08:42:14 INFO - PID 8739 | __startTimestamp1500219734262__endTimestamp 08:42:14 INFO - PID 8739 | 08:42:14 INFO - PID 8739 | ------- Summary: start ------- 08:42:14 INFO - PID 8739 | Number of tests: 6 08:42:14 INFO - PID 8739 | 08:42:14 INFO - PID 8739 | [#0] dojo.html Cycles:165 Average:5880.99 Median:6101.42 stddev:680.80 (11.2%) stddev-sans-first:644.50 08:42:14 INFO - PID 8739 | Values: 3007.6 3051.8 3060.9 3074.4 3094.4 5900.4 5955.5 5962.3 5974.8 5982.7 5933.8 5991.9 6085.4 6101.4 6112.5 5510.4 5587.6 5622.4 5651.9 5653.5 5544.7 5593.4 5620.1 5641.5 5653.0 5322.7 5404.9 5505.4 5575.0 5618.8 5457.3 5471.8 5512.1 5514.4 5534.5 5375.5 5437.1 5439.1 5443.9 5455.6 5886.4 5887.9 5889.8 5890.2 5913.0 6355.1 6365.3 6378.1 6392.1 6404.8 6412.7 6424.0 6444.4 6455.7 6470.8 5857.8 5949.3 5951.4 5996.4 6000.2 6517.0 6580.8 6588.6 6637.6 6673.7 6295.9 6299.1 6365.9 6387.6 6389.8 6322.2 6389.3 6405.2 6412.6 6416.6 6267.6 6301.7 6326.5 6361.8 6375.7 5340.9 6236.3 6409.5 6478.6 6513.9 5176.0 5238.8 5243.6 5247.2 5256.3 4409.8 4436.2 4499.0 4507.0 4522.0 5504.1 5521.1 5527.6 5533.8 5540.4 5267.4 6348.1 6375.9 6404.8 6463.9 5532.8 5538.3 5590.6 5609.6 5623.4 5630.2 5636.5 5656.5 5688.7 5702.5 6154.0 6223.9 6229.3 6241.0 6286.8 6373.6 6407.6 6408.7 6429.3 6447.5 6151.8 6207.1 6218.2 6227.3 6234.0 6276.1 6280.4 6285.0 6298.7 6314.6 6386.2 6392.4 6428.1 6468.7 6555.0 6227.9 6233.3 6234.7 6322.1 6342.5 6197.3 6198.0 6199.8 6273.6 6299.9 6068.4 6127.1 6169.2 6169.8 6216.3 5322.0 6072.6 6161.4 6165.0 6168.3 5856.5 5976.2 6005.6 6005.9 6135.7 08:42:14 INFO - PID 8739 | 08:42:14 INFO - PID 8739 | [#1] ext.html Cycles:180 Average:37521.20 Median:19128.04 stddev:52620.99 (275.1%) stddev-sans-first:52695.94 08:42:14 INFO - PID 8739 | Values: 691.2 776.3 802.6 803.7 847.4 41076.8 41385.8 41601.0 41618.8 41752.6 38834.4 39008.2 39018.6 39045.0 39293.2 6898.7 6972.3 6975.4 7020.0 7030.1 6869.0 6924.5 6933.0 6947.7 6969.2 6963.0 6964.1 6979.1 6996.2 7002.2 6899.2 6954.5 7001.6 7006.9 7012.2 6362.9 6364.2 6382.9 6392.0 6394.7 33956.3 34265.1 34314.0 34345.5 34626.5 3318.8 3342.8 3355.9 3410.4 3487.8 32130.2 32139.0 32221.7 32268.4 32359.0 4845.6 4895.8 4928.3 4936.0 4976.1 183972.0 185448.0 185562.0 187322.1 187824.0 44042.0 49489.8 49937.8 50265.0 50276.7 51562.2 51750.0 51762.7 51839.5 51865.7 16119.4 16236.1 16261.3 16289.1 16299.0 13363.1 13478.1 13518.5 13530.5 13563.2 13869.8 14020.4 14088.9 14111.6 14118.1 5623.6 5709.9 5854.6 5869.1 5919.8 952.8 993.4 1013.4 1019.1 1028.9 22448.0 22539.2 22610.0 22827.7 22991.8 1053.2 1083.2 1108.1 1114.9 1116.5 11849.9 11963.6 12088.5 12098.5 12279.0 225034.0 225556.0 226761.0 226842.0 227005.0 54162.7 54633.2 54643.2 54718.0 54940.7 1471.4 1474.1 1494.6 1513.9 1516.9 21691.4 21909.0 22306.7 22420.3 23103.2 37638.2 37672.4 37747.0 37805.8 37847.8 190719.0 191230.0 195761.0 195954.0 196328.0 34768.3 37369.3 37433.3 38976.8 39146.0 46963.5 48785.0 49027.3 49402.5 49716.0 32651.5 34054.1 34632.5 34719.7 35302.1 33870.8 34245.8 34291.7 34696.0 35061.5 38679.8 38751.0 38920.0 38986.8 39031.0 31580.5 32425.7 33191.8 33650.0 33705.5 23947.0 24158.6 24180.9 24255.8 24499.9 08:42:14 INFO - PID 8739 | 08:42:14 INFO - PID 8739 | [#2] jquery.html Cycles:180 Average:35750.15 Median:23715.64 stddev:85736.16 (361.5%) stddev-sans-first:85935.98 08:42:14 INFO - PID 8739 | Values: 567.3 573.9 575.2 577.6 586.5 22716.5 23650.6 23678.9 23715.6 23744.4 25237.6 26133.7 27333.7 27369.3 27807.0 6586.1 6718.6 6730.6 6763.8 6769.9 6600.0 6646.9 6663.9 6670.1 6672.7 6027.7 6340.2 6558.0 6598.0 6616.0 6526.0 6528.9 6560.5 6561.1 6584.1 6070.3 6105.1 6135.9 6137.1 6143.7 28778.6 29780.0 30177.8 30247.5 30424.8 1941.5 1945.2 1965.9 1970.3 1974.8 18723.8 19058.7 19236.5 19242.9 19318.3 2294.3 2300.7 2382.0 2396.9 2405.8 140265.3 143987.0 144748.3 144797.3 145236.0 14027.9 14801.0 14883.3 15267.3 15914.5 24392.3 24426.0 24477.6 24486.9 24568.1 9781.1 10042.2 10087.1 10256.5 10421.5 9032.2 9181.1 9363.1 9458.3 9551.8 8899.2 9319.5 9384.2 9484.4 9585.0 2704.8 2705.9 2790.0 2871.7 2932.7 936.9 937.7 975.2 985.5 992.3 19520.3 20172.5 20228.6 20241.4 20311.7 1010.9 1025.7 1041.8 1049.3 1049.3 11060.4 11208.3 11267.3 13034.8 13922.0 498081.0 501637.0 507676.0 519151.0 519695.0 115933.0 116568.0 116592.0 117335.4 120031.0 1239.3 1278.6 1285.8 1286.9 1291.5 20200.4 20427.9 20675.8 20991.4 21325.0 53736.5 54768.9 55929.2 56005.7 56473.4 67819.7 71350.3 71678.0 72015.6 72484.3 14562.1 14720.3 15274.2 15310.2 15524.3 23675.2 23715.6 24127.6 24317.5 24537.9 18547.2 18803.0 18953.2 19008.4 19238.9 14560.3 14807.9 15254.3 15414.5 15960.1 19097.4 19227.7 19228.3 19231.2 19300.6 15201.2 15216.7 15221.8 15244.7 15342.8 17203.9 18811.0 19042.3 19055.0 19073.8 08:42:14 INFO - PID 8739 | 08:42:14 INFO - PID 8739 | [#3] mootools.html Cycles:180 Average:8404.23 Median:2420.82 stddev:5713.47 (236.0%) stddev-sans-first:5705.11 08:42:14 INFO - PID 8739 | Values: 1378.5 1396.0 1408.1 1421.4 1427.5 13460.6 14058.6 14067.1 14090.2 14102.4 13520.7 14012.1 14028.4 14077.0 14105.2 2595.4 2628.9 2631.2 2646.9 2670.5 2333.6 2359.5 2376.5 2380.2 2382.4 2419.5 2422.2 2437.4 2471.0 2476.5 2429.0 2443.6 2445.7 2445.9 2446.7 2352.1 2356.8 2364.4 2369.0 2370.2 13180.9 13459.9 13480.1 13490.9 13491.8 6772.8 7074.7 7076.8 7091.7 7096.8 4676.4 4801.9 4932.8 4933.2 4933.8 1821.7 1857.1 1881.3 1892.7 1919.9 20389.3 20617.4 20776.0 20882.0 21601.9 5259.2 5440.8 6344.1 6619.1 6746.2 17575.4 18050.0 18105.3 18123.5 18221.8 7258.1 7475.4 7515.3 7546.0 7558.0 6685.0 6714.3 6765.1 6788.8 6838.0 5244.7 5348.1 5373.4 5425.6 5447.9 1646.6 1706.6 1722.1 1738.1 1744.8 850.5 875.7 883.7 889.5 890.1 6953.4 7052.3 7055.4 7123.6 7197.2 680.2 714.6 723.7 724.3 725.3 4282.6 4554.7 4860.0 4883.8 5166.6 17992.7 18575.5 18686.9 18725.2 18822.6 17264.7 18382.4 18452.2 19217.3 19410.2 9722.2 10304.7 10486.0 10571.4 10690.2 7673.0 8025.8 8149.8 8432.1 8513.6 15104.2 15325.6 15595.0 15905.1 16026.1 15276.4 16415.8 16565.6 16771.1 16924.7 10836.1 10972.9 10975.2 10981.5 10993.1 11686.2 12065.5 12142.4 12217.1 12295.7 10075.9 10257.5 10347.9 10660.0 10670.1 9540.8 9857.9 9953.2 9974.0 10144.2 8720.1 8913.7 8917.6 8919.2 8993.6 6730.4 7043.4 7095.5 7187.4 7192.0 7177.1 7239.2 7250.3 7327.6 7340.9 08:42:14 INFO - PID 8739 | 08:42:14 INFO - PID 8739 | [#4] prototype.html Cycles:180 Average:5382.83 Median:5873.43 stddev:1507.26 (25.7%) stddev-sans-first:1465.94 08:42:14 INFO - PID 8739 | Values: 483.4 500.9 515.4 516.6 528.8 6085.2 6085.7 6093.6 6113.2 6192.6 5861.3 5957.5 5982.2 6009.6 6066.7 4850.2 4878.0 4885.7 4900.2 4941.1 4791.9 4829.1 4853.8 4889.6 4898.2 4846.4 4862.7 4863.0 4895.4 4904.5 4568.6 4815.3 4826.6 4880.2 4891.2 4305.7 4314.7 4325.6 4355.5 4386.6 5788.5 5836.9 5851.8 5885.6 5918.9 5431.5 5507.4 5561.5 5572.2 5605.9 6332.4 6339.6 6350.8 6401.6 6476.0 4781.0 4783.8 4798.1 4817.3 4825.7 6640.8 6717.6 6719.5 6822.0 6833.9 4948.2 4974.8 4980.5 4994.6 5027.8 4929.2 4967.2 4995.7 4997.3 5031.3 5476.4 5528.9 5549.6 5562.8 5572.7 6379.7 6407.6 6467.7 6472.5 6502.5 1737.5 1748.5 1752.3 1760.4 1760.7 1118.5 1202.3 1211.3 1216.6 1218.2 5460.0 5591.8 5647.7 5653.3 5671.4 6482.4 6550.1 6555.7 6556.9 6581.1 5641.6 5693.1 5699.6 5719.7 5719.7 3425.2 3425.8 3496.4 3500.6 3509.3 6322.3 6345.0 6373.8 6402.0 6493.5 6611.4 6691.3 6768.6 6821.9 6856.5 6327.4 6353.5 6379.9 6392.1 6419.5 6489.6 6547.7 6555.5 6592.0 6620.2 6431.0 6433.9 6480.8 6502.2 6614.1 6322.9 6377.9 6380.6 6384.2 6421.0 4827.8 4827.8 4847.3 4889.8 4891.1 6496.0 6584.9 6608.6 6634.6 6679.1 6345.6 6349.4 6375.9 6381.4 6390.6 6399.2 6405.3 6415.4 6420.9 6450.3 6294.6 6319.4 6364.6 6369.3 6417.5 6289.6 6377.8 6400.0 6428.3 6462.0 5823.6 5837.6 5908.8 6067.0 6188.2 08:42:14 INFO - PID 8739 | 08:42:14 INFO - PID 8739 | [#5] yui.html Cycles:180 Average:21161.03 Median:17810.61 stddev:28803.47 (161.7%) stddev-sans-first:28844.01 08:42:14 INFO - PID 8739 | Values: 879.6 880.3 890.4 898.0 901.3 17591.0 17700.1 17729.6 17952.5 17994.5 14991.9 15364.6 15398.5 15426.1 16225.5 1019.8 1020.3 1022.8 1024.3 1025.0 1040.5 1043.2 1047.3 1049.0 1051.4 1099.4 1101.3 1102.9 1107.8 1113.6 1067.9 1072.8 1074.0 1094.2 1094.3 786.0 791.9 795.2 795.2 796.5 16977.8 17163.9 17202.1 17234.1 17240.0 18070.2 19090.8 19131.9 19144.4 19248.8 15365.8 16088.8 16144.1 16197.4 16303.8 3281.0 3301.5 3301.8 3302.5 3305.1 105186.0 109062.5 109571.5 110072.4 110732.4 12878.5 12981.3 13001.3 13026.1 13192.9 28092.0 28843.7 29090.0 29447.9 29509.3 8032.8 8261.5 8494.6 8534.6 8586.2 4082.4 4178.2 4190.0 4207.9 4212.1 4833.7 4842.7 4878.8 4924.7 4954.5 992.3 1001.4 1002.2 1005.1 1006.7 644.4 649.6 665.5 671.5 681.8 11614.5 11629.2 11839.7 11856.3 12545.8 653.1 677.4 681.2 688.1 690.9 5163.8 5291.8 5343.9 5355.4 5378.4 97153.0 104248.0 104509.0 106134.5 111328.4 91129.0 92025.5 92631.5 94665.5 97204.5 73675.3 76540.6 77314.2 79243.0 83003.6 10616.9 10883.5 10983.2 11276.2 11281.8 34670.0 35172.3 35563.6 35805.0 37167.4 45868.6 46348.5 47255.8 47320.8 48689.8 15537.5 15656.6 15781.7 15792.6 15808.4 17467.5 17800.1 17821.1 17910.9 18089.4 15036.0 15106.7 16110.9 16163.8 16199.0 16927.8 17939.0 17996.6 18025.2 18248.8 17011.0 17743.2 17977.4 18017.9 18282.5 11919.7 11927.1 11985.8 12145.3 12158.8 12303.5 12379.3 12396.6 12400.4 12419.1 08:42:14 INFO - PID 8739 | -------- Summary: end -------- 08:42:14 INFO - PID 8739 | 08:42:14 INFO - TEST-INFO | 8739: exit 0 08:42:14 INFO - TEST-OK | dromaeo_css | took 1111080ms 08:42:14 INFO - TEST-START | kraken 08:42:14 INFO - Initialising browser for kraken test... 08:42:14 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:48690/getInfo.html -profile /tmp/tmpleLkZi/profile 08:42:14 INFO - TEST-INFO | started process 9159 (/builds/slave/test/build/application/firefox/firefox http://localhost:48690/getInfo.html) 08:42:20 INFO - TEST-INFO | 9159: exit 0 08:42:20 INFO - Browser initialized. 08:42:20 INFO - Running cycle 1/1 for kraken test... 08:42:20 INFO - TEST-INFO | started process 9384 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpleLkZi/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 08:42:32 INFO - PID 9384 | RSS: Main: 170082304 08:42:32 INFO - PID 9384 | 08:42:34 INFO - PID 9384 | Cycle 1(1): loaded http://localhost:48690/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:48690/tests/kraken/driver.html?testName=audio-beat-detection) 08:42:35 INFO - PID 9384 | RSS: Main: 176209920 08:42:35 INFO - PID 9384 | 08:42:38 INFO - PID 9384 | Cycle 1(1): loaded http://localhost:48690/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:48690/tests/kraken/driver.html?testName=audio-dft) 08:42:38 INFO - PID 9384 | RSS: Main: 175910912 08:42:38 INFO - PID 9384 | 08:42:41 INFO - PID 9384 | Cycle 1(1): loaded http://localhost:48690/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:48690/tests/kraken/driver.html?testName=audio-fft) 08:42:42 INFO - PID 9384 | RSS: Main: 170274816 08:42:42 INFO - PID 9384 | 08:42:44 INFO - PID 9384 | Cycle 1(1): loaded http://localhost:48690/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:48690/tests/kraken/driver.html?testName=audio-oscillator) 08:42:45 INFO - PID 9384 | RSS: Main: 171315200 08:42:45 INFO - PID 9384 | 08:42:47 INFO - PID 9384 | Cycle 1(1): loaded http://localhost:48690/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:48690/tests/kraken/driver.html?testName=imaging-gaussian-blur) 08:42:47 INFO - PID 9384 | RSS: Main: 172376064 08:42:47 INFO - PID 9384 | 08:42:50 INFO - PID 9384 | Cycle 1(1): loaded http://localhost:48690/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:48690/tests/kraken/driver.html?testName=imaging-darkroom) 08:42:51 INFO - PID 9384 | RSS: Main: 175878144 08:42:51 INFO - PID 9384 | 08:42:54 INFO - PID 9384 | Cycle 1(1): loaded http://localhost:48690/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:48690/tests/kraken/driver.html?testName=imaging-desaturate) 08:42:55 INFO - PID 9384 | RSS: Main: 176365568 08:42:55 INFO - PID 9384 | 08:42:58 INFO - PID 9384 | Cycle 1(1): loaded http://localhost:48690/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:48690/tests/kraken/driver.html?testName=json-parse-financial) 08:42:59 INFO - PID 9384 | RSS: Main: 175431680 08:42:59 INFO - PID 9384 | 08:43:00 INFO - PID 9384 | Cycle 1(1): loaded http://localhost:48690/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:48690/tests/kraken/driver.html?testName=json-stringify-tinderbox) 08:43:01 INFO - PID 9384 | RSS: Main: 174981120 08:43:01 INFO - PID 9384 | 08:43:02 INFO - PID 9384 | Cycle 1(1): loaded http://localhost:48690/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:48690/tests/kraken/driver.html?testName=stanford-crypto-aes) 08:43:03 INFO - PID 9384 | RSS: Main: 175562752 08:43:03 INFO - PID 9384 | 08:43:05 INFO - PID 9384 | Cycle 1(1): loaded http://localhost:48690/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:48690/tests/kraken/driver.html?testName=stanford-crypto-ccm) 08:43:06 INFO - PID 9384 | RSS: Main: 175132672 08:43:06 INFO - PID 9384 | 08:43:08 INFO - PID 9384 | Cycle 1(1): loaded http://localhost:48690/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:48690/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 08:43:09 INFO - PID 9384 | RSS: Main: 175112192 08:43:09 INFO - PID 9384 | 08:43:12 INFO - PID 9384 | Cycle 1(1): loaded http://localhost:48690/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:48690/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 08:43:13 INFO - PID 9384 | RSS: Main: 175497216 08:43:13 INFO - PID 9384 | 08:43:15 INFO - PID 9384 | Cycle 1(1): loaded http://localhost:48690/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:48690/tests/kraken/driver.html?testName=ai-astar) 08:43:15 INFO - PID 9384 | RSS: Main: 177373184 08:43:15 INFO - PID 9384 | 08:43:15 INFO - PID 9384 | __start_tp_report 08:43:15 INFO - PID 9384 | _x_x_mozilla_page_load 08:43:15 INFO - PID 9384 | _x_x_mozilla_page_load_details 08:43:15 INFO - PID 9384 | |i|pagename|runs| 08:43:15 INFO - PID 9384 | |0;ai-astar;101;108;108;106;109;109;108;109;108;109 08:43:15 INFO - PID 9384 | |1;audio-beat-detection;154;125;153;186;125;146;154;130;170;123 08:43:15 INFO - PID 9384 | |2;audio-dft;165;162;161;163;163;171;163;166;171;165 08:43:15 INFO - PID 9384 | |3;audio-fft;74;77;74;157;76;78;76;78;95;74 08:43:15 INFO - PID 9384 | |4;audio-oscillator;83;82;146;81;80;82;135;83;81;131 08:43:15 INFO - PID 9384 | |5;imaging-gaussian-blur;114;113;113;114;114;113;114;113;113;113 08:43:15 INFO - PID 9384 | |6;imaging-darkroom;151;152;151;150;151;150;151;150;149;149 08:43:15 INFO - PID 9384 | |7;imaging-desaturate;94;95;94;94;94;94;95;94;94;95 08:43:15 INFO - PID 9384 | |8;json-parse-financial;58;57;56;54;55;56;58;54;56;54 08:43:15 INFO - PID 9384 | |9;json-stringify-tinderbox;54;54;55;54;54;54;54;55;54;54 08:43:15 INFO - PID 9384 | |10;stanford-crypto-aes;77;78;78;79;77;77;76;76;76;77 08:43:15 INFO - PID 9384 | |11;stanford-crypto-ccm;133;128;128;129;126;128;127;123;133;160 08:43:15 INFO - PID 9384 | |12;stanford-crypto-pbkdf2;190;180;188;178;188;188;179;193;189;182 08:43:15 INFO - PID 9384 | |13;stanford-crypto-sha256-iterative;68;72;71;68;70;67;67;69;69;68 08:43:15 INFO - PID 9384 | __end_tp_report 08:43:15 INFO - PID 9384 | __start_cc_report 08:43:15 INFO - PID 9384 | _x_x_mozilla_cycle_collect,928 08:43:15 INFO - PID 9384 | __end_cc_report 08:43:15 INFO - PID 9384 | __startTimestamp1500219795347__endTimestamp 08:43:15 INFO - PID 9384 | 08:43:15 INFO - PID 9384 | ------- Summary: start ------- 08:43:15 INFO - PID 9384 | Number of tests: 14 08:43:15 INFO - PID 9384 | 08:43:15 INFO - PID 9384 | [#0] ai-astar Cycles:10 Average:107.50 Median:108.50 stddev:2.46 (2.3%) stddev-sans-first:0.97 08:43:15 INFO - PID 9384 | Values: 101.0 108.0 108.0 106.0 109.0 109.0 108.0 109.0 108.0 109.0 08:43:15 INFO - PID 9384 | 08:43:15 INFO - PID 9384 | [#1] audio-beat-detection Cycles:10 Average:146.60 Median:153.50 stddev:21.13 (13.8%) stddev-sans-first:22.24 08:43:15 INFO - PID 9384 | Values: 154.0 125.0 153.0 186.0 125.0 146.0 154.0 130.0 170.0 123.0 08:43:15 INFO - PID 9384 | 08:43:15 INFO - PID 9384 | [#2] audio-dft Cycles:10 Average:165.00 Median:165.00 stddev:3.50 (2.1%) stddev-sans-first:3.71 08:43:15 INFO - PID 9384 | Values: 165.0 162.0 161.0 163.0 163.0 171.0 163.0 166.0 171.0 165.0 08:43:15 INFO - PID 9384 | 08:43:15 INFO - PID 9384 | [#3] audio-fft Cycles:10 Average:85.90 Median:76.50 stddev:25.74 (33.6%) stddev-sans-first:26.94 08:43:15 INFO - PID 9384 | Values: 74.0 77.0 74.0 157.0 76.0 78.0 76.0 78.0 95.0 74.0 08:43:15 INFO - PID 9384 | 08:43:15 INFO - PID 9384 | [#4] audio-oscillator Cycles:10 Average:98.40 Median:81.50 stddev:27.13 (33.3%) stddev-sans-first:28.20 08:43:15 INFO - PID 9384 | Values: 83.0 82.0 146.0 81.0 80.0 82.0 135.0 83.0 81.0 131.0 08:43:15 INFO - PID 9384 | 08:43:15 INFO - PID 9384 | [#5] imaging-gaussian-blur Cycles:10 Average:113.40 Median:113.50 stddev:0.52 (0.5%) stddev-sans-first:0.50 08:43:15 INFO - PID 9384 | Values: 114.0 113.0 113.0 114.0 114.0 113.0 114.0 113.0 113.0 113.0 08:43:15 INFO - PID 9384 | 08:43:15 INFO - PID 9384 | [#6] imaging-darkroom Cycles:10 Average:150.40 Median:151.00 stddev:0.97 (0.6%) stddev-sans-first:1.00 08:43:15 INFO - PID 9384 | Values: 151.0 152.0 151.0 150.0 151.0 150.0 151.0 150.0 149.0 149.0 08:43:15 INFO - PID 9384 | 08:43:15 INFO - PID 9384 | [#7] imaging-desaturate Cycles:10 Average:94.30 Median:94.00 stddev:0.48 (0.5%) stddev-sans-first:0.50 08:43:15 INFO - PID 9384 | Values: 94.0 95.0 94.0 94.0 94.0 94.0 95.0 94.0 94.0 95.0 08:43:15 INFO - PID 9384 | 08:43:15 INFO - PID 9384 | [#8] json-parse-financial Cycles:10 Average:55.80 Median:56.00 stddev:1.55 (2.8%) stddev-sans-first:1.42 08:43:15 INFO - PID 9384 | Values: 58.0 57.0 56.0 54.0 55.0 56.0 58.0 54.0 56.0 54.0 08:43:15 INFO - PID 9384 | 08:43:15 INFO - PID 9384 | [#9] json-stringify-tinderbox Cycles:10 Average:54.20 Median:54.00 stddev:0.42 (0.8%) stddev-sans-first:0.44 08:43:15 INFO - PID 9384 | Values: 54.0 54.0 55.0 54.0 54.0 54.0 54.0 55.0 54.0 54.0 08:43:15 INFO - PID 9384 | 08:43:15 INFO - PID 9384 | [#10] stanford-crypto-aes Cycles:10 Average:77.10 Median:77.00 stddev:0.99 (1.3%) stddev-sans-first:1.05 08:43:15 INFO - PID 9384 | Values: 77.0 78.0 78.0 79.0 77.0 77.0 76.0 76.0 76.0 77.0 08:43:15 INFO - PID 9384 | 08:43:15 INFO - PID 9384 | [#11] stanford-crypto-ccm Cycles:10 Average:131.50 Median:128.50 stddev:10.45 (8.1%) stddev-sans-first:11.07 08:43:15 INFO - PID 9384 | Values: 133.0 128.0 128.0 129.0 126.0 128.0 127.0 123.0 133.0 160.0 08:43:15 INFO - PID 9384 | 08:43:15 INFO - PID 9384 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:185.50 Median:188.00 stddev:5.25 (2.8%) stddev-sans-first:5.32 08:43:15 INFO - PID 9384 | Values: 190.0 180.0 188.0 178.0 188.0 188.0 179.0 193.0 189.0 182.0 08:43:15 INFO - PID 9384 | 08:43:15 INFO - PID 9384 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.90 Median:69.00 stddev:1.66 (2.4%) stddev-sans-first:1.73 08:43:15 INFO - PID 9384 | Values: 68.0 72.0 71.0 68.0 70.0 67.0 67.0 69.0 69.0 68.0 08:43:15 INFO - PID 9384 | -------- Summary: end -------- 08:43:15 INFO - PID 9384 | 08:43:15 INFO - PID 9384 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 08:43:16 INFO - TEST-INFO | 9384: exit 0 08:43:16 INFO - TEST-OK | kraken | took 61221ms 08:43:16 INFO - SUITE-END | took 1172s 08:43:16 INFO - Completed test suite (00:19:32) 08:43:16 INFO - javascript benchmark 08:43:16 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8221.271986582133, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3007.609010828595, 3051.7558595312375, 3060.877564897404, 3074.431230222409, 3094.39659266443, 5900.409959004098, 5955.464008239263, 5962.314333851608, 5974.761009559618, 5982.670953097589, 5933.762649494015, 5991.880162396749, 6085.361037091108, 6101.420365065312, 6112.510999120071, 5510.366307874586, 5587.636803607773, 5622.409646987069, 5651.943480565183, 5653.4911857932775, 5544.667319960815, 5593.412691667378, 5620.100783874581, 5641.548676105922, 5653.0, 5322.65402748822, 5404.864878378033, 5505.366882808468, 5575.024370735126, 5618.775248990056, 5457.345118585795, 5471.781128754885, 5512.118061110244, 5514.420985796473, 5534.4742249486235, 5375.543078838304, 5437.13005919055, 5439.129739241703, 5443.918341224885, 5455.563554915637, 5886.352501224862, 5887.941120588782, 5889.79385721502, 5890.2342695449315, 5913.0, 6355.142055822451, 6365.267994180682, 6378.138951241569, 6392.073149393358, 6404.807855764335, 6412.679366031726, 6423.96788016057, 6444.387783160592, 6455.741770329181, 6470.838229044264, 5857.76568937242, 5949.25634295713, 5951.434613711691, 5996.430339117776, 6000.159977603095, 6517.0, 6580.76967306142, 6588.604683718992, 6637.568558043712, 6673.666316684146, 6295.874082518324, 6299.055141728686, 6365.904511432333, 6387.584806987531, 6389.7763578274535, 6322.178116844781, 6389.2652344980925, 6405.19935008124, 6412.615243085336, 6416.582922110048, 6267.633918610039, 6301.653409062454, 6326.49388048955, 6361.840953976188, 6375.71309291083, 5340.866478338073, 6236.314005459396, 6409.455196308366, 6478.611283323015, 6513.869722605521, 5176.0, 5238.842834714965, 5243.580513558906, 5247.2129180623215, 5256.2904007959205, 4409.845655402046, 4436.179306828247, 4499.032707967803, 4506.954930450719, 4522.0277640307495, 5504.119340905436, 5521.116621340566, 5527.613067085346, 5533.750981205775, 5540.418256083134, 5267.420583735786, 6348.111264422984, 6375.936240637627, 6404.775832845828, 6463.935360646427, 5532.7786888524815, 5538.252335934678, 5590.608657393944, 5609.5792815539, 5623.381428042912, 5630.155476678449, 5636.464535869086, 5656.519195868397, 5688.744006519716, 5702.45826646468, 6153.96923015391, 6223.937760622336, 6229.345918678564, 6241.032639940817, 6286.811395658137, 6373.649449280334, 6407.583507072025, 6408.743650253938, 6429.260635027032, 6447.484201263981, 6151.815445536641, 6207.131001659862, 6218.19163508741, 6227.346128656607, 6233.96883015582, 6276.1213430118905, 6280.403361680633, 6284.962981108066, 6298.71655775482, 6314.62112273265, 6386.233651961795, 6392.3927226913365, 6428.100065990671, 6468.741250349934, 6554.951207806728, 6227.875442491216, 6233.283172435046, 6234.688265586793, 6322.114903913363, 6342.524310676626, 6197.25632924052, 6198.039303907902, 6199.845003874939, 6273.560850740404, 6299.8975179342515, 6068.423499767515, 6127.142200091902, 6169.198004259418, 6169.784057557964, 6216.347283535164, 5321.973390133025, 6072.635641861502, 6161.353057928853, 6165.0444181152, 6168.25980882297, 5856.531477481876, 5976.163337132892, 6005.6396616203165, 6005.879882402415, 6135.6932153393045], "value": 5832.300038690232, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [691.1809505735704, 776.2509178642616, 802.6227672993692, 803.7066470738181, 847.4322204123233, 41076.79461602691, 41385.79307103464, 41601.0, 41618.791906040504, 41752.58247417525, 38834.4174837377, 39008.21983560327, 39018.60981390185, 39045.0, 39293.214135717266, 6898.689558969859, 6972.337627925364, 6975.372216500514, 7019.964900175492, 7030.121234845645, 6868.965655171743, 6924.549904256207, 6933.0293758873795, 6947.7220911163495, 6969.19854216764, 6962.965185174067, 6964.094667693193, 6979.09271794666, 6996.230414654409, 7002.194747604014, 6899.206591242021, 6954.478414118936, 7001.579905205704, 7006.948957656341, 7012.228654847962, 6362.872742545123, 6364.172657554488, 6382.936170638281, 6392.0, 6394.680265986682, 33956.32087358239, 34265.143371415914, 34314.0, 34345.48481772775, 34626.48060279098, 3318.8174650394217, 3342.7660063795543, 3355.882544110969, 3410.4031794436123, 3487.773294735834, 32130.196745081324, 32139.0, 32221.6777832221, 32268.35463290721, 32359.0, 4845.588125009378, 4895.755212239374, 4928.26076088586, 4935.975320123376, 4976.104301225778, 183972.0, 185448.0, 185562.0, 187322.06338968355, 187824.0, 44042.0, 49489.75255123773, 49937.75031124821, 50265.0, 50276.74861625741, 51562.22656660153, 51750.0, 51762.741186293824, 51839.48160518422, 51865.74067129716, 16119.355225790838, 16236.1070141141, 16261.349546018264, 16289.104099274417, 16299.0, 13363.064585479118, 13478.056536042383, 13518.526851560346, 13530.45878164882, 13563.186208827501, 13869.791953120712, 14020.439182432792, 14088.85911140896, 14111.576652700436, 14118.082324648865, 5623.606347555632, 5709.885802283931, 5854.648721076749, 5869.148973398918, 5919.792807251725, 952.8284908716497, 993.4337427666305, 1013.3919648211014, 1019.108280254777, 1028.8713910761155, 22448.0, 22539.211127610455, 22610.0, 22827.657585135905, 22991.7700822993, 1053.2311412668641, 1083.1605505732962, 1108.0969010256615, 1114.8940850619178, 1116.4919961417536, 11849.94203941311, 11963.58127465552, 12088.456019479145, 12098.516059357704, 12279.0, 225034.0, 225556.0, 226761.0, 226842.0, 227005.0, 54162.729186354605, 54633.1805022925, 54643.180352294745, 54718.0, 54940.72529637406, 1471.4408524760522, 1474.0787008119926, 1494.624945050556, 1513.9015963962306, 1516.8558986896228, 21691.39741340959, 21909.0, 22306.661600304033, 22420.32739017832, 23103.19138830133, 37638.2472350546, 37672.43491347687, 37747.0, 37805.81097094497, 37847.81076094712, 190719.0, 191230.0, 195761.0, 195954.0, 196328.0, 34768.30463390768, 37369.25261494809, 37433.25133497369, 38976.80511597424, 39146.0, 46963.530364695915, 48785.0, 49027.264591031875, 49402.505974941225, 49716.0, 32651.510227346134, 34054.14864628305, 34632.48051279182, 34719.65280347265, 35302.117447064025, 33870.8306458476, 34245.82877085599, 34291.65708342884, 34696.0, 35061.47407788834, 38679.80660096682, 38751.03122421962, 38920.0, 38986.80506597449, 39031.0, 31580.526292105176, 32425.675743242267, 33191.83404082964, 33650.0, 33705.494417583264, 23947.0, 24158.63762043606, 24180.87909560441, 24255.75744242535, 24499.877500612383], "value": 16951.45736553974, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [567.3277166557627, 573.8594044459109, 575.1774961804617, 577.6072270855816, 586.5131940489395, 22716.54566908661, 23650.64524032141, 23678.881605591992, 23715.644265336035, 23744.40638984022, 25237.62143567848, 26133.738662613367, 27333.726662733367, 27369.315767105832, 27807.0, 6586.110875031869, 6718.6304753238555, 6730.629815360153, 6763.763268285611, 6769.864602707943, 6599.9770035644315, 6646.93353066468, 6663.9333606663795, 6670.099536562575, 6672.733090676367, 6027.698615069229, 6340.23917129945, 6558.049082882979, 6598.0, 6616.0406741022525, 6526.0, 6528.902066469007, 6560.507961902877, 6561.114249576318, 6584.078229047937, 6070.271567411939, 6105.053716673922, 6135.907961380538, 6137.079438084278, 6143.692815359214, 28778.568321475195, 29780.0, 30177.849110754527, 30247.546286805715, 30424.84787576048, 1941.5146213446637, 1945.1733013469218, 1965.8918759468224, 1970.2808474906699, 1974.812392822694, 18723.812761872345, 19058.714119288084, 19236.519087022796, 19242.90378548112, 19318.32385866488, 2294.2543673306077, 2300.666403371502, 2382.0114652419225, 2396.916107936231, 2405.8436201646837, 140265.29867350598, 143987.0, 144748.2762586191, 144797.2760136203, 145236.0, 14027.85972140286, 14801.0, 14883.255837208097, 15267.312970916335, 15914.52256432309, 24392.26823195307, 24426.0, 24477.63283550748, 24486.87756561206, 24568.140115095885, 9781.119699226962, 10042.19662427004, 10087.142592879687, 10256.461530770295, 10421.53103110362, 9032.206473281107, 9181.127792859668, 9363.110504502061, 9458.290628202913, 9551.808963820684, 8899.199072083544, 9319.534023298807, 9384.202342800801, 9484.383515071637, 9584.993575674593, 2704.7971402144917, 2705.891764329405, 2789.972100278971, 2871.7128287171536, 2932.7213914678073, 936.8969413364524, 937.7468083617522, 975.1662328708852, 985.4924713772413, 992.270681049428, 19520.31678891232, 20172.495687607632, 20228.595428091357, 20241.39275821698, 20311.695324570144, 1010.9494525273707, 1025.7128004158847, 1041.8228901086834, 1049.2655141400896, 1049.270756824, 11060.446977651085, 11208.27146235492, 11267.32396056223, 13034.80447793284, 13922.0, 498081.0, 501637.0, 507676.0, 519151.0, 519695.0, 115933.0, 116568.0, 116592.0, 117335.41332293455, 120031.0, 1239.3307613888398, 1278.5844600504688, 1285.7878450055823, 1286.897048236139, 1291.547958214636, 20200.393988180378, 20427.897860510602, 20675.793242067386, 20991.370258892257, 21325.0, 53736.462635373144, 54768.904621908136, 55929.161062584906, 56005.719971399885, 56473.43526564682, 67819.66090169517, 71350.28649713437, 71678.0, 72015.63992180006, 72484.27515724776, 14562.053466524641, 14720.263986800832, 15274.236288185324, 15310.234488275764, 15524.30140643651, 23675.171369002, 23715.64426533569, 24127.63808542838, 24317.51364972726, 24537.877310613334, 18547.165377557772, 18803.0, 18953.241870325033, 19008.42974710761, 19238.903805480884, 14560.344784484936, 14807.925960370128, 15254.313555890234, 15414.537563873102, 15960.122193279482, 19097.427077187705, 19227.711584325967, 19228.26945574905, 19231.230750770374, 19300.613987720448, 15201.239938003277, 15216.695666086838, 15221.771673424686, 15244.695106098037, 15342.76985845191, 17203.91398043052, 18811.0, 19042.33351832679, 19055.0, 19073.809261907205], "value": 12186.952023425, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1378.5312993582181, 1396.0158088547569, 1408.1269612840035, 1421.4101148023572, 1427.5003748687957, 13460.59618211454, 14058.64853378666, 14067.08563943343, 14090.154590724564, 14102.36539355729, 13520.661983450418, 14012.089214201069, 14028.368723407446, 14077.014608977375, 14105.153690778561, 2595.3900833304206, 2628.921132366032, 2631.158029430583, 2646.9205923822315, 2670.4659068186343, 2333.57995560799, 2359.539889721505, 2376.5246950609862, 2380.1788383007834, 2382.380581048931, 2419.479811840463, 2422.1643532981093, 2437.366284765965, 2471.02394554151, 2476.5170791695627, 2429.0283886445477, 2443.596806526921, 2445.6942882139733, 2445.8532488050773, 2446.694163229596, 2352.1414683640346, 2356.78788908999, 2364.408897775556, 2368.988155059231, 2370.1585936992465, 13180.86819131806, 13459.865401346056, 13480.05639605228, 13490.93254533731, 13491.797623035662, 6772.796816095476, 7074.6816393262425, 7076.823079423004, 7091.716331346792, 7096.787096387065, 4676.415448068991, 4801.879953001168, 4932.8273510427325, 4933.235348520985, 4933.80264789408, 1821.6994195957652, 1857.071464267866, 1881.2851116575614, 1892.706630472279, 1919.9040047997544, 20389.286374976804, 20617.381478555668, 20776.0, 20882.0, 21601.891990540105, 5259.237410575445, 5440.755166017539, 6344.143540621957, 6619.073329733841, 6746.156730408699, 17575.384861529787, 18050.0, 18105.275788968556, 18123.54691132732, 18221.817781822276, 7258.056452661121, 7475.401967842559, 7515.286047825448, 7545.962270188724, 7557.962210188914, 6684.966575167093, 6714.328567143247, 6765.05289259504, 6788.796336109925, 6838.0, 5244.711540865213, 5348.117560602457, 5373.408925018245, 5425.593080518976, 5447.863803404867, 1646.6130459342046, 1706.6416052629088, 1722.070082155622, 1738.1483073294248, 1744.825517448245, 850.4727069217125, 875.7416562114191, 883.7127933421664, 889.5018789477913, 890.0876601483532, 6953.443724502129, 7052.294770522906, 7055.400290975324, 7123.572585644878, 7197.244289349647, 680.2007641021878, 714.5676865496404, 723.7430712097236, 724.3480867219545, 725.3109545931386, 4282.6359759420175, 4554.7039442436135, 4859.975700121477, 4883.804647814119, 5166.638335316492, 17992.730109048374, 18575.53561160982, 18686.906565467358, 18725.157367918477, 18822.623547528972, 17264.74102888458, 18382.448526544224, 18452.169652365676, 19217.32739354116, 19410.22359105648, 9722.173615242784, 10304.742381440525, 10486.00382963602, 10571.36571805694, 10690.198235132397, 7673.0, 8025.839483210187, 8149.755507334789, 8432.114627963976, 8513.574321284035, 15104.169270690218, 15325.6168595786, 15595.0, 15905.125218113115, 16026.11856347912, 15276.388944442542, 16415.83584164143, 16565.58586035359, 16771.077590732628, 16924.66150676955, 10836.13310935139, 10972.890271097187, 10975.231733778559, 10981.450927453436, 10993.065589424989, 11686.18196726221, 12065.517379304729, 12142.392880356123, 12217.083718720954, 12295.69260768488, 10075.949620251851, 10257.538410771383, 10347.94826025865, 10660.040596346365, 10670.146388288764, 9540.809183816424, 9857.852132217879, 9953.203743700342, 9974.002599739968, 10144.188464922641, 8720.127987201482, 8913.732588022369, 8917.643294268157, 8919.241864441596, 8993.640254390013, 6730.427913627396, 7043.436525078084, 7095.503314767917, 7187.412531488555, 7192.0, 7177.102862142232, 7239.167495737847, 7250.274972502708, 7327.596982165819, 7340.926590734024], "value": 6122.307990157284, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [483.3643758457628, 500.9255147708166, 515.3789683431465, 516.6435159739777, 528.8096285337278, 6085.20892284003, 6085.665288409135, 6093.598472351351, 6113.174721412608, 6192.597481163722, 5861.267341582302, 5957.52339812815, 5982.162497250389, 6009.639421634705, 6066.726997285122, 4850.199717046692, 4878.0, 4885.6808661661335, 4900.240462728265, 4941.061198372297, 4791.904161916777, 4829.1307564638355, 4853.830115945942, 4889.633277504184, 4898.232498638258, 4846.418429788413, 4862.6839255448285, 4862.951370486286, 4895.437024742165, 4904.48502907195, 4568.614130434787, 4815.3258543803895, 4826.565609095198, 4880.243562247857, 4891.217405215184, 4305.677074219446, 4314.697971142022, 4325.632321252698, 4355.455568053993, 4386.627136693353, 5788.450097240755, 5836.88326233473, 5851.76592936282, 5885.588008839383, 5918.8816223675285, 5431.4840090191365, 5507.366652834935, 5561.4716601922755, 5572.164175373686, 5605.887882242332, 6332.430081292659, 6339.556231063827, 6350.80947571569, 6401.551891367606, 6476.0, 4780.976095119537, 4783.832565860213, 4798.136335459616, 4817.277408388734, 4825.710457372534, 6640.80077597668, 6717.63053032083, 6719.529632925697, 6821.99999999995, 6833.897491537631, 4948.208286674115, 4974.751262436864, 4980.492654148002, 4994.575461085776, 5027.824026159067, 4929.211326187793, 4967.230079337708, 4995.725235112031, 4997.3253610762085, 5031.295618613397, 5476.424975377608, 5528.86177845549, 5549.5837812164245, 5562.833115006556, 5572.749226284745, 6379.681015949184, 6407.551471397051, 6467.676616169173, 6472.514561407913, 6502.512311576651, 1737.4700716281402, 1748.475457362786, 1752.2728067851954, 1760.3662681434673, 1760.6830770461183, 1118.4687273545, 1202.290648517379, 1211.2913945342073, 1216.6191372791945, 1218.1959906461693, 5460.0, 5591.832245032656, 5647.745851436695, 5653.293338332708, 5671.412004638708, 6482.35176482348, 6550.148480697479, 6555.704993275314, 6556.934430655632, 6581.14445122131, 5641.633293835887, 5693.089105743061, 5699.629524080921, 5719.656820590778, 5719.742611582489, 3425.195079156446, 3425.783846734423, 3496.423090190141, 3500.562429696288, 3509.3332266869215, 6322.336154703782, 6344.968275158594, 6373.840653983688, 6402.0, 6493.51298652603, 6611.371919667624, 6691.297413771484, 6768.5938843668555, 6821.863562728718, 6856.485763567753, 6327.425004872232, 6353.4599559038, 6379.904301435482, 6392.137061496732, 6419.51853610981, 6489.5781774184525, 6547.738090476328, 6555.508336874849, 6592.0, 6620.205575330991, 6430.967845160744, 6433.871322573429, 6480.805575832733, 6502.154719886574, 6614.140161779131, 6322.8735425290315, 6377.904331434939, 6380.585261957958, 6384.17005789263, 6420.967895160495, 4827.758612069452, 4827.806887724451, 4847.321375007431, 4889.753112956173, 4891.119598472309, 6495.967520162369, 6584.901226481702, 6608.570442921195, 6634.601923884582, 6679.131712877489, 6345.587536810092, 6349.428551430394, 6375.936240637534, 6381.361863813581, 6390.64851433157, 6399.168108145911, 6405.295417503978, 6415.358464153547, 6420.935790642034, 6450.322916041957, 6294.622322660655, 6319.431251187415, 6364.586301890362, 6369.267534233622, 6417.454516366161, 6289.584843410196, 6377.7767778127545, 6399.992003758226, 6428.325025872216, 6462.0, 5823.592348535732, 5837.6497410155525, 5908.763649453974, 6066.9696651518225, 6188.226471691039], "value": 4942.20491038458, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [879.5734068976548, 880.3133555826454, 890.35449299258, 898.0390981649633, 901.31950377465, 17591.0, 17700.114994250285, 17729.55676108098, 17952.461426157202, 17994.460166195004, 14991.850081499182, 15364.61588460289, 15398.538043858702, 15426.074435533848, 16225.513234602951, 1019.8266294729896, 1020.2501161646184, 1022.7698767777265, 1024.2778840917172, 1025.021104844875, 1040.5317607076809, 1043.1967385113496, 1047.3297089862494, 1049.034887903131, 1051.384939810212, 1099.4008265495324, 1101.3281898042187, 1102.944852757363, 1107.7507560798836, 1113.6269349767797, 1067.8505009298703, 1072.8498010278568, 1073.951672174754, 1094.2395035450365, 1094.2887123369794, 786.0331791896, 791.9010123734533, 795.1928792275845, 795.2286282306154, 796.5419883566914, 16977.83022169775, 17163.91418042902, 17202.1398930053, 17234.052127133004, 17240.0, 18070.18684159216, 19090.80909190918, 19131.904340478348, 19144.425667230007, 19248.80751192498, 15365.846341536666, 16088.758668619863, 16144.112073835935, 16197.4330898418, 16303.755443668237, 3280.950785738216, 3301.5212794144954, 3301.8349082546015, 3302.4881143422567, 3305.1406634275263, 105186.0, 109062.45468772684, 109571.45214273957, 110072.4496377513, 110732.4463377686, 12878.549250776177, 12981.286029268482, 13001.349932503526, 13026.088173827931, 13192.868071319355, 28092.0, 28843.711562884102, 29090.0, 29447.85276073606, 29509.26226844346, 8032.839343213103, 8261.504309741435, 8494.575271236414, 8534.573271336409, 8586.22723954847, 4082.4284600156, 4178.206140833293, 4189.958100419018, 4207.915841683149, 4212.052288235122, 4833.73414462208, 4842.733649649233, 4878.829240976549, 4924.72913989734, 4954.47977962316, 992.3450522655013, 1001.3991605037065, 1002.2032484174953, 1005.0552480668294, 1006.7281833904805, 644.4135836388957, 649.5777744466135, 665.5308007854451, 671.4896678524357, 681.7954613615896, 11614.477348519336, 11629.24409913353, 11839.704007399883, 11856.347900865363, 12545.811812822814, 653.1117679955257, 677.4478799778165, 681.2438193605094, 688.0711040095831, 690.8860038093759, 5163.789574576442, 5291.788328466895, 5343.893122137535, 5355.437679043722, 5378.408375078739, 97153.0, 104248.0, 104509.0, 106134.46932765287, 111328.44335778432, 91129.0, 92025.53987230021, 92631.53684231536, 94665.52667236619, 97204.51397742965, 73675.26324736791, 76540.61729691316, 77314.22685773183, 79243.0, 83003.58498207471, 10616.946915265375, 10883.455827208449, 10983.176261780558, 11276.154288428237, 11281.774364512828, 34670.0, 35172.29655406929, 35563.64436355707, 35805.0, 37167.442488362154, 45868.622286626836, 46348.53651463442, 47255.763721181174, 47320.76339618418, 48689.75655121702, 15537.533873983799, 15656.608584785472, 15781.68436631238, 15792.60518487047, 15808.36766529372, 17467.47597572075, 17800.109994500483, 17821.10894455298, 17910.925344479372, 18089.36687215941, 15036.0, 15106.697866042838, 16110.919445403168, 16163.75754363709, 16199.0, 16927.830721693117, 17939.0, 17996.64006719832, 18025.188866500775, 18248.817511824713, 17010.957249898896, 17743.20155593027, 17977.370792022215, 18017.909910450362, 18282.542936426165, 11919.702007449883, 11927.10546708983, 11985.760284794429, 12145.271283723005, 12158.75682486363, 12303.507859685513, 12379.257244565355, 12396.566120185751, 12400.441980110736, 12419.130660853654], "value": 8468.90624704109, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1534.4999999999998, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [101.0, 108.0, 108.0, 106.0, 109.0, 109.0, 108.0, 109.0, 108.0, 109.0], "value": 107.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [154.0, 125.0, 153.0, 186.0, 125.0, 146.0, 154.0, 130.0, 170.0, 123.0], "value": 146.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 162.0, 161.0, 163.0, 163.0, 171.0, 163.0, 166.0, 171.0, 165.0], "value": 165.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 77.0, 74.0, 157.0, 76.0, 78.0, 76.0, 78.0, 95.0, 74.0], "value": 85.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 82.0, 146.0, 81.0, 80.0, 82.0, 135.0, 83.0, 81.0, 131.0], "value": 98.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 113.0, 113.0, 114.0, 114.0, 113.0, 114.0, 113.0, 113.0, 113.0], "value": 113.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 152.0, 151.0, 150.0, 151.0, 150.0, 151.0, 150.0, 149.0, 149.0], "value": 150.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 94.0, 94.0, 94.0, 94.0, 95.0, 94.0, 94.0, 95.0], "value": 94.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 57.0, 56.0, 54.0, 55.0, 56.0, 58.0, 54.0, 56.0, 54.0], "value": 55.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 54.0, 55.0, 54.0, 54.0, 54.0, 54.0, 55.0, 54.0, 54.0], "value": 54.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 78.0, 78.0, 79.0, 77.0, 77.0, 76.0, 76.0, 76.0, 77.0], "value": 77.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [133.0, 128.0, 128.0, 129.0, 126.0, 128.0, 127.0, 123.0, 133.0, 160.0], "value": 131.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [190.0, 180.0, 188.0, 178.0, 188.0, 188.0, 179.0, 193.0, 189.0, 182.0], "value": 185.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 72.0, 71.0, 68.0, 70.0, 67.0, 67.0, 69.0, 69.0, 68.0], "value": 68.9, "unit": "score"}]}]} 08:43:16 INFO - Return code: 0 08:43:16 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 08:43:16 INFO - # TBPL SUCCESS # 08:43:16 INFO - Running post-action listener: _package_coverage_data 08:43:16 INFO - Running post-action listener: _resource_record_post_action 08:43:16 INFO - [mozharness: 2017-07-16 15:43:16.654825Z] Finished run-tests step (success) 08:43:16 INFO - Running post-run listener: _resource_record_post_run 08:43:16 INFO - Total resource usage - Wall time: 1191s; CPU: 13.0%; Read bytes: 4096; Write bytes: 436142080; Read time: 8; Write time: 338152 08:43:16 INFO - TinderboxPrint: CPU usage
13.1% 08:43:16 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 8 08:43:16 INFO - TinderboxPrint: I/O write bytes / time
436,142,080 / 338,152 08:43:16 INFO - TinderboxPrint: CPU idle
8,251.9 (86.9%) 08:43:16 INFO - TinderboxPrint: CPU user
1,197.7 (12.6%) 08:43:16 INFO - TinderboxPrint: Swap in / out
0 / 0 08:43:16 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 107532288; Read time: 0; Write time: 100792 08:43:16 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 08:43:16 INFO - run-tests - Wall time: 1173s; CPU: 13.0%; Read bytes: 0; Write bytes: 328609792; Read time: 0; Write time: 237360 08:43:17 INFO - Running post-run listener: _upload_blobber_files 08:43:17 INFO - Blob upload gear active. 08:43:17 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 08:43:17 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 08:43:17 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'] 08:43:17 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 08:43:17 INFO - Traceback (most recent call last): 08:43:17 INFO - File "/builds/slave/test/build/venv/bin/blobberc.py", line 253, in 08:43:17 INFO - main() 08:43:17 INFO - File "/builds/slave/test/build/venv/bin/blobberc.py", line 235, in main 08:43:17 INFO - filetype_whitelist = get_server_whitelist(args['--url']) 08:43:17 INFO - File "/builds/slave/test/build/venv/bin/blobberc.py", line 69, in get_server_whitelist 08:43:17 INFO - return set(response.json().get('whitelist', [])) 08:43:17 INFO - File "/builds/slave/test/build/venv/local/lib/python2.7/site-packages/requests/models.py", line 651, in json 08:43:17 INFO - return json.loads(self.text or self.content, **kwargs) 08:43:17 INFO - File "/builds/slave/test/build/venv/local/lib/python2.7/site-packages/simplejson/__init__.py", line 488, in loads 08:43:17 INFO - return _default_decoder.decode(s) 08:43:17 INFO - File "/builds/slave/test/build/venv/local/lib/python2.7/site-packages/simplejson/decoder.py", line 370, in decode 08:43:17 INFO - obj, end = self.raw_decode(s) 08:43:17 INFO - File "/builds/slave/test/build/venv/local/lib/python2.7/site-packages/simplejson/decoder.py", line 389, in raw_decode 08:43:17 INFO - return self.scan_once(s, idx=_w(s, idx).end()) 08:43:17 INFO - simplejson.scanner.JSONDecodeError: Expecting value: line 1 column 1 (char 0) 08:43:17 ERROR - Return code: 1 08:43:17 INFO - Setting buildbot property blobber_files to {} 08:43:17 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 08:43:17 INFO - Writing to file /builds/slave/test/properties/blobber_files 08:43:17 INFO - Contents: 08:43:17 INFO - blobber_files:{} 08:43:17 INFO - Running post-run listener: copy_logs_to_upload_dir 08:43:17 INFO - Copying logs to upload dir... 08:43:17 INFO - mkdir: /builds/slave/test/build/upload/logs 08:43:17 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1244.465391 ========= master_lag: 0.33 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 44 secs) (at 2017-07-16 08:43:15.598267) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-07-16 08:43:15.606978) ========= 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=ed14279e38b05397cf4aa391000001a4-1500218451.411980-622583467 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{} build_url:https://queue.taskcluster.net/v1/task/NDpJWzxyReSiqoum8vZ_XA/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011188 build_url: 'https://queue.taskcluster.net/v1/task/NDpJWzxyReSiqoum8vZ_XA/artifacts/public/build/target.tar.bz2' blobber_files: '{}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-07-16 08:43:15.636435) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-07-16 08:43:15.636796) ========= 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=ed14279e38b05397cf4aa391000001a4-1500218451.411980-622583467 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004501 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-07-16 08:43:15.686342) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-07-16 08:43:15.686670) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-07-16 08:43:15.686988) ========= ========= Total master_lag: 0.47 =========