builder: mozilla-central_ubuntu64_hw_qr_test-dromaeojs-e10s slave: talos-linux64-ix-056 starttime: 1502925680.32 results: success (0) revision: 1d38626ba9686d119e489db538ce84f8f9854217 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-08-16 16:21:20.320833) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-08-16 16:21:20.321430) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-08-16 16:21:20.321774) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-08-16 16:21:20.378202) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-16 16:21:20.378577) ========= 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=52faae308a556c440401f8e5000001e8-1502921579.399767-1660496627 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-08-16 16:21:20-- 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% 96.1M=0s 2017-08-16 16:21:20 (96.1 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.083462 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-16 16:21:20.492071) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-08-16 16:21:20.492437) ========= 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=52faae308a556c440401f8e5000001e8-1502921579.399767-1660496627 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015694 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-08-16 16:21:20.549017) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 mins, 18 secs) (at 2017-08-16 16:21:20.549454) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 1d38626ba9686d119e489db538ce84f8f9854217 --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 1d38626ba9686d119e489db538ce84f8f9854217 --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=52faae308a556c440401f8e5000001e8-1502921579.399767-1660496627 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-08-16 16:21:21,008 truncating revision to first 12 chars 2017-08-16 16:21:21,008 Setting DEBUG logging. 2017-08-16 16:21:21,008 attempt 1/10 2017-08-16 16:21:21,008 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/1d38626ba968?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-08-16 16:21:21,806 attempt 1/10 2017-08-16 16:21:22,577 current task status: no status available at this point. state: PENDING 2017-08-16 16:21:22,577 sleeping for 9.00s (attempt 1/10) 2017-08-16 16:21:31,586 attempt 2/10 2017-08-16 16:21:32,104 current task status: no status available at this point. state: PENDING 2017-08-16 16:21:32,104 sleeping for 13.50s (attempt 2/10) 2017-08-16 16:21:45,618 attempt 3/10 2017-08-16 16:21:46,184 current task status: no status available at this point. state: PENDING 2017-08-16 16:21:46,185 sleeping for 21.25s (attempt 3/10) 2017-08-16 16:22:07,456 attempt 4/10 2017-08-16 16:22:07,997 current task status: no status available at this point. state: STARTED 2017-08-16 16:22:07,997 sleeping for 30.88s (attempt 4/10) 2017-08-16 16:22:38,903 attempt 5/10 2017-08-16 16:22:39,212 current task status: Task completed! Check 's3_urls' for upload locations. state: SUCCESS 2017-08-16 16:22:39,459 unpacking tar archive at: mozilla-central-1d38626ba968/testing/mozharness/ program finished with exit code 0 elapsedTime=78.761786 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 mins, 18 secs) (at 2017-08-16 16:22:39.333704) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-08-16 16:22:39.336670) ========= script_repo_revision: 1d38626ba9686d119e489db538ce84f8f9854217 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-08-16 16:22:39.337232) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-08-16 16:22:39.337563) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-08-16 16:22:39.349877) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 2 secs) (at 2017-08-16 16:22:39.350271) ========= /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=52faae308a556c440401f8e5000001e8-1502921579.399767-1660496627 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 16:22:39 INFO - MultiFileLogger online at 20170816 16:22:39 in /builds/slave/test 16:22:39 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 16:22:39 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 16:22:39 INFO - {'append_to_log': False, 16:22:39 INFO - 'base_work_dir': '/builds/slave/test', 16:22:39 INFO - 'blob_upload_branch': 'Firefox', 16:22:39 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 16:22:39 INFO - 'branch': 'Firefox', 16:22:39 INFO - 'buildbot_json_path': 'buildprops.json', 16:22:39 INFO - 'code_coverage': False, 16:22:39 INFO - 'config_files': ('talos/linux_config.py',), 16:22:39 INFO - 'default_actions': ('clobber', 16:22:39 INFO - 'read-buildbot-config', 16:22:39 INFO - 'download-and-extract', 16:22:39 INFO - 'populate-webroot', 16:22:39 INFO - 'create-virtualenv', 16:22:39 INFO - 'install', 16:22:39 INFO - 'setup-mitmproxy', 16:22:39 INFO - 'run-tests'), 16:22:39 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 16:22:39 INFO - 'disable_ccov_upload': False, 16:22:39 INFO - 'download_minidump_stackwalk': True, 16:22:39 INFO - 'download_symbols': 'ondemand', 16:22:39 INFO - 'enable_stylo': False, 16:22:39 INFO - 'enable_webrender': False, 16:22:39 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 16:22:39 INFO - 'tooltool.py': '/tools/tooltool.py', 16:22:39 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 16:22:39 INFO - '/tools/misc-python/virtualenv.py')}, 16:22:39 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 16:22:39 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 16:22:39 INFO - 'gecko_profile': False, 16:22:39 INFO - 'gecko_profile_interval': 0, 16:22:39 INFO - 'installer_path': 'installer.exe', 16:22:39 INFO - 'log_level': 'info', 16:22:39 INFO - 'log_name': 'talos', 16:22:39 INFO - 'log_to_console': True, 16:22:39 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 16:22:39 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 16:22:39 INFO - 'opt_config_files': (), 16:22:39 INFO - 'pip_index': False, 16:22:39 INFO - 'suite': 'dromaeojs-e10s', 16:22:39 INFO - 'system_bits': '32', 16:22:39 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 16:22:39 INFO - 'title': 'talos-linux64-ix-056', 16:22:39 INFO - 'tooltool_cache': '/builds/tooltool_cache', 16:22:39 INFO - 'use_talos_json': True, 16:22:39 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 16:22:39 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 16:22:39 INFO - 'work_dir': 'build'} 16:22:39 INFO - [mozharness: 2017-08-16 23:22:39.938869Z] Running clobber step. 16:22:39 INFO - Running pre-action listener: _resource_record_pre_action 16:22:39 INFO - Running main action method: clobber 16:22:39 INFO - rmtree: /builds/slave/test/build 16:22:39 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 16:22:40 INFO - Running post-action listener: _resource_record_post_action 16:22:40 INFO - [mozharness: 2017-08-16 23:22:40.962570Z] Finished clobber step (success) 16:22:40 INFO - [mozharness: 2017-08-16 23:22:40.962673Z] Running read-buildbot-config step. 16:22:40 INFO - Running pre-action listener: _resource_record_pre_action 16:22:40 INFO - Running main action method: read_buildbot_config 16:22:40 INFO - Using buildbot properties: 16:22:40 INFO - { 16:22:40 INFO - "project": "", 16:22:40 INFO - "product": "firefox", 16:22:40 INFO - "who": "kwierso@gmail.com", 16:22:40 INFO - "installer_path": "public/build/target.tar.bz2", 16:22:40 INFO - "builddir": "mozilla-central_ubuntu64_hw_qr_test-dromaeojs-e10s", 16:22:40 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 16:22:40 INFO - "buildername": "Ubuntu HW 12.04 x64 qr mozilla-central talos dromaeojs-e10s", 16:22:40 INFO - "stage_platform": "linux64-qr", 16:22:40 INFO - "basedir": "/builds/slave/test", 16:22:40 INFO - "buildnumber": 2, 16:22:40 INFO - "platform": "ubuntu64_hw_qr", 16:22:40 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 16:22:40 INFO - "slavebuilddir": "test", 16:22:40 INFO - "taskId": "GkdlO-JjT0i452HFS1ej6A", 16:22:40 INFO - "branch": "mozilla-central", 16:22:40 INFO - "script_repo_revision": "production", 16:22:40 INFO - "revision": "1d38626ba9686d119e489db538ce84f8f9854217", 16:22:40 INFO - "slavename": "talos-linux64-ix-056", 16:22:40 INFO - "repo_path": "mozilla-central" 16:22:40 INFO - } 16:22:40 INFO - Finding installer, test and symbols from parent task. 16:22:40 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/GkdlO-JjT0i452HFS1ej6A'}, attempt #1 16:22:41 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/GkdlO-JjT0i452HFS1ej6A'}, attempt #1 16:22:41 INFO - Task dependencies: MwNIxikqQeW7ZnNry6c34A 16:22:41 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/MwNIxikqQeW7ZnNry6c34A'}, attempt #1 16:22:42 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/MwNIxikqQeW7ZnNry6c34A/artifacts/public/build/target.tar.bz2 16:22:42 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/MwNIxikqQeW7ZnNry6c34A/artifacts/public/build/target.test_packages.json 16:22:42 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/MwNIxikqQeW7ZnNry6c34A/artifacts/public/build/target.crashreporter-symbols.zip 16:22:42 INFO - Running post-action listener: _resource_record_post_action 16:22:42 INFO - [mozharness: 2017-08-16 23:22:42.301648Z] Finished read-buildbot-config step (success) 16:22:42 INFO - [mozharness: 2017-08-16 23:22:42.301872Z] Running download-and-extract step. 16:22:42 INFO - Running pre-action listener: _resource_record_pre_action 16:22:42 INFO - Running main action method: download_and_extract 16:22:42 INFO - mkdir: /builds/slave/test/build/tests 16:22:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:22:42 INFO - trying https://queue.taskcluster.net/v1/task/MwNIxikqQeW7ZnNry6c34A/artifacts/public/build/target.test_packages.json 16:22:42 INFO - Downloading https://queue.taskcluster.net/v1/task/MwNIxikqQeW7ZnNry6c34A/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 16:22:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/MwNIxikqQeW7ZnNry6c34A/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 16:22:42 INFO - Downloaded 989 bytes. 16:22:42 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 16:22:42 INFO - Using the following test package requirements: 16:22:42 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 16:22:42 INFO - u'common': [u'target.common.tests.zip'], 16:22:42 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 16:22:42 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 16:22:42 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 16:22:42 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 16:22:42 INFO - u'mozbase': [u'target.common.tests.zip'], 16:22:42 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 16:22:42 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 16:22:42 INFO - u'web-platform': [u'target.common.tests.zip', 16:22:42 INFO - u'target.web-platform.tests.tar.gz'], 16:22:42 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 16:22:42 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 16:22:42 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/MwNIxikqQeW7ZnNry6c34A/artifacts/public/build/target.common.tests.zip 16:22:42 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/MwNIxikqQeW7ZnNry6c34A/artifacts/public/build/target.common.tests.zip'}, attempt #1 16:22:42 INFO - Fetch https://queue.taskcluster.net/v1/task/MwNIxikqQeW7ZnNry6c34A/artifacts/public/build/target.common.tests.zip into memory 16:22:43 INFO - Content-Length response header: 54004033 16:22:43 INFO - Bytes received: 54004033 16:22:55 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 16:22:55 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/MwNIxikqQeW7ZnNry6c34A/artifacts/public/build/target.common.tests.zip 16:22:55 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/MwNIxikqQeW7ZnNry6c34A/artifacts/public/build/target.common.tests.zip'}, attempt #1 16:22:55 INFO - Fetch https://queue.taskcluster.net/v1/task/MwNIxikqQeW7ZnNry6c34A/artifacts/public/build/target.common.tests.zip into memory 16:22:56 INFO - Content-Length response header: 54004033 16:22:56 INFO - Bytes received: 54004033 16:23:07 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/MwNIxikqQeW7ZnNry6c34A/artifacts/public/build/target.talos.tests.zip 16:23:07 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/MwNIxikqQeW7ZnNry6c34A/artifacts/public/build/target.talos.tests.zip'}, attempt #1 16:23:07 INFO - Fetch https://queue.taskcluster.net/v1/task/MwNIxikqQeW7ZnNry6c34A/artifacts/public/build/target.talos.tests.zip into memory 16:23:08 INFO - Content-Length response header: 14496050 16:23:08 INFO - Bytes received: 14496050 16:23:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:23:08 INFO - trying https://queue.taskcluster.net/v1/task/MwNIxikqQeW7ZnNry6c34A/artifacts/public/build/target.tar.bz2 16:23:08 INFO - Downloading https://queue.taskcluster.net/v1/task/MwNIxikqQeW7ZnNry6c34A/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 16:23:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/MwNIxikqQeW7ZnNry6c34A/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 16:23:10 INFO - Downloaded 61751858 bytes. 16:23:10 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/MwNIxikqQeW7ZnNry6c34A/artifacts/public/build/target.tar.bz2 16:23:10 INFO - mkdir: /builds/slave/test/properties 16:23:10 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 16:23:10 INFO - Writing to file /builds/slave/test/properties/build_url 16:23:10 INFO - Contents: 16:23:10 INFO - build_url:https://queue.taskcluster.net/v1/task/MwNIxikqQeW7ZnNry6c34A/artifacts/public/build/target.tar.bz2 16:23:10 INFO - Running post-action listener: _resource_record_post_action 16:23:10 INFO - Running post-action listener: set_extra_try_arguments 16:23:10 INFO - [mozharness: 2017-08-16 23:23:10.138698Z] Finished download-and-extract step (success) 16:23:10 INFO - [mozharness: 2017-08-16 23:23:10.138796Z] Running populate-webroot step. 16:23:10 INFO - Running pre-action listener: _resource_record_pre_action 16:23:10 INFO - Running main action method: populate_webroot 16:23:10 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 16:23:10 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 16:23:10 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 16:23:10 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:23:10 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 16:23:10 INFO - 'tests': ['damp', 'tps']}, 16:23:10 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 16:23:10 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 16:23:10 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 16:23:10 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 16:23:10 INFO - 'other-e10s': {'tests': ['a11yr', 16:23:10 INFO - 'ts_paint', 16:23:10 INFO - 'tpaint', 16:23:10 INFO - 'sessionrestore', 16:23:10 INFO - 'sessionrestore_many_windows', 16:23:10 INFO - 'sessionrestore_no_auto_restore', 16:23:10 INFO - 'tabpaint']}, 16:23:10 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 16:23:10 INFO - 'perf-reftest-singletons-e10s': {'tests': ['bloom_basic_singleton']}, 16:23:10 INFO - 'svgr-e10s': {'tests': ['tsvgx', 16:23:10 INFO - 'tsvgr_opacity', 16:23:10 INFO - 'tart', 16:23:10 INFO - 'tscrollx', 16:23:10 INFO - 'tsvg_static']}, 16:23:10 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 16:23:10 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 16:23:10 INFO - 'talos_options': ['--mitmproxy', 16:23:10 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 16:23:10 INFO - '--firstNonBlankPaint'], 16:23:10 INFO - 'tests': ['tp6_google', 16:23:10 INFO - 'tp6_youtube', 16:23:10 INFO - 'tp6_amazon', 16:23:10 INFO - 'tp6_facebook']}, 16:23:10 INFO - 'tp6-stylo-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 16:23:10 INFO - 'talos_options': ['--stylo', 16:23:10 INFO - '--mitmproxy', 16:23:10 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 16:23:10 INFO - '--firstNonBlankPaint'], 16:23:10 INFO - 'tests': ['tp6_google', 16:23:10 INFO - 'tp6_youtube', 16:23:10 INFO - 'tp6_amazon', 16:23:10 INFO - 'tp6_facebook']}, 16:23:10 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 16:23:10 INFO - 'talos_options': ['--stylo', 16:23:10 INFO - '--stylo-threads=1', 16:23:10 INFO - '--mitmproxy', 16:23:10 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 16:23:10 INFO - '--firstNonBlankPaint'], 16:23:10 INFO - 'tests': ['tp6_google', 16:23:10 INFO - 'tp6_youtube', 16:23:10 INFO - 'tp6_amazon', 16:23:10 INFO - 'tp6_facebook']}, 16:23:10 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 16:23:10 INFO - 'talos_options': ['--xperf_path', 16:23:10 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:23:10 INFO - 'tests': ['tp5n']}}} 16:23:10 INFO - Running post-action listener: _resource_record_post_action 16:23:10 INFO - [mozharness: 2017-08-16 23:23:10.147249Z] Finished populate-webroot step (success) 16:23:10 INFO - [mozharness: 2017-08-16 23:23:10.147339Z] Running create-virtualenv step. 16:23:10 INFO - Running pre-action listener: _resource_record_pre_action 16:23:10 INFO - Running main action method: create_virtualenv 16:23:10 INFO - Creating virtualenv /builds/slave/test/build/venv 16:23:10 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 16:23:10 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 16:23:10 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 16:23:10 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 16:23:10 INFO - Using real prefix '/usr' 16:23:10 INFO - New python executable in /builds/slave/test/build/venv/bin/python 16:23:10 INFO - Installing distribute.............................................................................................................................................................................................done. 16:23:12 INFO - Installing pip.................done. 16:23:12 INFO - Return code: 0 16:23:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 16:23:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 16:23:12 INFO - Reading from file tmpfile_stdout 16:23:12 INFO - Output received: 16:23:12 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) 16:23:12 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 16: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')]} 16:23:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16: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')]} 16:23:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:23:12 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22b21f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23b6a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2559ef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25570b0>, '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 0x2557fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2558440>, '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': '52faae308a556c440401f8e5000001e8-1502921579.399767-1660496627', '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 16:23:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 16:23:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 16:23:12 INFO - Using env: {'DISPLAY': ':0', 16:23:12 INFO - 'HOME': '/home/cltbld', 16:23:12 INFO - 'LANG': 'en_US.UTF-8', 16:23:12 INFO - 'LANGUAGE': 'en_US:en', 16:23:12 INFO - 'LOGNAME': 'cltbld', 16:23:12 INFO - 'MAIL': '/var/mail/cltbld', 16:23:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:23:12 INFO - 'MOZ_NO_REMOTE': '1', 16:23:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:23:12 INFO - 'NO_EM_RESTART': '1', 16:23:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:23:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:23:12 INFO - 'PWD': '/builds/slave/test', 16:23:12 INFO - 'SHELL': '/bin/bash', 16:23:12 INFO - 'SHLVL': '1', 16:23:12 INFO - 'TERM': 'linux', 16:23:12 INFO - 'TMOUT': '86400', 16:23:12 INFO - 'USER': 'cltbld', 16:23:12 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1502921579.399767-1660496627', 16:23:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:23:12 INFO - '_': '/tools/buildbot/bin/python'} 16:23:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:23:13 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 16:23:13 INFO - Cleaning up... 16:23:13 INFO - Return code: 0 16:23:13 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 16: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')]} 16:23:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16: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')]} 16:23:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16: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', '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 0x22b21f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23b6a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2559ef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25570b0>, '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 0x2557fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2558440>, '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': '52faae308a556c440401f8e5000001e8-1502921579.399767-1660496627', '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 16: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', 'psutil>=3.1.1'] in /builds/slave/test/build 16: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 psutil>=3.1.1 16:23:13 INFO - Using env: {'DISPLAY': ':0', 16:23:13 INFO - 'HOME': '/home/cltbld', 16:23:13 INFO - 'LANG': 'en_US.UTF-8', 16:23:13 INFO - 'LANGUAGE': 'en_US:en', 16:23:13 INFO - 'LOGNAME': 'cltbld', 16:23:13 INFO - 'MAIL': '/var/mail/cltbld', 16:23:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:23:13 INFO - 'MOZ_NO_REMOTE': '1', 16:23:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:23:13 INFO - 'NO_EM_RESTART': '1', 16:23:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:23:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:23:13 INFO - 'PWD': '/builds/slave/test', 16:23:13 INFO - 'SHELL': '/bin/bash', 16:23:13 INFO - 'SHLVL': '1', 16:23:13 INFO - 'TERM': 'linux', 16:23:13 INFO - 'TMOUT': '86400', 16:23:13 INFO - 'USER': 'cltbld', 16:23:13 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1502921579.399767-1660496627', 16:23:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:23:13 INFO - '_': '/tools/buildbot/bin/python'} 16:23:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:23:13 INFO - Downloading/unpacking psutil>=3.1.1 16: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 16: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 16: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 16: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 16:23:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 16:23:14 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:23:14 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:23:14 INFO - Installing collected packages: psutil 16:23:14 INFO - Running setup.py install for psutil 16:23:14 INFO - building 'psutil._psutil_linux' extension 16:23:14 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 16:23:14 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 16:23:14 INFO - building 'psutil._psutil_posix' extension 16:23:14 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 16:23:15 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 16:23:15 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:23:15 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:23:15 INFO - Successfully installed psutil 16:23:15 INFO - Cleaning up... 16:23:15 INFO - Return code: 0 16:23:15 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 16: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')]} 16:23:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16: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')]} 16:23:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:23:15 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22b21f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23b6a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2559ef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25570b0>, '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 0x2557fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2558440>, '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': '52faae308a556c440401f8e5000001e8-1502921579.399767-1660496627', '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 16:23:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 16:23:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 16:23:15 INFO - Using env: {'DISPLAY': ':0', 16:23:15 INFO - 'HOME': '/home/cltbld', 16:23:15 INFO - 'LANG': 'en_US.UTF-8', 16:23:15 INFO - 'LANGUAGE': 'en_US:en', 16:23:15 INFO - 'LOGNAME': 'cltbld', 16:23:15 INFO - 'MAIL': '/var/mail/cltbld', 16:23:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:23:15 INFO - 'MOZ_NO_REMOTE': '1', 16:23:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:23:15 INFO - 'NO_EM_RESTART': '1', 16:23:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:23:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:23:15 INFO - 'PWD': '/builds/slave/test', 16:23:15 INFO - 'SHELL': '/bin/bash', 16:23:15 INFO - 'SHLVL': '1', 16:23:15 INFO - 'TERM': 'linux', 16:23:15 INFO - 'TMOUT': '86400', 16:23:15 INFO - 'USER': 'cltbld', 16:23:15 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1502921579.399767-1660496627', 16:23:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:23:15 INFO - '_': '/tools/buildbot/bin/python'} 16:23:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:23:15 INFO - Downloading/unpacking mozsystemmonitor==0.3 16:23:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:23:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:23:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:23:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:23:16 INFO - Downloading mozsystemmonitor-0.3.tar.gz 16:23:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 16:23:16 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 16:23:16 INFO - Installing collected packages: mozsystemmonitor 16:23:16 INFO - Running setup.py install for mozsystemmonitor 16:23:16 INFO - Successfully installed mozsystemmonitor 16:23:16 INFO - Cleaning up... 16:23:16 INFO - Return code: 0 16:23:16 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 16:23:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:23:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:23:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:23:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:23:16 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x22b21f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23b6a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2559ef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25570b0>, '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 0x2557fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2558440>, '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': '52faae308a556c440401f8e5000001e8-1502921579.399767-1660496627', '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 16:23:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 16:23:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 16:23:16 INFO - Using env: {'DISPLAY': ':0', 16:23:16 INFO - 'HOME': '/home/cltbld', 16:23:16 INFO - 'LANG': 'en_US.UTF-8', 16:23:16 INFO - 'LANGUAGE': 'en_US:en', 16:23:16 INFO - 'LOGNAME': 'cltbld', 16:23:16 INFO - 'MAIL': '/var/mail/cltbld', 16:23:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:23:16 INFO - 'MOZ_NO_REMOTE': '1', 16:23:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:23:16 INFO - 'NO_EM_RESTART': '1', 16:23:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:23:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:23:16 INFO - 'PWD': '/builds/slave/test', 16:23:16 INFO - 'SHELL': '/bin/bash', 16:23:16 INFO - 'SHLVL': '1', 16:23:16 INFO - 'TERM': 'linux', 16:23:16 INFO - 'TMOUT': '86400', 16:23:16 INFO - 'USER': 'cltbld', 16:23:16 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1502921579.399767-1660496627', 16:23:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:23:16 INFO - '_': '/tools/buildbot/bin/python'} 16:23:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:23:16 INFO - Downloading/unpacking jsonschema==2.5.1 16:23:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:23:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:23:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:23:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:23:17 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 16:23:18 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 16:23:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:23:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:23:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:23:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:23:18 INFO - Downloading functools32-3.2.3-2.tar.gz 16:23:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 16:23:18 INFO - warning: no files found matching '*.txt' 16:23:18 INFO - no previously-included directories found matching 'build' 16:23:18 INFO - no previously-included directories found matching 'dist' 16:23:18 INFO - no previously-included directories found matching '.git*' 16:23:18 INFO - Installing collected packages: jsonschema, functools32 16:23:18 INFO - Running setup.py install for functools32 16:23:18 INFO - warning: no files found matching '*.txt' 16:23:18 INFO - no previously-included directories found matching 'build' 16:23:18 INFO - no previously-included directories found matching 'dist' 16:23:18 INFO - no previously-included directories found matching '.git*' 16:23:18 INFO - Successfully installed jsonschema functools32 16:23:18 INFO - Cleaning up... 16:23:18 INFO - Return code: 0 16:23:18 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 16:23:18 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')]} 16:23:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:23:18 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')]} 16:23:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:23:18 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/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 0x22b21f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23b6a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2559ef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25570b0>, '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 0x2557fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2558440>, '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': '52faae308a556c440401f8e5000001e8-1502921579.399767-1660496627', '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 16:23:18 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 16:23:18 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 16:23:18 INFO - Using env: {'DISPLAY': ':0', 16:23:18 INFO - 'HOME': '/home/cltbld', 16:23:18 INFO - 'LANG': 'en_US.UTF-8', 16:23:18 INFO - 'LANGUAGE': 'en_US:en', 16:23:18 INFO - 'LOGNAME': 'cltbld', 16:23:18 INFO - 'MAIL': '/var/mail/cltbld', 16:23:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:23:18 INFO - 'MOZ_NO_REMOTE': '1', 16:23:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:23:18 INFO - 'NO_EM_RESTART': '1', 16:23:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:23:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:23:18 INFO - 'PWD': '/builds/slave/test', 16:23:18 INFO - 'SHELL': '/bin/bash', 16:23:18 INFO - 'SHLVL': '1', 16:23:18 INFO - 'TERM': 'linux', 16:23:18 INFO - 'TMOUT': '86400', 16:23:18 INFO - 'USER': 'cltbld', 16:23:18 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1502921579.399767-1660496627', 16:23:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:23:18 INFO - '_': '/tools/buildbot/bin/python'} 16:23:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:23:18 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 16:23:18 INFO - Cleaning up... 16:23:18 INFO - Return code: 0 16:23:18 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 16:23:18 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')]} 16:23:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:23:18 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')]} 16:23:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:23:18 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/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 0x22b21f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23b6a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2559ef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25570b0>, '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 0x2557fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2558440>, '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': '52faae308a556c440401f8e5000001e8-1502921579.399767-1660496627', '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 16:23:18 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 16:23:18 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 16:23:18 INFO - Using env: {'DISPLAY': ':0', 16:23:18 INFO - 'HOME': '/home/cltbld', 16:23:18 INFO - 'LANG': 'en_US.UTF-8', 16:23:18 INFO - 'LANGUAGE': 'en_US:en', 16:23:18 INFO - 'LOGNAME': 'cltbld', 16:23:18 INFO - 'MAIL': '/var/mail/cltbld', 16:23:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:23:18 INFO - 'MOZ_NO_REMOTE': '1', 16:23:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:23:18 INFO - 'NO_EM_RESTART': '1', 16:23:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:23:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:23:18 INFO - 'PWD': '/builds/slave/test', 16:23:18 INFO - 'SHELL': '/bin/bash', 16:23:18 INFO - 'SHLVL': '1', 16:23:18 INFO - 'TERM': 'linux', 16:23:18 INFO - 'TMOUT': '86400', 16:23:18 INFO - 'USER': 'cltbld', 16:23:18 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1502921579.399767-1660496627', 16:23:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:23:18 INFO - '_': '/tools/buildbot/bin/python'} 16:23:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:23:18 INFO - Downloading/unpacking blobuploader==1.2.4 16:23:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:23:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:23:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:23:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:23:19 INFO - Downloading blobuploader-1.2.4.tar.gz 16:23:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 16:23:19 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 16:23:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:23:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:23:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:23:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:23:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 16:23:20 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 16: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 16: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 16: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 16: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 16:23:20 INFO - Downloading docopt-0.6.1.tar.gz 16:23:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 16:23:20 INFO - Installing collected packages: blobuploader, requests, docopt 16:23:20 INFO - Running setup.py install for blobuploader 16:23:20 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 16:23:20 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 16:23:20 INFO - Running setup.py install for requests 16:23:20 INFO - Running setup.py install for docopt 16:23:21 INFO - Successfully installed blobuploader requests docopt 16:23:21 INFO - Cleaning up... 16:23:21 INFO - Return code: 0 16:23:21 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:23:21 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')]} 16:23:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:23:21 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')]} 16:23:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:23:21 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 0x22b21f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23b6a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2559ef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25570b0>, '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 0x2557fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2558440>, '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': '52faae308a556c440401f8e5000001e8-1502921579.399767-1660496627', '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 16:23:21 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 16:23:21 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 16:23:21 INFO - Using env: {'DISPLAY': ':0', 16:23:21 INFO - 'HOME': '/home/cltbld', 16:23:21 INFO - 'LANG': 'en_US.UTF-8', 16:23:21 INFO - 'LANGUAGE': 'en_US:en', 16:23:21 INFO - 'LOGNAME': 'cltbld', 16:23:21 INFO - 'MAIL': '/var/mail/cltbld', 16:23:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:23:21 INFO - 'MOZ_NO_REMOTE': '1', 16:23:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:23:21 INFO - 'NO_EM_RESTART': '1', 16:23:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:23:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:23:21 INFO - 'PWD': '/builds/slave/test', 16:23:21 INFO - 'SHELL': '/bin/bash', 16:23:21 INFO - 'SHLVL': '1', 16:23:21 INFO - 'TERM': 'linux', 16:23:21 INFO - 'TMOUT': '86400', 16:23:21 INFO - 'USER': 'cltbld', 16:23:21 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1502921579.399767-1660496627', 16:23:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:23:21 INFO - '_': '/tools/buildbot/bin/python'} 16:23:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:23:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:23:21 INFO - Running setup.py (path:/tmp/pip-l8M2jo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:23:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:23:21 INFO - Running setup.py (path:/tmp/pip-7RUoWE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:23:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:23:21 INFO - Running setup.py (path:/tmp/pip-fCQdW5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:23:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:23:21 INFO - Running setup.py (path:/tmp/pip-1RZ4c7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:23:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:23:21 INFO - Running setup.py (path:/tmp/pip-WiCT81-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:23:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:23:21 INFO - Running setup.py (path:/tmp/pip-vI8rIQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:23:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:23:21 INFO - Running setup.py (path:/tmp/pip-6vpyt6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:23:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:23:21 INFO - Running setup.py (path:/tmp/pip-rO643t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:23:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:23:21 INFO - Running setup.py (path:/tmp/pip-FFzWJw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:23:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:23:22 INFO - Running setup.py (path:/tmp/pip-rKwwgJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:23:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:23:22 INFO - Running setup.py (path:/tmp/pip-inMuVQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:23:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:23:22 INFO - Running setup.py (path:/tmp/pip-17WU9e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:23:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:23:22 INFO - Running setup.py (path:/tmp/pip-2hgJAH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:23:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:23:22 INFO - Running setup.py (path:/tmp/pip-8YEGm3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:23:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:23:22 INFO - Running setup.py (path:/tmp/pip-xyouZn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:23:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:23:22 INFO - Running setup.py (path:/tmp/pip-gcLEAF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:23:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:23:22 INFO - Running setup.py (path:/tmp/pip-eDeIJP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:23:22 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 16:23:22 INFO - Running setup.py install for manifestparser 16:23:22 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 16:23:22 INFO - Running setup.py install for mozcrash 16:23:22 INFO - Running setup.py install for mozdebug 16:23:22 INFO - Running setup.py install for mozdevice 16:23:22 INFO - Installing dm script to /builds/slave/test/build/venv/bin 16:23:23 INFO - Running setup.py install for mozfile 16:23:23 INFO - Running setup.py install for mozhttpd 16:23:23 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 16:23:23 INFO - Running setup.py install for mozinfo 16:23:23 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 16:23:23 INFO - Running setup.py install for mozInstall 16:23:23 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 16:23:23 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 16:23:23 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 16:23:23 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 16:23:23 INFO - Running setup.py install for mozleak 16:23:23 INFO - Running setup.py install for mozlog 16:23:23 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 16:23:23 INFO - Running setup.py install for moznetwork 16:23:23 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 16:23:23 INFO - Running setup.py install for mozprocess 16:23:23 INFO - Running setup.py install for mozprofile 16:23:23 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 16:23:23 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 16:23:23 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 16:23:23 INFO - Running setup.py install for mozrunner 16:23:24 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 16:23:24 INFO - Running setup.py install for mozscreenshot 16:23:24 INFO - Running setup.py install for moztest 16:23:24 INFO - Running setup.py install for mozversion 16:23:24 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 16:23:24 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 16:23:24 INFO - Cleaning up... 16:23:24 INFO - Return code: 0 16:23:24 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16: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')]} 16:23:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16: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')]} 16:23:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:23:24 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 0x22b21f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23b6a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2559ef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25570b0>, '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 0x2557fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2558440>, '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': '52faae308a556c440401f8e5000001e8-1502921579.399767-1660496627', '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 16:23:24 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 16:23:24 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 16:23:24 INFO - Using env: {'DISPLAY': ':0', 16:23:24 INFO - 'HOME': '/home/cltbld', 16:23:24 INFO - 'LANG': 'en_US.UTF-8', 16:23:24 INFO - 'LANGUAGE': 'en_US:en', 16:23:24 INFO - 'LOGNAME': 'cltbld', 16:23:24 INFO - 'MAIL': '/var/mail/cltbld', 16:23:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:23:24 INFO - 'MOZ_NO_REMOTE': '1', 16:23:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:23:24 INFO - 'NO_EM_RESTART': '1', 16:23:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:23:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:23:24 INFO - 'PWD': '/builds/slave/test', 16:23:24 INFO - 'SHELL': '/bin/bash', 16:23:24 INFO - 'SHLVL': '1', 16:23:24 INFO - 'TERM': 'linux', 16:23:24 INFO - 'TMOUT': '86400', 16:23:24 INFO - 'USER': 'cltbld', 16:23:24 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1502921579.399767-1660496627', 16:23:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:23:24 INFO - '_': '/tools/buildbot/bin/python'} 16:23:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:23:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:23:24 INFO - Running setup.py (path:/tmp/pip-jrdo2y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:23:24 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)) 16:23:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:23:24 INFO - Running setup.py (path:/tmp/pip-btgE8C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:23:24 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)) 16:23:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:23:24 INFO - Running setup.py (path:/tmp/pip-0dG3DZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:23:24 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)) 16:23:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:23:24 INFO - Running setup.py (path:/tmp/pip-ohQKuz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:23:24 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)) 16:23:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:23:24 INFO - Running setup.py (path:/tmp/pip-_TvW5y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:23:24 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)) 16:23:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:23:24 INFO - Running setup.py (path:/tmp/pip-9i9ZFf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:23:25 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)) 16:23:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:23:25 INFO - Running setup.py (path:/tmp/pip-Ge44rs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:23:25 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)) 16:23:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:23:25 INFO - Running setup.py (path:/tmp/pip-eDvG23-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:23:25 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)) 16:23:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:23:25 INFO - Running setup.py (path:/tmp/pip-Wqd1v1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:23:25 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)) 16:23:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:23:25 INFO - Running setup.py (path:/tmp/pip-rDzWm7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:23:25 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)) 16:23:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:23:25 INFO - Running setup.py (path:/tmp/pip-DqNuoM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:23:25 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)) 16:23:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:23:25 INFO - Running setup.py (path:/tmp/pip-wuiTq3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:23:25 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)) 16:23:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:23:25 INFO - Running setup.py (path:/tmp/pip-CV7KXA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:23:25 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)) 16:23:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:23:25 INFO - Running setup.py (path:/tmp/pip-SyB3Ml-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:23:25 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)) 16:23:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:23:25 INFO - Running setup.py (path:/tmp/pip-7PluP5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:23:25 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)) 16:23:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:23:25 INFO - Running setup.py (path:/tmp/pip-JPwEVq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:23:25 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)) 16:23:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:23:25 INFO - Running setup.py (path:/tmp/pip-PorC6U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:23:25 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)) 16:23:25 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)) 16:23:25 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)) 16:23:25 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)) 16:23:25 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)) 16:23:25 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)) 16:23:25 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)) 16:23:25 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 16:23:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:23:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:23:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:23:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:23:26 INFO - Downloading blessings-1.6.tar.gz 16:23:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 16:23:27 INFO - Installing collected packages: blessings 16:23:27 INFO - Running setup.py install for blessings 16:23:27 INFO - Successfully installed blessings 16:23:27 INFO - Cleaning up... 16:23:27 INFO - Return code: 0 16:23:27 INFO - Done creating virtualenv /builds/slave/test/build/venv. 16:23:27 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:23:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:23:27 INFO - Reading from file tmpfile_stdout 16:23:27 INFO - Current package versions: 16:23:27 INFO - argparse == 1.2.1 16:23:27 INFO - blessings == 1.6 16:23:27 INFO - blobuploader == 1.2.4 16:23:27 INFO - docopt == 0.6.1 16:23:27 INFO - functools32 == 3.2.3-2 16:23:27 INFO - jsonschema == 2.5.1 16:23:27 INFO - manifestparser == 1.1 16:23:27 INFO - mozInstall == 1.13 16:23:27 INFO - mozcrash == 1.0 16:23:27 INFO - mozdebug == 0.1 16:23:27 INFO - mozdevice == 0.51 16:23:27 INFO - mozfile == 1.2 16:23:27 INFO - mozhttpd == 0.7 16:23:27 INFO - mozinfo == 0.10 16:23:27 INFO - mozleak == 0.1 16:23:27 INFO - mozlog == 3.5 16:23:27 INFO - moznetwork == 0.27 16:23:27 INFO - mozprocess == 0.25 16:23:27 INFO - mozprofile == 0.28 16:23:27 INFO - mozrunner == 6.13 16:23:27 INFO - mozscreenshot == 0.1 16:23:27 INFO - mozsystemmonitor == 0.3 16:23:27 INFO - moztest == 0.8 16:23:27 INFO - mozversion == 1.4 16:23:27 INFO - psutil == 3.1.1 16:23:27 INFO - requests == 1.2.3 16:23:27 INFO - wsgiref == 0.1.2 16:23:27 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:23:27 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')]} 16:23:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:23:27 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')]} 16:23:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:23:27 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 0x22b21f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23b6a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2559ef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25570b0>, '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 0x2557fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2558440>, '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': '52faae308a556c440401f8e5000001e8-1502921579.399767-1660496627', '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 16:23:27 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 16:23:27 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 16:23:27 INFO - Using env: {'DISPLAY': ':0', 16:23:27 INFO - 'HOME': '/home/cltbld', 16:23:27 INFO - 'LANG': 'en_US.UTF-8', 16:23:27 INFO - 'LANGUAGE': 'en_US:en', 16:23:27 INFO - 'LOGNAME': 'cltbld', 16:23:27 INFO - 'MAIL': '/var/mail/cltbld', 16:23:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:23:27 INFO - 'MOZ_NO_REMOTE': '1', 16:23:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:23:27 INFO - 'NO_EM_RESTART': '1', 16:23:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:23:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:23:27 INFO - 'PWD': '/builds/slave/test', 16:23:27 INFO - 'SHELL': '/bin/bash', 16:23:27 INFO - 'SHLVL': '1', 16:23:27 INFO - 'TERM': 'linux', 16:23:27 INFO - 'TMOUT': '86400', 16:23:27 INFO - 'USER': 'cltbld', 16:23:27 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1502921579.399767-1660496627', 16:23:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:23:27 INFO - '_': '/tools/buildbot/bin/python'} 16:23:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:23:27 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)) 16:23:27 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)) 16:23:27 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)) 16:23:27 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)) 16:23:27 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)) 16:23:27 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)) 16:23:27 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)) 16:23:27 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)) 16:23:27 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)) 16:23:27 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 16:23:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:23:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:23:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:23:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:23:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 16:23:28 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)) 16:23:28 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)) 16:23:28 INFO - Installing collected packages: simplejson 16:23:28 INFO - Running setup.py install for simplejson 16:23:28 INFO - building 'simplejson._speedups' extension 16:23:28 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 16:23:29 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 16:23:29 INFO - Successfully installed simplejson 16:23:29 INFO - Cleaning up... 16:23:29 INFO - Return code: 0 16:23:29 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 16:23:29 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')]} 16:23:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:23:29 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')]} 16:23:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:23:29 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 0x22b21f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23b6a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2559ef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25570b0>, '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 0x2557fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2558440>, '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': '52faae308a556c440401f8e5000001e8-1502921579.399767-1660496627', '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 16:23:29 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 16:23:29 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 16:23:29 INFO - Using env: {'DISPLAY': ':0', 16:23:29 INFO - 'HOME': '/home/cltbld', 16:23:29 INFO - 'LANG': 'en_US.UTF-8', 16:23:29 INFO - 'LANGUAGE': 'en_US:en', 16:23:29 INFO - 'LOGNAME': 'cltbld', 16:23:29 INFO - 'MAIL': '/var/mail/cltbld', 16:23:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:23:29 INFO - 'MOZ_NO_REMOTE': '1', 16:23:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:23:29 INFO - 'NO_EM_RESTART': '1', 16:23:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:23:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:23:29 INFO - 'PWD': '/builds/slave/test', 16:23:29 INFO - 'SHELL': '/bin/bash', 16:23:29 INFO - 'SHLVL': '1', 16:23:29 INFO - 'TERM': 'linux', 16:23:29 INFO - 'TMOUT': '86400', 16:23:29 INFO - 'USER': 'cltbld', 16:23:29 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1502921579.399767-1660496627', 16:23:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:23:29 INFO - '_': '/tools/buildbot/bin/python'} 16:23:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:23:30 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 16:23:30 INFO - Cleaning up... 16:23:30 INFO - Return code: 0 16:23:30 INFO - Running post-action listener: _resource_record_post_action 16:23:30 INFO - Running post-action listener: _start_resource_monitoring 16:23:30 INFO - Starting resource monitoring. 16:23:30 INFO - [mozharness: 2017-08-16 23:23:30.159471Z] Finished create-virtualenv step (success) 16:23:30 INFO - [mozharness: 2017-08-16 23:23:30.160065Z] Running install step. 16:23:30 INFO - Running pre-action listener: _resource_record_pre_action 16:23:30 INFO - Running main action method: install 16:23:30 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:23:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:23:30 INFO - Reading from file tmpfile_stdout 16:23:30 INFO - Detecting whether we're running mozinstall >=1.0... 16:23:30 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 16:23:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 16:23:30 INFO - Reading from file tmpfile_stdout 16:23:30 INFO - Output received: 16:23:30 INFO - Usage: mozinstall [options] installer 16:23:30 INFO - Options: 16:23:30 INFO - -h, --help show this help message and exit 16:23:30 INFO - -d DEST, --destination=DEST 16:23:30 INFO - Directory to install application into. [default: 16:23:30 INFO - "/builds/slave/test"] 16:23:30 INFO - --app=APP Application being installed. [default: firefox] 16:23:30 INFO - mkdir: /builds/slave/test/build/application 16:23:30 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'] 16:23:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 16:23:49 INFO - Reading from file tmpfile_stdout 16:23:49 INFO - Output received: 16:23:49 INFO - /builds/slave/test/build/application/firefox/firefox 16:23:49 INFO - Running post-action listener: _resource_record_post_action 16:23:49 INFO - [mozharness: 2017-08-16 23:23:49.650022Z] Finished install step (success) 16:23:49 INFO - [mozharness: 2017-08-16 23:23:49.650303Z] Running setup-mitmproxy step. 16:23:49 INFO - Running pre-action listener: _resource_record_pre_action 16:23:49 INFO - Running main action method: setup_mitmproxy 16:23:49 INFO - Skipping: mitmproxy is not required 16:23:49 INFO - Running post-action listener: _resource_record_post_action 16:23:49 INFO - [mozharness: 2017-08-16 23:23:49.651452Z] Finished setup-mitmproxy step (success) 16:23:49 INFO - [mozharness: 2017-08-16 23:23:49.651674Z] Running run-tests step. 16:23:49 INFO - Running pre-action listener: _resource_record_pre_action 16:23:49 INFO - Running pre-action listener: _set_gcov_prefix 16:23:49 INFO - Running main action method: run_tests 16:23:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 16:23:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 16:23:49 INFO - Python 2.7.3 16:23:49 INFO - Return code: 0 16:23:49 INFO - grabbing minidump binary from tooltool 16:23:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:23:49 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 0x25570b0>, '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 0x2557fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2558440>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 16:23:49 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 16:23:49 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 16:23:49 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 16:23:49 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 16:23:49 INFO - Return code: 0 16:23:49 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 16:23:49 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 16:23:49 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 16:23:49 INFO - ENV: RUST_BACKTRACE is now full 16:23:49 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 16:23:49 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 16:23:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/MwNIxikqQeW7ZnNry6c34A/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-056', '--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 16:23:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/MwNIxikqQeW7ZnNry6c34A/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-056 --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 16:23:49 INFO - Using env: {'DISPLAY': ':0', 16:23:49 INFO - 'HOME': '/home/cltbld', 16:23:49 INFO - 'LANG': 'en_US.UTF-8', 16:23:49 INFO - 'LANGUAGE': 'en_US:en', 16:23:49 INFO - 'LOGNAME': 'cltbld', 16:23:49 INFO - 'MAIL': '/var/mail/cltbld', 16:23:49 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 16:23:49 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 16:23:49 INFO - 'MOZ_ACCELERATED': '1', 16:23:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:23:49 INFO - 'MOZ_NO_REMOTE': '1', 16:23:49 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 16:23:49 INFO - 'MOZ_WEBRENDER': '1', 16:23:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:23:49 INFO - 'NO_EM_RESTART': '1', 16:23:49 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:23:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:23:49 INFO - 'PWD': '/builds/slave/test', 16:23:49 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 16:23:49 INFO - 'RUST_BACKTRACE': 'full', 16:23:49 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 16:23:49 INFO - 'SHELL': '/bin/bash', 16:23:49 INFO - 'SHLVL': '1', 16:23:49 INFO - 'TERM': 'linux', 16:23:49 INFO - 'TMOUT': '86400', 16:23:49 INFO - 'USER': 'cltbld', 16:23:49 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1502921579.399767-1660496627', 16:23:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:23:49 INFO - '_': '/tools/buildbot/bin/python'} 16:23:49 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/MwNIxikqQeW7ZnNry6c34A/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-056', '--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 16:23:50 INFO - mozversion application_buildid: 20170816223054 16:23:50 INFO - mozversion application_changeset: 1d38626ba9686d119e489db538ce84f8f9854217 16:23:50 INFO - mozversion application_display_name: Nightly 16:23:50 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 16:23:50 INFO - mozversion application_name: Firefox 16:23:50 INFO - mozversion application_remotingname: firefox 16:23:50 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 16:23:50 INFO - mozversion application_vendor: Mozilla 16:23:50 INFO - mozversion application_version: 57.0a1 16:23:50 INFO - mozversion platform_buildid: 20170816223054 16:23:50 INFO - mozversion platform_changeset: 1d38626ba9686d119e489db538ce84f8f9854217 16:23:50 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 16:23:50 INFO - mozversion platform_version: 57.0a1 16:23:50 INFO - using testdate: 1502925830 16:23:50 INFO - actual date: 1502925830 16:23:50 INFO - starting webserver on 'localhost:47036' 16:23:50 INFO - SUITE-START | Running 2 tests 16:23:50 INFO - TEST-START | dromaeo_css 16:23:50 INFO - Initialising browser for dromaeo_css test... 16:23:50 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:47036/getInfo.html -profile /tmp/tmpqDyrxn/profile 16:23:50 INFO - TEST-INFO | started process 6580 (/builds/slave/test/build/application/firefox/firefox http://localhost:47036/getInfo.html) 16:23:57 INFO - TEST-INFO | 6580: exit 0 16:23:58 INFO - Browser initialized. 16:23:58 INFO - Running cycle 1/1 for dromaeo_css test... 16:23:58 INFO - TEST-INFO | started process 6802 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpqDyrxn/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 16:23:58 INFO - PID 6802 | WebRender - OpenGL version new 3.2.0 NVIDIA 361.42 16:23:59 INFO - PID 6802 | WebRender - OpenGL version new 3.2.0 NVIDIA 361.42 16:23:59 INFO - PID 6802 | 16:23:59 INFO - PID 6802 | (/builds/slave/test/build/application/firefox/firefox:6862): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 16:23:59 INFO - PID 6802 | 16:24:09 INFO - PID 6802 | RSS: Main: 195055616 16:24:09 INFO - PID 6802 | 16:24:13 INFO - PID 6802 | WebRender - OpenGL version new 3.2.0 NVIDIA 361.42 16:27:09 INFO - PID 6802 | Cycle 1(1): loaded http://localhost:47036/tests/dromaeo/cssquery-dojo.html (next: http://localhost:47036/tests/dromaeo/cssquery-ext.html) 16:27:10 INFO - PID 6802 | RSS: Main: 227741696 16:27:10 INFO - PID 6802 | 16:30:12 INFO - PID 6802 | Cycle 1(1): loaded http://localhost:47036/tests/dromaeo/cssquery-ext.html (next: http://localhost:47036/tests/dromaeo/cssquery-jquery.html) 16:30:13 INFO - PID 6802 | RSS: Main: 273117184 16:30:13 INFO - PID 6802 | 16:33:15 INFO - PID 6802 | Cycle 1(1): loaded http://localhost:47036/tests/dromaeo/cssquery-jquery.html (next: http://localhost:47036/tests/dromaeo/cssquery-mootools.html) 16:33:16 INFO - PID 6802 | RSS: Main: 278482944 16:33:16 INFO - PID 6802 | 16:36:18 INFO - PID 6802 | Cycle 1(1): loaded http://localhost:47036/tests/dromaeo/cssquery-mootools.html (next: http://localhost:47036/tests/dromaeo/cssquery-prototype.html) 16:36:18 INFO - PID 6802 | RSS: Main: 276221952 16:36:18 INFO - PID 6802 | 16:39:23 INFO - PID 6802 | Cycle 1(1): loaded http://localhost:47036/tests/dromaeo/cssquery-prototype.html (next: http://localhost:47036/tests/dromaeo/cssquery-yui.html) 16:39:23 INFO - PID 6802 | RSS: Main: 279248896 16:39:23 INFO - PID 6802 | 16:42:25 INFO - PID 6802 | Cycle 1(1): loaded http://localhost:47036/tests/dromaeo/cssquery-yui.html (next: http://localhost:47036/tests/dromaeo/cssquery-dojo.html) 16:42:26 INFO - PID 6802 | RSS: Main: 280580096 16:42:26 INFO - PID 6802 | 16:42:26 INFO - PID 6802 | __start_tp_report 16:42:26 INFO - PID 6802 | _x_x_mozilla_page_load 16:42:26 INFO - PID 6802 | _x_x_mozilla_page_load_details 16:42:26 INFO - PID 6802 | |i|pagename|runs| 16:42:26 INFO - PID 6802 | |0;dojo.html;3125.2186953261685;3162.683731626839;3171.873125074997;3182.4908014717644;3193.961962362233;5969.164316995624;6029.246344206974;6130.846728831782;6144.723487443064;6157.076438534216;6038.003729384646;6092.908606370908;6100.328963813977;6109.755609775603;6133;5548.833534993936;5555.30558680165;5577.9163312550245;5602.215689803431;5606.523445507137;5568.86077848053;5589.888202235953;5592.86017849555;5593.328800543941;5598.020346439377;5542.196381524676;5572.498475137237;5582.078956972095;5589.04986152353;5589.217509548646;5485.917711234335;5576.0241957657245;5586.497215250627;5600.52395546379;5602.411746766572;5618.943810561924;5652.0391533439415;5689.857753556153;5719.742611582447;5724.713764311768;5848.561357898175;5862.413758624146;5946.316173640043;5995.850103747442;6085.786997455112;6481.189851268591;6494.253160886511;6576.6382848943285;6655.76704815334;6658.733650654017;6591.967040164816;6616.603003819738;6645.3686899744935;6683.565568238049;6695.832604184886;6107.8473038173515;6154.26148862135;6164.198654174928;6171.475424588871;6179.721912513947;6795.558288711218;6807.795766127024;6824.624645644537;6830.453563714891;6850.040994260808;6413.198350206224;6463.935360646427;6464.741410343628;6470.676466176672;6502.284748677642;6544.214694236722;6567.605943643397;6584.670766461658;6591.110200123018;6672.2994085621285;6530.640814755234;6536;6568.080468734381;6611.768588099393;6617.9669101655145;6419.903701444482;6477.060826180177;6487.610743355413;6517.087607734921;6618.338166183439;5324.334458192726;5443.156310771837;5444.128939369761;5447;5449.972750136303;4608.861734147981;4664.603508701731;4665.533446655375;4672.789724462407;4705.576498115186;5673.716314184357;5720.2849643794525;5766.855828604318;5787.421257874179;5798.275215598051;6535.150430444107;6580.967095164494;6591.505637077238;6637.137172167587;6740.730370785212;5631.831045068655;5652.349979752299;5657.094864821609;5667.149927510906;5693.743781529841;5753.482186603226;5873.353931067579;5879.029960056629;5880.235569375954;5945.970270148621;6464.676766161673;6472.255690595548;6493.935060649427;6498.155239818793;6518.967405162944;6689;6713.56361836479;6735.764248251287;6740.325967403221;6741.59550426976;6398.4561312287115;6419.903701444388;6465.77369792055;6474.384933431316;6519.869602608016;6410.423061924449;6545;6563.146790917151;6638.435732962752;6644.435223006099;6364.840878977878;6404.359564043559;6427.453666438405;6437.324080971618;6449.516286278454;5921.585489015728;6237.376262373908;6288.937110628835;6302.338254483397;6308.27454842699;6123.234595675541;6408.423241908251;6437.581557198767;6547.0179473079415;6562.081308616893;6312.147860038836;6331.556791024584;6407.103005579316;6477.4170324671;6494.805155845333;6344.841378965378;6421.7110230038825;6429.517786165963;6442.967785161044;6522.28254891952;6194.287656919512;6215.160953271251;6222.906656400067;6267.341929097562;6269.40440658155 16:42:26 INFO - PID 6802 | |1;ext.html;806.0931452116369;820.6430202861759;838.9790255243618;862.9956850215744;863.7365603490935;42723.35914961274;42858.35712464315;43485;43661.345079823746;43759.34360984584;39351;39494.210115797665;39813.203735925264;39931.800340998256;40167.19665606686;6658.833529161773;6808.965955170217;6820.283870193608;6829.351211634887;6838.452923766112;6773.390394864461;6856.554323968951;6860.03959445678;6872.381485666289;6876.140482439695;6827.692753826065;6834.589924604539;6851.623160726158;6857.759978400757;7569.470137090406;7637.961810190941;7659.425543084263;7707.6916923323;7708.997830282027;7726.188750181263;7592.544447333178;7598.316151546332;7687.077550693896;7692.999910011718;7693.884591731128;39411.40882886759;40282;40341.79829100836;40849;41239.58760412387;3493.8602455901732;3511.438169892805;3539.628339024391;3546.7694599851184;3550.8757193498104;32230.838845805854;32465;32501.349973000644;32567.51148732771;32930.670693293;5026.773795179226;5067.670601410897;5118.897622047575;5132.101882170605;5144.331236939174;218867;222546;222991;223689;223990.99999999837;51975;51978.22032669513;52000;52040;52097.479025209264;54140;54398;54689.453105468434;54710.45289547133;54942.17586736202;15767.448139315069;15847.445339413065;15972.440964566184;16023;16313.184340782913;12823.487060517475;12923.676908077374;12936.482540698267;12961.15752476086;12984.67538311531;14629.85370146285;14781.408743650134;14822.777658335133;14866.851331486547;15115.31981060833;5905.822825315247;5938.910916336258;5945.613535120204;6000.759969601167;6022.488088512438;1001.3941565352857;1011.0597144655394;1016.3749294184023;1036.3781730961364;1045.0281238448165;22853.657195142085;23044.308670739905;23366;23519.88240058789;23577;1095.2114477576133;1100.7248187953012;1104.9226554141294;1108.7117349489029;1139.8316725356576;12226.748065450989;12259.774022597669;12304.677737010958;12485.625431237077;12705.618831435071;223056;224104;224255;224687;224995;47550;48783.51216487861;53877.73061134669;54321.45678543243;54584.72707636436;1466.9339879705226;1472.3963175098372;1479.948201812953;1487.4570781664615;1497.1466264229502;27032.864835675697;27254.727452726012;27471.17586472409;27713.307167320978;28024.29939251535;38156.61843381642;38178.42732358961;38212.808935955145;38244.80877595594;38276.425853612775;194596;194892;195311;195639;196003;34271;35314.64685353216;35354.29291414209;35461.82269088638;35806.10484737798;45172;45303.54696453125;45590;45603;45977.77011115057;34994.825025875725;35164;35594;35897;36204.45693314655;34897.12757181091;35078.47382289216;35278.70688405245;35390.29219415546;35611.28777424385;39113;39318.803405982784;39430;39689.80155099206;39807.40288895611;33198;33606;34503.13742156366;35172.64827351796;35194.82402587971;24282.554107377793;24394;24887.253382398558;25070;25139 16:42:26 INFO - PID 6802 | |2;jquery.html;558.5196730811501;568.6445971267955;572.8281515545335;574.8649067469147;584.1967294969417;22331.218407355726;22804.08783648652;22964.88517557412;23242.65136022961;23291.534169316645;18483.168257428413;21237.787622123775;23093.307200784002;23229.88385058072;23315.417114572145;6423.454006409449;6604.966975165117;6629.237637671681;6640.236372817116;6655.600663960154;5856.063029915214;6186.103015062836;6512.967435162817;6634.933650663504;6646.60120392778;6434.935650643504;6436.034594810769;6444.323346048668;6451.870962580746;6469.74121035158;6435.034744788272;6437.034444833265;6444.935550644504;6449.419552240321;6470.967645161792;6001.789937352171;6008.3390827009;6014.939850601481;6016.639001659914;6021.36775638556;27136.864315678296;28491.860325586953;28494.145175644764;28840.134795955946;29151.125466236048;1899.2118270917554;1953.7655481342188;1957.843372530194;1958.8237058664647;1965.3809050149157;19026.90486547572;19455.708164377545;19469.318573849847;19520.414387568395;19544;2258.0741895822634;2412.1316326122583;2420.6490058941354;2439.6096624539987;2452.865092419916;132298.33850830683;136145;136220;136526;136570.31714841462;14639.201969166974;14848.034877732913;14999.325030373659;15022.774658380133;15113.773293400607;22573.54852902933;22618.773812261996;22663;22713.205037823598;22837.20069797549;9994.10053095225;10253.84619230712;10417.479126043667;10496.632617858339;10564.788704225872;9658;9697.224222062217;9737.707868763948;9742.902570974342;9816.165625921734;7655.885161722578;8820.897387826522;9083.318751093562;9108.407953483002;9226.677066302647;2648.695400028983;2696.7168447313143;2708.810383273152;2719.5648696208514;2741.629879966179;960.2030314838668;961.7643677299106;970.1220395542045;976.8388215944432;978.858065580501;19067.713984290247;19073.523161920784;19247.23011079541;19392.70910936337;19615.901920490305;1021.7088129882948;1036.9481525923673;1037.0873631204493;1041.7760181561;1049.3913530152493;10527.789444211227;10591.523381447852;10895.237333386587;10931.125509959184;11180.552777888794;450228;451598;457700;489055;508948;118738.40630796964;122832.38583807024;123579;125900;127322;1214.8238505416666;1220.4934951994824;1261.6278197931815;1261.9621411357673;1266.0757646917803;19777.60444791125;20197.394078177676;20537.075831587914;20633.555651104878;21168.78831211668;56322.7183864078;57084.71457642685;58397.70801145967;58858;59397;69022.30977690159;77559.61220193862;79059;79965;80240.19759802561;14195.219262940638;14661.853381466475;14776.33506492189;14786.408543658134;14803.555893323217;22503.09987600543;22643.320700379016;22652.886735566215;23078.884605576866;23149.3055208344;18270.45188644343;18315.267389304277;18477.260909564004;18506;18612.255509779457;16292.755608665642;16620.501384958472;16946.745798812783;16960.491185264462;17269.481915542554;17783.73324400109;18920;19005.144768485174;19145.425637230906;19500.902495487433;14668.119912805267;14719.705605888037;14858.777118343449;14886.25568721538;14888;18310.26758929628;18511;18795.06024698787;18990.1454434548;19089.618207635493 16:42:26 INFO - PID 6802 | |3;mootools.html;1331.6670832291927;1372.3618517389411;1389.4789453954768;1392.7214557088585;1407.7395681798862;14134.64663383416;14307.427702891871;14684.339204735787;14792.482263120794;14844.257787110655;13998.930005349985;14313.284335783195;14344.28278586069;14425;14430.855691443083;2650.787936965043;2699.622052912594;2703.3917368592106;2718.768904643108;2729.972700272992;2582.715901250861;2646.4045589742345;2698.231004163814;2744.2316151477617;2745.629340039089;2554.1443616388533;2618.293060873563;2633.117905501659;2651.231142968537;2677.4377380750066;2583.3154214133174;2597.142942828862;2610.0864697355773;2610.2038878142157;2617.5026744918405;2540.593505039185;2542.0975553678363;2563.2310306907852;2565.8332208406396;2575.1244576843965;14002.859971400258;14242.715145697131;14281.714365712627;14294.070885392417;14294.785578216335;7398.630068496607;7628.31345178931;7685.615719214073;7747.728829490997;7759.9612001940195;4960.982998485302;5032.572231360339;5053.36832895888;5176.094183517907;5182.507661772125;1900.7053906644492;1916.2239293086323;1945.9005661801036;1945.9221631134737;1986.106252186522;23705;24000.519989600285;24014.15950441726;24077.39806504834;24108.156214532406;6225.906611400833;6408.359164083555;6412.2625898022325;6524.934750652527;6580.605163690194;16434.83565164357;16500.42248521296;16583.087930163714;16586.668266634842;16604.920680155752;7426.405887528985;7564.281393267631;7570.091589009244;7570.356519695777;7589.468737188454;5974.2233509643465;6041.939580604226;6279.152314437584;6319.58922670025;6330.905036424458;5191.714455704972;5216.765245563959;5308.442613525602;5312.92030619541;5329.307190065267;1475.6310922269433;1518.422999260274;1523.1470376589145;1525.603343130794;1543.1127101916218;852.1563651984491;871.834351473218;886.3441053620403;890.9599068041954;896.171041786358;6865.897011544831;7052.612106334098;7055.118110236221;7071.7878463646175;7122.608256545836;648.3872740260408;656.7668477690447;658.8748137853793;660.1187414801199;666.5367569539123;4516.503184649686;4850.902981940341;4888.315635810989;4971.403431588233;5137.588992880561;19734.506637334183;20368.69446958297;20478.18087276522;20656.896715516326;20684.689729654066;20214.696779548318;20343.898280508503;20416.897915510624;20622.484437889172;20642.380728578166;10248;10595.735106622396;10940.890591093987;10960.890391095987;11114.944425277983;7442.590657513889;7577.734779282699;7694.846103077795;7731.6520756567215;7777.611119444118;16674.749878751587;16847.663046739242;17153.313867445162;17347;17448.21483033241;17081.914590426968;17367.7394839075;17438.738418923473;17543.912280438515;17746.20142093583;10318.948405258227;10501.582286391545;10588.417637030037;10591.099756520782;10647.787044258917;12953.158044727063;13027.218366898016;13150.079494435298;13182.80225796633;13284;10802;10900.108074725978;10929.56281748753;11088.334699917708;11212.887871121511;10148.847767283349;10490.895091049297;10492.317999330018;10543.420111893613;10704.839427408438;9199.724008279762;9399.530023498934;9423.905760942303;9490.240780737662;9515.666951656658;6655.534112612264;6751.797446076625;6809.727610895508;6812.284710105368;6835.077264569419;6800.727970881308;6886.8622627548175;6936.237013928565;6960.129983752031;7024.929750702428 16:42:26 INFO - PID 6802 | |4;prototype.html;493.7679290733356;507.5787096709731;533.0671325180933;533.4665334665335;541.2449632762294;5991.161237426752;6069.60547564408;6150.907736383958;6189.1644627975265;6221.284552276489;5940.316863560692;5971.1043343498495;6054.969725151368;6102.969485152579;6104.664243466618;4858.732769697665;4863.635227357945;4884.633652476078;4885.120678277917;4928.654994150411;4874.147024270738;4878.902421951559;4884.753013613742;4940.703557786526;4943.332650092246;4781.521847815226;4847.951520484785;4872.829450969217;4872.9756351218375;4875.463698993108;4829.541193586604;4852.660313778019;4866.902661946741;4896.877578060541;4897;4339.696221264513;4350.260455722503;4386.649068074546;4402.361657559668;4422.889427764299;5877.441643043904;5962.642241465483;5984.281886173643;6028.367021462771;6036.456718895277;5565.693886836222;5634.126710359901;5657.547396208293;5664.122061080539;5691.26013618227;6370.4266616004315;6475.179644010057;6494.480441564663;6503.187101612299;6534.921737913286;4776.09254241693;4776.805798550363;4791.7124972501415;4797.736124513151;4825.710457372569;6775.186977562675;6787.879999800027;6829.248782633907;6906.411525349147;7001.894971575482;4882.438519570223;4932.827351042696;4948.752562371939;4971.90056198874;5002.74986250686;4957.454679985199;4978.5270399312;4988.850334489971;5002.1496345621335;5013.423456302572;5580.525655319343;5596.944030559724;5620.156976453564;5632.324121105494;5641.84342209846;6432.807015789534;6479.060536222316;6536.869262614721;6563.212414510193;6605;1653.4047742812577;1676.7484877268507;1746.4062218845654;1756.2535922233;1757.8242175782575;1171.84765980422;1210.431097384228;1215.523139385633;1217.5251651855783;1222.896053835434;5555.694436806015;5646.181303711021;5653.943460565424;5673.205751194836;5678.886422271531;6544.869102617921;6577.440917521969;6604.084815403479;6670.666466676744;6685.130932978682;5613.691246981373;5616.9157462638095;5620.859478512988;5632.887342253132;5714.9714251429305;3502.3188869342857;3530.8234588271;3536.4164912789615;3543.75193736436;3578.8210589470423;6422.935770642233;6464.806055818333;6470.993991862538;6505.316941721051;6510.47916166715;6815.522913396114;6825.35159159879;6852.314768523108;6879.690413931385;6886.621235832077;6361.650109244036;6408.455281300955;6447.065175549519;6448.709808058648;6512.837179070656;6600.636964966973;6625.304343043911;6632.938729803208;6638.933610664025;6716.664166791543;6492.415682588589;6498.3826536478955;6606.933930660632;6618.205815302194;6637.1703537057865;6456.127023474509;6462.741490340334;6495.415412612888;6524.184476940382;6550.7707230246715;4959.3552838132255;4970.701757894538;4990.477904239242;5003.499650034967;5010.799568017239;6595.472362210916;6628.138342015507;6659.37173664318;6684.398404143456;6732.528722989344;6423.4861211103935;6433.941138835527;6445.774397896051;6456.644884531396;6502.382273683992;6360.363963603602;6433.549651524536;6439.967800160969;6463.709133089116;6549.574277671936;5844.853878653068;6306.653134077486;6336.366363363627;6372.203474565679;6453.225612926291;6452.096706461193;6503.317151699192;6528.281888992112;6538.967305163444;6551.901721474277;6244.0321750128805;6311.463525600376;6351.745930162741;6374.4263016326895;6425.261094973951 16:42:26 INFO - PID 6802 | |5;yui.html;916.1205242966753;925.1858364639116;934.7195841247624;937.1565590968132;946.7207173883704;19494.610107797835;19861.900690496564;20074.297399591018;20100.59798804023;20175;17796.288148474046;19728.408147755556;19871.900640496777;19887.70168447471;19916.402507924784;1018.2668478695327;1035.5754140802235;1050.144132531988;1051.5057922776282;1051.6319288249128;970.7233438470038;1071.6517131932114;1072.3565860483725;1073.2701762801291;1078.1967434261446;1125.0212315285712;1131.519104380639;1131.8302254661826;1132.513019401657;1133.773245350929;1117.944102794861;1117.966461006163;1120.775844831029;1127.9266847654917;1129.1531351486385;813.4021494201756;817.1256755271861;817.190980928882;818.4598165210991;818.66434761748;18302.816971830376;19124.521886952938;19968.500787480283;20247.4938126548;20331;21483.46291342729;21701.565968680537;21930.89034554833;21959;22011.449713757283;16826.83173168265;16963.3214671413;16973.660526789517;17124.40064597733;17224;3578.874739384135;3592.2815436912724;3592.497050412944;3594.946075808865;3597.80212088335;122820.38589806994;126942;127057.36471317676;128345;129571;16816;16970.490885273462;17315;17449.651006979788;17500;30456.390872182434;30994.59059503453;31326.686733132832;31352.529712054336;31552.053438396426;8510.531920744419;8880.023197448276;8916.465012099165;8927.24118449939;8969.865452018224;4010.438538604598;4042.3532234842282;4100.2619528484565;4197.97901010493;4225.978870105691;4541.159885421208;4749.715017098985;4948.851534453972;5117.513836185556;5372.1941708744;983.1201075037801;990.2622546203124;1011.3982180602529;1019.1133713669155;1020.6274709730894;664.5049438168498;675.8445557521798;685.0751485494543;689.7654797368818;691.6921969723425;10781.62264320745;11952.581659642045;12046.976007039324;12428.75142497145;12746.745065098832;618.8916939535563;640.5292110298926;642.5373730913734;647.4593714248655;655.3250152343094;5959.225300710967;6187.783427580013;6455.838604034842;6492.935070649233;6579.967100164468;99256.5037174824;102502.48748756357;105197.47401262945;106301;111611;95374;95435;95464.52267738756;97343;98359.50820245853;81087.18912810796;83142;84064;85738.85652858604;85916.57041714751;13210.339483026002;13210.933945330213;13328.866711332763;13412.463501459832;13519.256440895846;38984.610153898095;40073.398899015956;40778.592214078664;41086;41234.79382603188;49866;51132.48867511277;51166.74416627893;51982.480175197765;52615.21077183922;18779.15493802755;18790.624187516445;18848;18890.905545472186;19246.7112993308;20585.382438526867;20835.79164208399;20946.58106837885;21235.088842003675;21645.567088658452;19155.712664310326;19256.903715481334;19621.411357659294;19646.115924783135;19939;17688.55778605494;17741;18035.81964180394;18069.186886589872;18252.81747182511;17728.46814595564;18071.909640451715;18129.728054079464;18207.90896045511;18438;13159.407826647632;13202.207867527979;13331.200127992352;13501.729965400833;13572.04995650295;13710.931445343109;13913.721725565634;13946.093503922213;13992.580222593338;14061.789073164115 16:42:26 INFO - PID 6802 | __end_tp_report 16:42:26 INFO - PID 6802 | __start_cc_report 16:42:26 INFO - PID 6802 | _x_x_mozilla_cycle_collect,376 16:42:26 INFO - PID 6802 | __end_cc_report 16:42:26 INFO - PID 6802 | __startTimestamp1502926946081__endTimestamp 16:42:26 INFO - PID 6802 | 16:42:26 INFO - PID 6802 | ------- Summary: start ------- 16:42:26 INFO - PID 6802 | Number of tests: 6 16:42:26 INFO - PID 6802 | 16:42:26 INFO - PID 6802 | [#0] dojo.html Cycles:165 Average:6058.82 Median:6269.40 stddev:703.51 (11.2%) stddev-sans-first:666.97 16:42:26 INFO - PID 6802 | Values: 3125.2 3162.7 3171.9 3182.5 3194.0 5969.2 6029.2 6130.8 6144.7 6157.1 6038.0 6092.9 6100.3 6109.8 6133.0 5548.8 5555.3 5577.9 5602.2 5606.5 5568.9 5589.9 5592.9 5593.3 5598.0 5542.2 5572.5 5582.1 5589.0 5589.2 5485.9 5576.0 5586.5 5600.5 5602.4 5618.9 5652.0 5689.9 5719.7 5724.7 5848.6 5862.4 5946.3 5995.9 6085.8 6481.2 6494.3 6576.6 6655.8 6658.7 6592.0 6616.6 6645.4 6683.6 6695.8 6107.8 6154.3 6164.2 6171.5 6179.7 6795.6 6807.8 6824.6 6830.5 6850.0 6413.2 6463.9 6464.7 6470.7 6502.3 6544.2 6567.6 6584.7 6591.1 6672.3 6530.6 6536.0 6568.1 6611.8 6618.0 6419.9 6477.1 6487.6 6517.1 6618.3 5324.3 5443.2 5444.1 5447.0 5450.0 4608.9 4664.6 4665.5 4672.8 4705.6 5673.7 5720.3 5766.9 5787.4 5798.3 6535.2 6581.0 6591.5 6637.1 6740.7 5631.8 5652.3 5657.1 5667.1 5693.7 5753.5 5873.4 5879.0 5880.2 5946.0 6464.7 6472.3 6493.9 6498.2 6519.0 6689.0 6713.6 6735.8 6740.3 6741.6 6398.5 6419.9 6465.8 6474.4 6519.9 6410.4 6545.0 6563.1 6638.4 6644.4 6364.8 6404.4 6427.5 6437.3 6449.5 5921.6 6237.4 6288.9 6302.3 6308.3 6123.2 6408.4 6437.6 6547.0 6562.1 6312.1 6331.6 6407.1 6477.4 6494.8 6344.8 6421.7 6429.5 6443.0 6522.3 6194.3 6215.2 6222.9 6267.3 6269.4 16:42:26 INFO - PID 6802 | 16:42:26 INFO - PID 6802 | [#1] ext.html Cycles:180 Average:39073.70 Median:35602.64 stddev:55561.52 (156.1%) stddev-sans-first:55643.08 16:42:26 INFO - PID 6802 | Values: 806.1 820.6 839.0 863.0 863.7 42723.4 42858.4 43485.0 43661.3 43759.3 39351.0 39494.2 39813.2 39931.8 40167.2 6658.8 6809.0 6820.3 6829.4 6838.5 6773.4 6856.6 6860.0 6872.4 6876.1 6827.7 6834.6 6851.6 6857.8 7569.5 7638.0 7659.4 7707.7 7709.0 7726.2 7592.5 7598.3 7687.1 7693.0 7693.9 39411.4 40282.0 40341.8 40849.0 41239.6 3493.9 3511.4 3539.6 3546.8 3550.9 32230.8 32465.0 32501.3 32567.5 32930.7 5026.8 5067.7 5118.9 5132.1 5144.3 218867.0 222546.0 222991.0 223689.0 223991.0 51975.0 51978.2 52000.0 52040.0 52097.5 54140.0 54398.0 54689.5 54710.5 54942.2 15767.4 15847.4 15972.4 16023.0 16313.2 12823.5 12923.7 12936.5 12961.2 12984.7 14629.9 14781.4 14822.8 14866.9 15115.3 5905.8 5938.9 5945.6 6000.8 6022.5 1001.4 1011.1 1016.4 1036.4 1045.0 22853.7 23044.3 23366.0 23519.9 23577.0 1095.2 1100.7 1104.9 1108.7 1139.8 12226.7 12259.8 12304.7 12485.6 12705.6 223056.0 224104.0 224255.0 224687.0 224995.0 47550.0 48783.5 53877.7 54321.5 54584.7 1466.9 1472.4 1479.9 1487.5 1497.1 27032.9 27254.7 27471.2 27713.3 28024.3 38156.6 38178.4 38212.8 38244.8 38276.4 194596.0 194892.0 195311.0 195639.0 196003.0 34271.0 35314.6 35354.3 35461.8 35806.1 45172.0 45303.5 45590.0 45603.0 45977.8 34994.8 35164.0 35594.0 35897.0 36204.5 34897.1 35078.5 35278.7 35390.3 35611.3 39113.0 39318.8 39430.0 39689.8 39807.4 33198.0 33606.0 34503.1 35172.6 35194.8 24282.6 24394.0 24887.3 25070.0 25139.0 16:42:26 INFO - PID 6802 | 16:42:26 INFO - PID 6802 | [#2] jquery.html Cycles:180 Average:34539.48 Median:22631.05 stddev:80077.84 (353.8%) stddev-sans-first:80261.83 16:42:26 INFO - PID 6802 | Values: 558.5 568.6 572.8 574.9 584.2 22331.2 22804.1 22964.9 23242.7 23291.5 18483.2 21237.8 23093.3 23229.9 23315.4 6423.5 6605.0 6629.2 6640.2 6655.6 5856.1 6186.1 6513.0 6634.9 6646.6 6434.9 6436.0 6444.3 6451.9 6469.7 6435.0 6437.0 6444.9 6449.4 6471.0 6001.8 6008.3 6014.9 6016.6 6021.4 27136.9 28491.9 28494.1 28840.1 29151.1 1899.2 1953.8 1957.8 1958.8 1965.4 19026.9 19455.7 19469.3 19520.4 19544.0 2258.1 2412.1 2420.6 2439.6 2452.9 132298.3 136145.0 136220.0 136526.0 136570.3 14639.2 14848.0 14999.3 15022.8 15113.8 22573.5 22618.8 22663.0 22713.2 22837.2 9994.1 10253.8 10417.5 10496.6 10564.8 9658.0 9697.2 9737.7 9742.9 9816.2 7655.9 8820.9 9083.3 9108.4 9226.7 2648.7 2696.7 2708.8 2719.6 2741.6 960.2 961.8 970.1 976.8 978.9 19067.7 19073.5 19247.2 19392.7 19615.9 1021.7 1036.9 1037.1 1041.8 1049.4 10527.8 10591.5 10895.2 10931.1 11180.6 450228.0 451598.0 457700.0 489055.0 508948.0 118738.4 122832.4 123579.0 125900.0 127322.0 1214.8 1220.5 1261.6 1262.0 1266.1 19777.6 20197.4 20537.1 20633.6 21168.8 56322.7 57084.7 58397.7 58858.0 59397.0 69022.3 77559.6 79059.0 79965.0 80240.2 14195.2 14661.9 14776.3 14786.4 14803.6 22503.1 22643.3 22652.9 23078.9 23149.3 18270.5 18315.3 18477.3 18506.0 18612.3 16292.8 16620.5 16946.7 16960.5 17269.5 17783.7 18920.0 19005.1 19145.4 19500.9 14668.1 14719.7 14858.8 14886.3 14888.0 18310.3 18511.0 18795.1 18990.1 19089.6 16:42:26 INFO - PID 6802 | 16:42:26 INFO - PID 6802 | [#3] mootools.html Cycles:180 Average:8755.69 Median:2578.92 stddev:6195.28 (240.2%) stddev-sans-first:6187.55 16:42:26 INFO - PID 6802 | Values: 1331.7 1372.4 1389.5 1392.7 1407.7 14134.6 14307.4 14684.3 14792.5 14844.3 13998.9 14313.3 14344.3 14425.0 14430.9 2650.8 2699.6 2703.4 2718.8 2730.0 2582.7 2646.4 2698.2 2744.2 2745.6 2554.1 2618.3 2633.1 2651.2 2677.4 2583.3 2597.1 2610.1 2610.2 2617.5 2540.6 2542.1 2563.2 2565.8 2575.1 14002.9 14242.7 14281.7 14294.1 14294.8 7398.6 7628.3 7685.6 7747.7 7760.0 4961.0 5032.6 5053.4 5176.1 5182.5 1900.7 1916.2 1945.9 1945.9 1986.1 23705.0 24000.5 24014.2 24077.4 24108.2 6225.9 6408.4 6412.3 6524.9 6580.6 16434.8 16500.4 16583.1 16586.7 16604.9 7426.4 7564.3 7570.1 7570.4 7589.5 5974.2 6041.9 6279.2 6319.6 6330.9 5191.7 5216.8 5308.4 5312.9 5329.3 1475.6 1518.4 1523.1 1525.6 1543.1 852.2 871.8 886.3 891.0 896.2 6865.9 7052.6 7055.1 7071.8 7122.6 648.4 656.8 658.9 660.1 666.5 4516.5 4850.9 4888.3 4971.4 5137.6 19734.5 20368.7 20478.2 20656.9 20684.7 20214.7 20343.9 20416.9 20622.5 20642.4 10248.0 10595.7 10940.9 10960.9 11114.9 7442.6 7577.7 7694.8 7731.7 7777.6 16674.7 16847.7 17153.3 17347.0 17448.2 17081.9 17367.7 17438.7 17543.9 17746.2 10318.9 10501.6 10588.4 10591.1 10647.8 12953.2 13027.2 13150.1 13182.8 13284.0 10802.0 10900.1 10929.6 11088.3 11212.9 10148.8 10490.9 10492.3 10543.4 10704.8 9199.7 9399.5 9423.9 9490.2 9515.7 6655.5 6751.8 6809.7 6812.3 6835.1 6800.7 6886.9 6936.2 6960.1 7024.9 16:42:26 INFO - PID 6802 | 16:42:26 INFO - PID 6802 | [#4] prototype.html Cycles:180 Average:5441.55 Median:5987.72 stddev:1533.03 (25.6%) stddev-sans-first:1491.67 16:42:26 INFO - PID 6802 | Values: 493.8 507.6 533.1 533.5 541.2 5991.2 6069.6 6150.9 6189.2 6221.3 5940.3 5971.1 6055.0 6103.0 6104.7 4858.7 4863.6 4884.6 4885.1 4928.7 4874.1 4878.9 4884.8 4940.7 4943.3 4781.5 4848.0 4872.8 4873.0 4875.5 4829.5 4852.7 4866.9 4896.9 4897.0 4339.7 4350.3 4386.6 4402.4 4422.9 5877.4 5962.6 5984.3 6028.4 6036.5 5565.7 5634.1 5657.5 5664.1 5691.3 6370.4 6475.2 6494.5 6503.2 6534.9 4776.1 4776.8 4791.7 4797.7 4825.7 6775.2 6787.9 6829.2 6906.4 7001.9 4882.4 4932.8 4948.8 4971.9 5002.7 4957.5 4978.5 4988.9 5002.1 5013.4 5580.5 5596.9 5620.2 5632.3 5641.8 6432.8 6479.1 6536.9 6563.2 6605.0 1653.4 1676.7 1746.4 1756.3 1757.8 1171.8 1210.4 1215.5 1217.5 1222.9 5555.7 5646.2 5653.9 5673.2 5678.9 6544.9 6577.4 6604.1 6670.7 6685.1 5613.7 5616.9 5620.9 5632.9 5715.0 3502.3 3530.8 3536.4 3543.8 3578.8 6422.9 6464.8 6471.0 6505.3 6510.5 6815.5 6825.4 6852.3 6879.7 6886.6 6361.7 6408.5 6447.1 6448.7 6512.8 6600.6 6625.3 6632.9 6638.9 6716.7 6492.4 6498.4 6606.9 6618.2 6637.2 6456.1 6462.7 6495.4 6524.2 6550.8 4959.4 4970.7 4990.5 5003.5 5010.8 6595.5 6628.1 6659.4 6684.4 6732.5 6423.5 6433.9 6445.8 6456.6 6502.4 6360.4 6433.5 6440.0 6463.7 6549.6 5844.9 6306.7 6336.4 6372.2 6453.2 6452.1 6503.3 6528.3 6539.0 6551.9 6244.0 6311.5 6351.7 6374.4 6425.3 16:42:26 INFO - PID 6802 | 16:42:26 INFO - PID 6802 | [#5] yui.html Cycles:180 Average:23185.25 Median:20021.40 stddev:30966.84 (154.7%) stddev-sans-first:31008.56 16:42:26 INFO - PID 6802 | Values: 916.1 925.2 934.7 937.2 946.7 19494.6 19861.9 20074.3 20100.6 20175.0 17796.3 19728.4 19871.9 19887.7 19916.4 1018.3 1035.6 1050.1 1051.5 1051.6 970.7 1071.7 1072.4 1073.3 1078.2 1125.0 1131.5 1131.8 1132.5 1133.8 1117.9 1118.0 1120.8 1127.9 1129.2 813.4 817.1 817.2 818.5 818.7 18302.8 19124.5 19968.5 20247.5 20331.0 21483.5 21701.6 21930.9 21959.0 22011.4 16826.8 16963.3 16973.7 17124.4 17224.0 3578.9 3592.3 3592.5 3594.9 3597.8 122820.4 126942.0 127057.4 128345.0 129571.0 16816.0 16970.5 17315.0 17449.7 17500.0 30456.4 30994.6 31326.7 31352.5 31552.1 8510.5 8880.0 8916.5 8927.2 8969.9 4010.4 4042.4 4100.3 4198.0 4226.0 4541.2 4749.7 4948.9 5117.5 5372.2 983.1 990.3 1011.4 1019.1 1020.6 664.5 675.8 685.1 689.8 691.7 10781.6 11952.6 12047.0 12428.8 12746.7 618.9 640.5 642.5 647.5 655.3 5959.2 6187.8 6455.8 6492.9 6580.0 99256.5 102502.5 105197.5 106301.0 111611.0 95374.0 95435.0 95464.5 97343.0 98359.5 81087.2 83142.0 84064.0 85738.9 85916.6 13210.3 13210.9 13328.9 13412.5 13519.3 38984.6 40073.4 40778.6 41086.0 41234.8 49866.0 51132.5 51166.7 51982.5 52615.2 18779.2 18790.6 18848.0 18890.9 19246.7 20585.4 20835.8 20946.6 21235.1 21645.6 19155.7 19256.9 19621.4 19646.1 19939.0 17688.6 17741.0 18035.8 18069.2 18252.8 17728.5 18071.9 18129.7 18207.9 18438.0 13159.4 13202.2 13331.2 13501.7 13572.0 13710.9 13913.7 13946.1 13992.6 14061.8 16:42:26 INFO - PID 6802 | -------- Summary: end -------- 16:42:26 INFO - PID 6802 | 16:42:27 INFO - TEST-INFO | 6802: exit 0 16:42:27 INFO - TEST-OK | dromaeo_css | took 1117004ms 16:42:27 INFO - TEST-START | kraken 16:42:27 INFO - Initialising browser for kraken test... 16:42:27 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:47036/getInfo.html -profile /tmp/tmpMM5EVN/profile 16:42:27 INFO - TEST-INFO | started process 7189 (/builds/slave/test/build/application/firefox/firefox http://localhost:47036/getInfo.html) 16:42:33 INFO - TEST-INFO | 7189: exit 0 16:42:33 INFO - Browser initialized. 16:42:33 INFO - Running cycle 1/1 for kraken test... 16:42:33 INFO - TEST-INFO | started process 7410 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpMM5EVN/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 16:42:34 INFO - PID 7410 | WebRender - OpenGL version new 3.2.0 NVIDIA 361.42 16:42:34 INFO - PID 7410 | WebRender - OpenGL version new 3.2.0 NVIDIA 361.42 16:42:34 INFO - PID 7410 | 16:42:34 INFO - PID 7410 | (/builds/slave/test/build/application/firefox/firefox:7469): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 16:42:34 INFO - PID 7410 | 16:42:45 INFO - PID 7410 | RSS: Main: 195153920 16:42:45 INFO - PID 7410 | 16:42:47 INFO - PID 7410 | Cycle 1(1): loaded http://localhost:47036/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:47036/tests/kraken/driver.html?testName=audio-beat-detection) 16:42:48 INFO - PID 7410 | RSS: Main: 204210176 16:42:48 INFO - PID 7410 | 16:42:49 INFO - PID 7410 | WebRender - OpenGL version new 3.2.0 NVIDIA 361.42 16:42:51 INFO - PID 7410 | Cycle 1(1): loaded http://localhost:47036/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:47036/tests/kraken/driver.html?testName=audio-dft) 16:42:52 INFO - PID 7410 | RSS: Main: 223080448 16:42:52 INFO - PID 7410 | 16:42:55 INFO - PID 7410 | Cycle 1(1): loaded http://localhost:47036/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:47036/tests/kraken/driver.html?testName=audio-fft) 16:42:56 INFO - PID 7410 | RSS: Main: 217378816 16:42:56 INFO - PID 7410 | 16:42:58 INFO - PID 7410 | Cycle 1(1): loaded http://localhost:47036/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:47036/tests/kraken/driver.html?testName=audio-oscillator) 16:42:58 INFO - PID 7410 | RSS: Main: 217784320 16:42:58 INFO - PID 7410 | 16:43:01 INFO - PID 7410 | Cycle 1(1): loaded http://localhost:47036/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:47036/tests/kraken/driver.html?testName=imaging-gaussian-blur) 16:43:01 INFO - PID 7410 | RSS: Main: 218529792 16:43:01 INFO - PID 7410 | 16:43:04 INFO - PID 7410 | Cycle 1(1): loaded http://localhost:47036/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:47036/tests/kraken/driver.html?testName=imaging-darkroom) 16:43:05 INFO - PID 7410 | RSS: Main: 219615232 16:43:05 INFO - PID 7410 | 16:43:09 INFO - PID 7410 | Cycle 1(1): loaded http://localhost:47036/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:47036/tests/kraken/driver.html?testName=imaging-desaturate) 16:43:09 INFO - PID 7410 | RSS: Main: 218234880 16:43:09 INFO - PID 7410 | 16:43:12 INFO - PID 7410 | Cycle 1(1): loaded http://localhost:47036/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:47036/tests/kraken/driver.html?testName=json-parse-financial) 16:43:13 INFO - PID 7410 | RSS: Main: 219033600 16:43:13 INFO - PID 7410 | 16:43:14 INFO - PID 7410 | Cycle 1(1): loaded http://localhost:47036/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:47036/tests/kraken/driver.html?testName=json-stringify-tinderbox) 16:43:15 INFO - PID 7410 | RSS: Main: 219328512 16:43:15 INFO - PID 7410 | 16:43:17 INFO - PID 7410 | Cycle 1(1): loaded http://localhost:47036/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:47036/tests/kraken/driver.html?testName=stanford-crypto-aes) 16:43:18 INFO - PID 7410 | RSS: Main: 219480064 16:43:18 INFO - PID 7410 | 16:43:20 INFO - PID 7410 | Cycle 1(1): loaded http://localhost:47036/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:47036/tests/kraken/driver.html?testName=stanford-crypto-ccm) 16:43:20 INFO - PID 7410 | RSS: Main: 218181632 16:43:20 INFO - PID 7410 | 16:43:23 INFO - PID 7410 | Cycle 1(1): loaded http://localhost:47036/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:47036/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 16:43:24 INFO - PID 7410 | RSS: Main: 220258304 16:43:24 INFO - PID 7410 | 16:43:27 INFO - PID 7410 | Cycle 1(1): loaded http://localhost:47036/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:47036/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 16:43:28 INFO - PID 7410 | RSS: Main: 218886144 16:43:28 INFO - PID 7410 | 16:43:30 INFO - PID 7410 | Cycle 1(1): loaded http://localhost:47036/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:47036/tests/kraken/driver.html?testName=ai-astar) 16:43:30 INFO - PID 7410 | RSS: Main: 221052928 16:43:30 INFO - PID 7410 | 16:43:30 INFO - PID 7410 | __start_tp_report 16:43:30 INFO - PID 7410 | _x_x_mozilla_page_load 16:43:30 INFO - PID 7410 | _x_x_mozilla_page_load_details 16:43:30 INFO - PID 7410 | |i|pagename|runs| 16:43:30 INFO - PID 7410 | |0;ai-astar;105;121;107;115;113;112;113;102;114;113 16:43:30 INFO - PID 7410 | |1;audio-beat-detection;151;121;155;189;126;145;153;120;183;123 16:43:30 INFO - PID 7410 | |2;audio-dft;173;170;167;165;171;172;169;170;166;171 16:43:30 INFO - PID 7410 | |3;audio-fft;80;78;77;181;83;87;83;80;169;82 16:43:30 INFO - PID 7410 | |4;audio-oscillator;81;81;131;83;86;85;140;79;88;127 16:43:30 INFO - PID 7410 | |5;imaging-gaussian-blur;122;115;114;120;116;117;117;123;120;115 16:43:30 INFO - PID 7410 | |6;imaging-darkroom;152;160;159;153;155;151;155;155;155;151 16:43:30 INFO - PID 7410 | |7;imaging-desaturate;101;97;97;96;103;99;96;95;101;101 16:43:30 INFO - PID 7410 | |8;json-parse-financial;61;53;53;53;54;53;53;53;54;55 16:43:30 INFO - PID 7410 | |9;json-stringify-tinderbox;61;58;62;56;55;60;56;55;60;63 16:43:30 INFO - PID 7410 | |10;stanford-crypto-aes;81;80;82;81;76;80;78;78;76;76 16:43:30 INFO - PID 7410 | |11;stanford-crypto-ccm;129;128;127;135;135;136;128;129;127;162 16:43:30 INFO - PID 7410 | |12;stanford-crypto-pbkdf2;187;184;187;180;179;185;176;181;178;175 16:43:30 INFO - PID 7410 | |13;stanford-crypto-sha256-iterative;68;79;69;74;69;68;70;76;67;68 16:43:30 INFO - PID 7410 | __end_tp_report 16:43:30 INFO - PID 7410 | __start_cc_report 16:43:30 INFO - PID 7410 | _x_x_mozilla_cycle_collect,958 16:43:30 INFO - PID 7410 | __end_cc_report 16:43:30 INFO - PID 7410 | __startTimestamp1502927010301__endTimestamp 16:43:30 INFO - PID 7410 | 16:43:30 INFO - PID 7410 | ------- Summary: start ------- 16:43:30 INFO - PID 7410 | Number of tests: 14 16:43:30 INFO - PID 7410 | 16:43:30 INFO - PID 7410 | [#0] ai-astar Cycles:10 Average:111.50 Median:113.00 stddev:5.46 (4.8%) stddev-sans-first:5.26 16:43:30 INFO - PID 7410 | Values: 105.0 121.0 107.0 115.0 113.0 112.0 113.0 102.0 114.0 113.0 16:43:30 INFO - PID 7410 | 16:43:30 INFO - PID 7410 | [#1] audio-beat-detection Cycles:10 Average:146.60 Median:152.00 stddev:24.95 (16.4%) stddev-sans-first:26.41 16:43:30 INFO - PID 7410 | Values: 151.0 121.0 155.0 189.0 126.0 145.0 153.0 120.0 183.0 123.0 16:43:30 INFO - PID 7410 | 16:43:30 INFO - PID 7410 | [#2] audio-dft Cycles:10 Average:169.40 Median:170.50 stddev:2.63 (1.5%) stddev-sans-first:2.45 16:43:30 INFO - PID 7410 | Values: 173.0 170.0 167.0 165.0 171.0 172.0 169.0 170.0 166.0 171.0 16:43:30 INFO - PID 7410 | 16:43:30 INFO - PID 7410 | [#3] audio-fft Cycles:10 Average:100.00 Median:81.00 stddev:39.73 (49.0%) stddev-sans-first:41.48 16:43:30 INFO - PID 7410 | Values: 80.0 78.0 77.0 181.0 83.0 87.0 83.0 80.0 169.0 82.0 16:43:30 INFO - PID 7410 | 16:43:30 INFO - PID 7410 | [#4] audio-oscillator Cycles:10 Average:98.10 Median:82.00 stddev:24.20 (29.5%) stddev-sans-first:24.86 16:43:30 INFO - PID 7410 | Values: 81.0 81.0 131.0 83.0 86.0 85.0 140.0 79.0 88.0 127.0 16:43:30 INFO - PID 7410 | 16:43:30 INFO - PID 7410 | [#5] imaging-gaussian-blur Cycles:10 Average:117.90 Median:118.50 stddev:3.14 (2.7%) stddev-sans-first:2.96 16:43:30 INFO - PID 7410 | Values: 122.0 115.0 114.0 120.0 116.0 117.0 117.0 123.0 120.0 115.0 16:43:30 INFO - PID 7410 | 16:43:30 INFO - PID 7410 | [#6] imaging-darkroom Cycles:10 Average:154.60 Median:155.00 stddev:3.06 (2.0%) stddev-sans-first:3.10 16:43:30 INFO - PID 7410 | Values: 152.0 160.0 159.0 153.0 155.0 151.0 155.0 155.0 155.0 151.0 16:43:30 INFO - PID 7410 | 16:43:30 INFO - PID 7410 | [#7] imaging-desaturate Cycles:10 Average:98.60 Median:96.00 stddev:2.76 (2.9%) stddev-sans-first:2.78 16:43:30 INFO - PID 7410 | Values: 101.0 97.0 97.0 96.0 103.0 99.0 96.0 95.0 101.0 101.0 16:43:30 INFO - PID 7410 | 16:43:30 INFO - PID 7410 | [#8] json-parse-financial Cycles:10 Average:54.20 Median:53.50 stddev:2.49 (4.6%) stddev-sans-first:0.73 16:43:30 INFO - PID 7410 | Values: 61.0 53.0 53.0 53.0 54.0 53.0 53.0 53.0 54.0 55.0 16:43:30 INFO - PID 7410 | 16:43:30 INFO - PID 7410 | [#9] json-stringify-tinderbox Cycles:10 Average:58.60 Median:60.00 stddev:2.99 (5.0%) stddev-sans-first:3.04 16:43:30 INFO - PID 7410 | Values: 61.0 58.0 62.0 56.0 55.0 60.0 56.0 55.0 60.0 63.0 16:43:30 INFO - PID 7410 | 16:43:30 INFO - PID 7410 | [#10] stanford-crypto-aes Cycles:10 Average:78.80 Median:80.00 stddev:2.30 (2.9%) stddev-sans-first:2.30 16:43:30 INFO - PID 7410 | Values: 81.0 80.0 82.0 81.0 76.0 80.0 78.0 78.0 76.0 76.0 16:43:30 INFO - PID 7410 | 16:43:30 INFO - PID 7410 | [#11] stanford-crypto-ccm Cycles:10 Average:133.60 Median:132.00 stddev:10.59 (8.0%) stddev-sans-first:11.10 16:43:30 INFO - PID 7410 | Values: 129.0 128.0 127.0 135.0 135.0 136.0 128.0 129.0 127.0 162.0 16:43:30 INFO - PID 7410 | 16:43:30 INFO - PID 7410 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:181.20 Median:182.50 stddev:4.37 (2.4%) stddev-sans-first:4.10 16:43:30 INFO - PID 7410 | Values: 187.0 184.0 187.0 180.0 179.0 185.0 176.0 181.0 178.0 175.0 16:43:30 INFO - PID 7410 | 16:43:30 INFO - PID 7410 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.80 Median:69.50 stddev:4.08 (5.9%) stddev-sans-first:4.20 16:43:30 INFO - PID 7410 | Values: 68.0 79.0 69.0 74.0 69.0 68.0 70.0 76.0 67.0 68.0 16:43:30 INFO - PID 7410 | -------- Summary: end -------- 16:43:30 INFO - PID 7410 | 16:43:30 INFO - PID 7410 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 16:43:31 INFO - TEST-INFO | 7410: exit 0 16:43:31 INFO - TEST-OK | kraken | took 64340ms 16:43:31 INFO - SUITE-END | took 1181s 16:43:31 INFO - Completed test suite (00:19:41) 16:43:31 INFO - javascript benchmark 16:43:31 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8447.386989343338, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3125.2186953261685, 3162.683731626839, 3171.873125074997, 3182.4908014717644, 3193.961962362233, 5969.164316995624, 6029.246344206974, 6130.846728831782, 6144.723487443064, 6157.076438534216, 6038.003729384646, 6092.908606370908, 6100.328963813977, 6109.755609775603, 6133.0, 5548.833534993936, 5555.30558680165, 5577.9163312550245, 5602.215689803431, 5606.523445507137, 5568.86077848053, 5589.888202235953, 5592.86017849555, 5593.328800543941, 5598.020346439377, 5542.196381524676, 5572.498475137237, 5582.078956972095, 5589.04986152353, 5589.217509548646, 5485.917711234335, 5576.0241957657245, 5586.497215250627, 5600.52395546379, 5602.411746766572, 5618.943810561924, 5652.0391533439415, 5689.857753556153, 5719.742611582447, 5724.713764311768, 5848.561357898175, 5862.413758624146, 5946.316173640043, 5995.850103747442, 6085.786997455112, 6481.189851268591, 6494.253160886511, 6576.6382848943285, 6655.76704815334, 6658.733650654017, 6591.967040164816, 6616.603003819738, 6645.3686899744935, 6683.565568238049, 6695.832604184886, 6107.8473038173515, 6154.26148862135, 6164.198654174928, 6171.475424588871, 6179.721912513947, 6795.558288711218, 6807.795766127024, 6824.624645644537, 6830.453563714891, 6850.040994260808, 6413.198350206224, 6463.935360646427, 6464.741410343628, 6470.676466176672, 6502.284748677642, 6544.214694236722, 6567.605943643397, 6584.670766461658, 6591.110200123018, 6672.2994085621285, 6530.640814755234, 6536.0, 6568.080468734381, 6611.768588099393, 6617.9669101655145, 6419.903701444482, 6477.060826180177, 6487.610743355413, 6517.087607734921, 6618.338166183439, 5324.334458192726, 5443.156310771837, 5444.128939369761, 5447.0, 5449.972750136303, 4608.861734147981, 4664.603508701731, 4665.533446655375, 4672.789724462407, 4705.576498115186, 5673.716314184357, 5720.2849643794525, 5766.855828604318, 5787.421257874179, 5798.275215598051, 6535.150430444107, 6580.967095164494, 6591.505637077238, 6637.137172167587, 6740.730370785212, 5631.831045068655, 5652.349979752299, 5657.094864821609, 5667.149927510906, 5693.743781529841, 5753.482186603226, 5873.353931067579, 5879.029960056629, 5880.235569375954, 5945.970270148621, 6464.676766161673, 6472.255690595548, 6493.935060649427, 6498.155239818793, 6518.967405162944, 6689.0, 6713.56361836479, 6735.764248251287, 6740.325967403221, 6741.59550426976, 6398.4561312287115, 6419.903701444388, 6465.77369792055, 6474.384933431316, 6519.869602608016, 6410.423061924449, 6545.0, 6563.146790917151, 6638.435732962752, 6644.435223006099, 6364.840878977878, 6404.359564043559, 6427.453666438405, 6437.324080971618, 6449.516286278454, 5921.585489015728, 6237.376262373908, 6288.937110628835, 6302.338254483397, 6308.27454842699, 6123.234595675541, 6408.423241908251, 6437.581557198767, 6547.0179473079415, 6562.081308616893, 6312.147860038836, 6331.556791024584, 6407.103005579316, 6477.4170324671, 6494.805155845333, 6344.841378965378, 6421.7110230038825, 6429.517786165963, 6442.967785161044, 6522.28254891952, 6194.287656919512, 6215.160953271251, 6222.906656400067, 6267.341929097562, 6269.40440658155], "value": 6007.5796363529535, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [806.0931452116369, 820.6430202861759, 838.9790255243618, 862.9956850215744, 863.7365603490935, 42723.35914961274, 42858.35712464315, 43485.0, 43661.345079823746, 43759.34360984584, 39351.0, 39494.210115797665, 39813.203735925264, 39931.800340998256, 40167.19665606686, 6658.833529161773, 6808.965955170217, 6820.283870193608, 6829.351211634887, 6838.452923766112, 6773.390394864461, 6856.554323968951, 6860.03959445678, 6872.381485666289, 6876.140482439695, 6827.692753826065, 6834.589924604539, 6851.623160726158, 6857.759978400757, 7569.470137090406, 7637.961810190941, 7659.425543084263, 7707.6916923323, 7708.997830282027, 7726.188750181263, 7592.544447333178, 7598.316151546332, 7687.077550693896, 7692.999910011718, 7693.884591731128, 39411.40882886759, 40282.0, 40341.79829100836, 40849.0, 41239.58760412387, 3493.8602455901732, 3511.438169892805, 3539.628339024391, 3546.7694599851184, 3550.8757193498104, 32230.838845805854, 32465.0, 32501.349973000644, 32567.51148732771, 32930.670693293, 5026.773795179226, 5067.670601410897, 5118.897622047575, 5132.101882170605, 5144.331236939174, 218867.0, 222546.0, 222991.0, 223689.0, 223990.99999999837, 51975.0, 51978.22032669513, 52000.0, 52040.0, 52097.479025209264, 54140.0, 54398.0, 54689.453105468434, 54710.45289547133, 54942.17586736202, 15767.448139315069, 15847.445339413065, 15972.440964566184, 16023.0, 16313.184340782913, 12823.487060517475, 12923.676908077374, 12936.482540698267, 12961.15752476086, 12984.67538311531, 14629.85370146285, 14781.408743650134, 14822.777658335133, 14866.851331486547, 15115.31981060833, 5905.822825315247, 5938.910916336258, 5945.613535120204, 6000.759969601167, 6022.488088512438, 1001.3941565352857, 1011.0597144655394, 1016.3749294184023, 1036.3781730961364, 1045.0281238448165, 22853.657195142085, 23044.308670739905, 23366.0, 23519.88240058789, 23577.0, 1095.2114477576133, 1100.7248187953012, 1104.9226554141294, 1108.7117349489029, 1139.8316725356576, 12226.748065450989, 12259.774022597669, 12304.677737010958, 12485.625431237077, 12705.618831435071, 223056.0, 224104.0, 224255.0, 224687.0, 224995.0, 47550.0, 48783.51216487861, 53877.73061134669, 54321.45678543243, 54584.72707636436, 1466.9339879705226, 1472.3963175098372, 1479.948201812953, 1487.4570781664615, 1497.1466264229502, 27032.864835675697, 27254.727452726012, 27471.17586472409, 27713.307167320978, 28024.29939251535, 38156.61843381642, 38178.42732358961, 38212.808935955145, 38244.80877595594, 38276.425853612775, 194596.0, 194892.0, 195311.0, 195639.0, 196003.0, 34271.0, 35314.64685353216, 35354.29291414209, 35461.82269088638, 35806.10484737798, 45172.0, 45303.54696453125, 45590.0, 45603.0, 45977.77011115057, 34994.825025875725, 35164.0, 35594.0, 35897.0, 36204.45693314655, 34897.12757181091, 35078.47382289216, 35278.70688405245, 35390.29219415546, 35611.28777424385, 39113.0, 39318.803405982784, 39430.0, 39689.80155099206, 39807.40288895611, 33198.0, 33606.0, 34503.13742156366, 35172.64827351796, 35194.82402587971, 24282.554107377793, 24394.0, 24887.253382398558, 25070.0, 25139.0], "value": 17524.28836523523, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [558.5196730811501, 568.6445971267955, 572.8281515545335, 574.8649067469147, 584.1967294969417, 22331.218407355726, 22804.08783648652, 22964.88517557412, 23242.65136022961, 23291.534169316645, 18483.168257428413, 21237.787622123775, 23093.307200784002, 23229.88385058072, 23315.417114572145, 6423.454006409449, 6604.966975165117, 6629.237637671681, 6640.236372817116, 6655.600663960154, 5856.063029915214, 6186.103015062836, 6512.967435162817, 6634.933650663504, 6646.60120392778, 6434.935650643504, 6436.034594810769, 6444.323346048668, 6451.870962580746, 6469.74121035158, 6435.034744788272, 6437.034444833265, 6444.935550644504, 6449.419552240321, 6470.967645161792, 6001.789937352171, 6008.3390827009, 6014.939850601481, 6016.639001659914, 6021.36775638556, 27136.864315678296, 28491.860325586953, 28494.145175644764, 28840.134795955946, 29151.125466236048, 1899.2118270917554, 1953.7655481342188, 1957.843372530194, 1958.8237058664647, 1965.3809050149157, 19026.90486547572, 19455.708164377545, 19469.318573849847, 19520.414387568395, 19544.0, 2258.0741895822634, 2412.1316326122583, 2420.6490058941354, 2439.6096624539987, 2452.865092419916, 132298.33850830683, 136145.0, 136220.0, 136526.0, 136570.31714841462, 14639.201969166974, 14848.034877732913, 14999.325030373659, 15022.774658380133, 15113.773293400607, 22573.54852902933, 22618.773812261996, 22663.0, 22713.205037823598, 22837.20069797549, 9994.10053095225, 10253.84619230712, 10417.479126043667, 10496.632617858339, 10564.788704225872, 9658.0, 9697.224222062217, 9737.707868763948, 9742.902570974342, 9816.165625921734, 7655.885161722578, 8820.897387826522, 9083.318751093562, 9108.407953483002, 9226.677066302647, 2648.695400028983, 2696.7168447313143, 2708.810383273152, 2719.5648696208514, 2741.629879966179, 960.2030314838668, 961.7643677299106, 970.1220395542045, 976.8388215944432, 978.858065580501, 19067.713984290247, 19073.523161920784, 19247.23011079541, 19392.70910936337, 19615.901920490305, 1021.7088129882948, 1036.9481525923673, 1037.0873631204493, 1041.7760181561, 1049.3913530152493, 10527.789444211227, 10591.523381447852, 10895.237333386587, 10931.125509959184, 11180.552777888794, 450228.0, 451598.0, 457700.0, 489055.0, 508948.0, 118738.40630796964, 122832.38583807024, 123579.0, 125900.0, 127322.0, 1214.8238505416666, 1220.4934951994824, 1261.6278197931815, 1261.9621411357673, 1266.0757646917803, 19777.60444791125, 20197.394078177676, 20537.075831587914, 20633.555651104878, 21168.78831211668, 56322.7183864078, 57084.71457642685, 58397.70801145967, 58858.0, 59397.0, 69022.30977690159, 77559.61220193862, 79059.0, 79965.0, 80240.19759802561, 14195.219262940638, 14661.853381466475, 14776.33506492189, 14786.408543658134, 14803.555893323217, 22503.09987600543, 22643.320700379016, 22652.886735566215, 23078.884605576866, 23149.3055208344, 18270.45188644343, 18315.267389304277, 18477.260909564004, 18506.0, 18612.255509779457, 16292.755608665642, 16620.501384958472, 16946.745798812783, 16960.491185264462, 17269.481915542554, 17783.73324400109, 18920.0, 19005.144768485174, 19145.425637230906, 19500.902495487433, 14668.119912805267, 14719.705605888037, 14858.777118343449, 14886.25568721538, 14888.0, 18310.26758929628, 18511.0, 18795.06024698787, 18990.1454434548, 19089.618207635493], "value": 11968.707541941714, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1331.6670832291927, 1372.3618517389411, 1389.4789453954768, 1392.7214557088585, 1407.7395681798862, 14134.64663383416, 14307.427702891871, 14684.339204735787, 14792.482263120794, 14844.257787110655, 13998.930005349985, 14313.284335783195, 14344.28278586069, 14425.0, 14430.855691443083, 2650.787936965043, 2699.622052912594, 2703.3917368592106, 2718.768904643108, 2729.972700272992, 2582.715901250861, 2646.4045589742345, 2698.231004163814, 2744.2316151477617, 2745.629340039089, 2554.1443616388533, 2618.293060873563, 2633.117905501659, 2651.231142968537, 2677.4377380750066, 2583.3154214133174, 2597.142942828862, 2610.0864697355773, 2610.2038878142157, 2617.5026744918405, 2540.593505039185, 2542.0975553678363, 2563.2310306907852, 2565.8332208406396, 2575.1244576843965, 14002.859971400258, 14242.715145697131, 14281.714365712627, 14294.070885392417, 14294.785578216335, 7398.630068496607, 7628.31345178931, 7685.615719214073, 7747.728829490997, 7759.9612001940195, 4960.982998485302, 5032.572231360339, 5053.36832895888, 5176.094183517907, 5182.507661772125, 1900.7053906644492, 1916.2239293086323, 1945.9005661801036, 1945.9221631134737, 1986.106252186522, 23705.0, 24000.519989600285, 24014.15950441726, 24077.39806504834, 24108.156214532406, 6225.906611400833, 6408.359164083555, 6412.2625898022325, 6524.934750652527, 6580.605163690194, 16434.83565164357, 16500.42248521296, 16583.087930163714, 16586.668266634842, 16604.920680155752, 7426.405887528985, 7564.281393267631, 7570.091589009244, 7570.356519695777, 7589.468737188454, 5974.2233509643465, 6041.939580604226, 6279.152314437584, 6319.58922670025, 6330.905036424458, 5191.714455704972, 5216.765245563959, 5308.442613525602, 5312.92030619541, 5329.307190065267, 1475.6310922269433, 1518.422999260274, 1523.1470376589145, 1525.603343130794, 1543.1127101916218, 852.1563651984491, 871.834351473218, 886.3441053620403, 890.9599068041954, 896.171041786358, 6865.897011544831, 7052.612106334098, 7055.118110236221, 7071.7878463646175, 7122.608256545836, 648.3872740260408, 656.7668477690447, 658.8748137853793, 660.1187414801199, 666.5367569539123, 4516.503184649686, 4850.902981940341, 4888.315635810989, 4971.403431588233, 5137.588992880561, 19734.506637334183, 20368.69446958297, 20478.18087276522, 20656.896715516326, 20684.689729654066, 20214.696779548318, 20343.898280508503, 20416.897915510624, 20622.484437889172, 20642.380728578166, 10248.0, 10595.735106622396, 10940.890591093987, 10960.890391095987, 11114.944425277983, 7442.590657513889, 7577.734779282699, 7694.846103077795, 7731.6520756567215, 7777.611119444118, 16674.749878751587, 16847.663046739242, 17153.313867445162, 17347.0, 17448.21483033241, 17081.914590426968, 17367.7394839075, 17438.738418923473, 17543.912280438515, 17746.20142093583, 10318.948405258227, 10501.582286391545, 10588.417637030037, 10591.099756520782, 10647.787044258917, 12953.158044727063, 13027.218366898016, 13150.079494435298, 13182.80225796633, 13284.0, 10802.0, 10900.108074725978, 10929.56281748753, 11088.334699917708, 11212.887871121511, 10148.847767283349, 10490.895091049297, 10492.317999330018, 10543.420111893613, 10704.839427408438, 9199.724008279762, 9399.530023498934, 9423.905760942303, 9490.240780737662, 9515.666951656658, 6655.534112612264, 6751.797446076625, 6809.727610895508, 6812.284710105368, 6835.077264569419, 6800.727970881308, 6886.8622627548175, 6936.237013928565, 6960.129983752031, 7024.929750702428], "value": 6279.109515765658, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [493.7679290733356, 507.5787096709731, 533.0671325180933, 533.4665334665335, 541.2449632762294, 5991.161237426752, 6069.60547564408, 6150.907736383958, 6189.1644627975265, 6221.284552276489, 5940.316863560692, 5971.1043343498495, 6054.969725151368, 6102.969485152579, 6104.664243466618, 4858.732769697665, 4863.635227357945, 4884.633652476078, 4885.120678277917, 4928.654994150411, 4874.147024270738, 4878.902421951559, 4884.753013613742, 4940.703557786526, 4943.332650092246, 4781.521847815226, 4847.951520484785, 4872.829450969217, 4872.9756351218375, 4875.463698993108, 4829.541193586604, 4852.660313778019, 4866.902661946741, 4896.877578060541, 4897.0, 4339.696221264513, 4350.260455722503, 4386.649068074546, 4402.361657559668, 4422.889427764299, 5877.441643043904, 5962.642241465483, 5984.281886173643, 6028.367021462771, 6036.456718895277, 5565.693886836222, 5634.126710359901, 5657.547396208293, 5664.122061080539, 5691.26013618227, 6370.4266616004315, 6475.179644010057, 6494.480441564663, 6503.187101612299, 6534.921737913286, 4776.09254241693, 4776.805798550363, 4791.7124972501415, 4797.736124513151, 4825.710457372569, 6775.186977562675, 6787.879999800027, 6829.248782633907, 6906.411525349147, 7001.894971575482, 4882.438519570223, 4932.827351042696, 4948.752562371939, 4971.90056198874, 5002.74986250686, 4957.454679985199, 4978.5270399312, 4988.850334489971, 5002.1496345621335, 5013.423456302572, 5580.525655319343, 5596.944030559724, 5620.156976453564, 5632.324121105494, 5641.84342209846, 6432.807015789534, 6479.060536222316, 6536.869262614721, 6563.212414510193, 6605.0, 1653.4047742812577, 1676.7484877268507, 1746.4062218845654, 1756.2535922233, 1757.8242175782575, 1171.84765980422, 1210.431097384228, 1215.523139385633, 1217.5251651855783, 1222.896053835434, 5555.694436806015, 5646.181303711021, 5653.943460565424, 5673.205751194836, 5678.886422271531, 6544.869102617921, 6577.440917521969, 6604.084815403479, 6670.666466676744, 6685.130932978682, 5613.691246981373, 5616.9157462638095, 5620.859478512988, 5632.887342253132, 5714.9714251429305, 3502.3188869342857, 3530.8234588271, 3536.4164912789615, 3543.75193736436, 3578.8210589470423, 6422.935770642233, 6464.806055818333, 6470.993991862538, 6505.316941721051, 6510.47916166715, 6815.522913396114, 6825.35159159879, 6852.314768523108, 6879.690413931385, 6886.621235832077, 6361.650109244036, 6408.455281300955, 6447.065175549519, 6448.709808058648, 6512.837179070656, 6600.636964966973, 6625.304343043911, 6632.938729803208, 6638.933610664025, 6716.664166791543, 6492.415682588589, 6498.3826536478955, 6606.933930660632, 6618.205815302194, 6637.1703537057865, 6456.127023474509, 6462.741490340334, 6495.415412612888, 6524.184476940382, 6550.7707230246715, 4959.3552838132255, 4970.701757894538, 4990.477904239242, 5003.499650034967, 5010.799568017239, 6595.472362210916, 6628.138342015507, 6659.37173664318, 6684.398404143456, 6732.528722989344, 6423.4861211103935, 6433.941138835527, 6445.774397896051, 6456.644884531396, 6502.382273683992, 6360.363963603602, 6433.549651524536, 6439.967800160969, 6463.709133089116, 6549.574277671936, 5844.853878653068, 6306.653134077486, 6336.366363363627, 6372.203474565679, 6453.225612926291, 6452.096706461193, 6503.317151699192, 6528.281888992112, 6538.967305163444, 6551.901721474277, 6244.0321750128805, 6311.463525600376, 6351.745930162741, 6374.4263016326895, 6425.261094973951], "value": 4993.767334520896, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [916.1205242966753, 925.1858364639116, 934.7195841247624, 937.1565590968132, 946.7207173883704, 19494.610107797835, 19861.900690496564, 20074.297399591018, 20100.59798804023, 20175.0, 17796.288148474046, 19728.408147755556, 19871.900640496777, 19887.70168447471, 19916.402507924784, 1018.2668478695327, 1035.5754140802235, 1050.144132531988, 1051.5057922776282, 1051.6319288249128, 970.7233438470038, 1071.6517131932114, 1072.3565860483725, 1073.2701762801291, 1078.1967434261446, 1125.0212315285712, 1131.519104380639, 1131.8302254661826, 1132.513019401657, 1133.773245350929, 1117.944102794861, 1117.966461006163, 1120.775844831029, 1127.9266847654917, 1129.1531351486385, 813.4021494201756, 817.1256755271861, 817.190980928882, 818.4598165210991, 818.66434761748, 18302.816971830376, 19124.521886952938, 19968.500787480283, 20247.4938126548, 20331.0, 21483.46291342729, 21701.565968680537, 21930.89034554833, 21959.0, 22011.449713757283, 16826.83173168265, 16963.3214671413, 16973.660526789517, 17124.40064597733, 17224.0, 3578.874739384135, 3592.2815436912724, 3592.497050412944, 3594.946075808865, 3597.80212088335, 122820.38589806994, 126942.0, 127057.36471317676, 128345.0, 129571.0, 16816.0, 16970.490885273462, 17315.0, 17449.651006979788, 17500.0, 30456.390872182434, 30994.59059503453, 31326.686733132832, 31352.529712054336, 31552.053438396426, 8510.531920744419, 8880.023197448276, 8916.465012099165, 8927.24118449939, 8969.865452018224, 4010.438538604598, 4042.3532234842282, 4100.2619528484565, 4197.97901010493, 4225.978870105691, 4541.159885421208, 4749.715017098985, 4948.851534453972, 5117.513836185556, 5372.1941708744, 983.1201075037801, 990.2622546203124, 1011.3982180602529, 1019.1133713669155, 1020.6274709730894, 664.5049438168498, 675.8445557521798, 685.0751485494543, 689.7654797368818, 691.6921969723425, 10781.62264320745, 11952.581659642045, 12046.976007039324, 12428.75142497145, 12746.745065098832, 618.8916939535563, 640.5292110298926, 642.5373730913734, 647.4593714248655, 655.3250152343094, 5959.225300710967, 6187.783427580013, 6455.838604034842, 6492.935070649233, 6579.967100164468, 99256.5037174824, 102502.48748756357, 105197.47401262945, 106301.0, 111611.0, 95374.0, 95435.0, 95464.52267738756, 97343.0, 98359.50820245853, 81087.18912810796, 83142.0, 84064.0, 85738.85652858604, 85916.57041714751, 13210.339483026002, 13210.933945330213, 13328.866711332763, 13412.463501459832, 13519.256440895846, 38984.610153898095, 40073.398899015956, 40778.592214078664, 41086.0, 41234.79382603188, 49866.0, 51132.48867511277, 51166.74416627893, 51982.480175197765, 52615.21077183922, 18779.15493802755, 18790.624187516445, 18848.0, 18890.905545472186, 19246.7112993308, 20585.382438526867, 20835.79164208399, 20946.58106837885, 21235.088842003675, 21645.567088658452, 19155.712664310326, 19256.903715481334, 19621.411357659294, 19646.115924783135, 19939.0, 17688.55778605494, 17741.0, 18035.81964180394, 18069.186886589872, 18252.81747182511, 17728.46814595564, 18071.909640451715, 18129.728054079464, 18207.90896045511, 18438.0, 13159.407826647632, 13202.207867527979, 13331.200127992352, 13501.729965400833, 13572.04995650295, 13710.931445343109, 13913.721725565634, 13946.093503922213, 13992.580222593338, 14061.789073164115], "value": 9195.864347655623, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1573.8999999999999, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [105.0, 121.0, 107.0, 115.0, 113.0, 112.0, 113.0, 102.0, 114.0, 113.0], "value": 111.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 121.0, 155.0, 189.0, 126.0, 145.0, 153.0, 120.0, 183.0, 123.0], "value": 146.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [173.0, 170.0, 167.0, 165.0, 171.0, 172.0, 169.0, 170.0, 166.0, 171.0], "value": 169.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 78.0, 77.0, 181.0, 83.0, 87.0, 83.0, 80.0, 169.0, 82.0], "value": 100.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 81.0, 131.0, 83.0, 86.0, 85.0, 140.0, 79.0, 88.0, 127.0], "value": 98.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [122.0, 115.0, 114.0, 120.0, 116.0, 117.0, 117.0, 123.0, 120.0, 115.0], "value": 117.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 160.0, 159.0, 153.0, 155.0, 151.0, 155.0, 155.0, 155.0, 151.0], "value": 154.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [101.0, 97.0, 97.0, 96.0, 103.0, 99.0, 96.0, 95.0, 101.0, 101.0], "value": 98.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 53.0, 53.0, 53.0, 54.0, 53.0, 53.0, 53.0, 54.0, 55.0], "value": 54.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 58.0, 62.0, 56.0, 55.0, 60.0, 56.0, 55.0, 60.0, 63.0], "value": 58.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 80.0, 82.0, 81.0, 76.0, 80.0, 78.0, 78.0, 76.0, 76.0], "value": 78.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [129.0, 128.0, 127.0, 135.0, 135.0, 136.0, 128.0, 129.0, 127.0, 162.0], "value": 133.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [187.0, 184.0, 187.0, 180.0, 179.0, 185.0, 176.0, 181.0, 178.0, 175.0], "value": 181.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 79.0, 69.0, 74.0, 69.0, 68.0, 70.0, 76.0, 67.0, 68.0], "value": 70.8, "unit": "score"}]}]} 16:43:31 INFO - Return code: 0 16:43:31 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 16:43:31 INFO - # TBPL SUCCESS # 16:43:31 INFO - Running post-action listener: _package_coverage_data 16:43:31 INFO - Running post-action listener: _resource_record_post_action 16:43:31 INFO - [mozharness: 2017-08-16 23:43:31.591612Z] Finished run-tests step (success) 16:43:31 INFO - Running post-run listener: _resource_record_post_run 16:43:31 INFO - Total resource usage - Wall time: 1201s; CPU: 13.0%; Read bytes: 3518464; Write bytes: 441106432; Read time: 1024; Write time: 408200 16:43:31 INFO - TinderboxPrint: CPU usage
13.3% 16:43:31 INFO - TinderboxPrint: I/O read bytes / time
3,518,464 / 1,024 16:43:31 INFO - TinderboxPrint: I/O write bytes / time
441,106,432 / 408,200 16:43:31 INFO - TinderboxPrint: CPU idle
8,293.7 (86.7%) 16:43:31 INFO - TinderboxPrint: CPU user
1,209.9 (12.6%) 16:43:31 INFO - TinderboxPrint: Swap in / out
0 / 0 16:43:31 INFO - install - Wall time: 19s; CPU: 13.0%; Read bytes: 0; Write bytes: 106254336; Read time: 0; Write time: 164788 16:43:31 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 16:43:31 INFO - run-tests - Wall time: 1182s; CPU: 13.0%; Read bytes: 3514368; Write bytes: 333393920; Read time: 1020; Write time: 243268 16:43:32 INFO - Running post-run listener: _upload_blobber_files 16:43:32 INFO - Blob upload gear active. 16:43:32 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 16:43:32 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 16:43:32 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'] 16:43:32 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 16:43:32 INFO - (blobuploader) - INFO - Open directory for files ... 16:43:32 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 16:43:32 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:43:32 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:43:33 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 16:43:33 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:43:33 INFO - (blobuploader) - INFO - Done attempting. 16:43:33 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 16:43:33 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:43:33 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:43:40 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 16:43:40 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:43:40 INFO - (blobuploader) - INFO - Done attempting. 16:43:40 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 16:43:40 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:43:40 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:43:41 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 16:43:41 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:43:41 INFO - (blobuploader) - INFO - Done attempting. 16:43:41 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 16:43:41 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:43:41 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:43:41 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 16:43:41 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:43:41 INFO - (blobuploader) - INFO - Done attempting. 16:43:41 INFO - (blobuploader) - INFO - Iteration through files over. 16:43:41 INFO - Return code: 0 16:43:41 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 16:43:41 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 16:43:41 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ece3d0d41be0ed79b0cbd493e2dd463c35bf02c258ce7e601741333e86ab5e9f887fbf624ae31796d263a3135df8ab02c7349f2b78ad4ecee91498b4c31c56c8", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/60834d062e0fdcc9750dd77887e2d480ead7f5190e49f4b68df0319d3067f97dd52f0ede0aaa5051dcdc2b63b1309410e1abd27879343723ede35733a1543891", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/94d58c881d164237aa4f7b0a726ecd8ef149808517df70cf47f4091c6409e79fee29cc7cbbcf1cdeae687a85b181d2e6ff42bac6361848e9c2253d6945bf1d1b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/97cc5fc7c3b6178f6e4146db921065ef891485009a530deae9a2f343efb9fb277a2244abf1fb4e7468afff2ba26881ac11aa2e1578b2f2eeaa068ded44a72597"} 16:43:41 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 16:43:41 INFO - Writing to file /builds/slave/test/properties/blobber_files 16:43:41 INFO - Contents: 16:43:41 INFO - blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ece3d0d41be0ed79b0cbd493e2dd463c35bf02c258ce7e601741333e86ab5e9f887fbf624ae31796d263a3135df8ab02c7349f2b78ad4ecee91498b4c31c56c8", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/60834d062e0fdcc9750dd77887e2d480ead7f5190e49f4b68df0319d3067f97dd52f0ede0aaa5051dcdc2b63b1309410e1abd27879343723ede35733a1543891", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/94d58c881d164237aa4f7b0a726ecd8ef149808517df70cf47f4091c6409e79fee29cc7cbbcf1cdeae687a85b181d2e6ff42bac6361848e9c2253d6945bf1d1b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/97cc5fc7c3b6178f6e4146db921065ef891485009a530deae9a2f343efb9fb277a2244abf1fb4e7468afff2ba26881ac11aa2e1578b2f2eeaa068ded44a72597"} 16:43:41 INFO - Running post-run listener: copy_logs_to_upload_dir 16:43:41 INFO - Copying logs to upload dir... 16:43:41 INFO - mkdir: /builds/slave/test/build/upload/logs 16:43:41 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1262.084378 ========= master_lag: 0.05 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 2 secs) (at 2017-08-16 16:43:41.487244) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-08-16 16:43:41.490809) ========= 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=52faae308a556c440401f8e5000001e8-1502921579.399767-1660496627 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ece3d0d41be0ed79b0cbd493e2dd463c35bf02c258ce7e601741333e86ab5e9f887fbf624ae31796d263a3135df8ab02c7349f2b78ad4ecee91498b4c31c56c8", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/60834d062e0fdcc9750dd77887e2d480ead7f5190e49f4b68df0319d3067f97dd52f0ede0aaa5051dcdc2b63b1309410e1abd27879343723ede35733a1543891", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/94d58c881d164237aa4f7b0a726ecd8ef149808517df70cf47f4091c6409e79fee29cc7cbbcf1cdeae687a85b181d2e6ff42bac6361848e9c2253d6945bf1d1b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/97cc5fc7c3b6178f6e4146db921065ef891485009a530deae9a2f343efb9fb277a2244abf1fb4e7468afff2ba26881ac11aa2e1578b2f2eeaa068ded44a72597"} build_url:https://queue.taskcluster.net/v1/task/MwNIxikqQeW7ZnNry6c34A/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011363 build_url: 'https://queue.taskcluster.net/v1/task/MwNIxikqQeW7ZnNry6c34A/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ece3d0d41be0ed79b0cbd493e2dd463c35bf02c258ce7e601741333e86ab5e9f887fbf624ae31796d263a3135df8ab02c7349f2b78ad4ecee91498b4c31c56c8", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/60834d062e0fdcc9750dd77887e2d480ead7f5190e49f4b68df0319d3067f97dd52f0ede0aaa5051dcdc2b63b1309410e1abd27879343723ede35733a1543891", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/94d58c881d164237aa4f7b0a726ecd8ef149808517df70cf47f4091c6409e79fee29cc7cbbcf1cdeae687a85b181d2e6ff42bac6361848e9c2253d6945bf1d1b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/97cc5fc7c3b6178f6e4146db921065ef891485009a530deae9a2f343efb9fb277a2244abf1fb4e7468afff2ba26881ac11aa2e1578b2f2eeaa068ded44a72597"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-08-16 16:43:41.518492) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-08-16 16:43:41.518862) ========= 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=52faae308a556c440401f8e5000001e8-1502921579.399767-1660496627 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004414 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-08-16 16:43:41.604159) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-08-16 16:43:41.604535) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-08-16 16:43:41.604926) ========= ========= Total master_lag: 0.24 =========