builder: mozilla-central_ubuntu64_hw_styloseq_test-dromaeojs-e10s slave: talos-linux64-ix-003 starttime: 1496178129.96 results: success (0) revision: 692e277e2b9f3bb36d6d67e1166d135228f2d851 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-05-30 14:02:09.961615) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-05-30 14:02:09.962058) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-30 14:02:09.962350) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-30 14:02:10.144427) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-30 14:02:10.144682) ========= 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=7de08804244eb36560b44971000001c3-1496171457.632463-630333248 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-05-30 14:02:10-- 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% 46.1M=0s 2017-05-30 14:02:10 (46.1 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.098611 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-30 14:02:10.271540) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-30 14:02:10.271830) ========= 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=7de08804244eb36560b44971000001c3-1496171457.632463-630333248 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.023568 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-30 14:02:10.338469) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-30 14:02:10.338789) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 692e277e2b9f3bb36d6d67e1166d135228f2d851 --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 692e277e2b9f3bb36d6d67e1166d135228f2d851 --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=7de08804244eb36560b44971000001c3-1496171457.632463-630333248 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-05-30 14:02:10,991 truncating revision to first 12 chars 2017-05-30 14:02:10,991 Setting DEBUG logging. 2017-05-30 14:02:10,991 attempt 1/10 2017-05-30 14:02:10,992 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/692e277e2b9f?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-05-30 14:02:11,461 unpacking tar archive at: mozilla-central-692e277e2b9f/testing/mozharness/ program finished with exit code 0 elapsedTime=0.778022 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-30 14:02:11.134614) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-30 14:02:11.135163) ========= script_repo_revision: 692e277e2b9f3bb36d6d67e1166d135228f2d851 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-30 14:02:11.135813) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-30 14:02:11.136262) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-30 14:02:11.159840) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 22 mins, 6 secs) (at 2017-05-30 14:02:11.160132) ========= /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=7de08804244eb36560b44971000001c3-1496171457.632463-630333248 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 14:02:11 INFO - MultiFileLogger online at 20170530 14:02:11 in /builds/slave/test 14:02:11 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 14:02:11 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 14:02:11 INFO - {'append_to_log': False, 14:02:11 INFO - 'base_work_dir': '/builds/slave/test', 14:02:11 INFO - 'blob_upload_branch': 'Firefox', 14:02:11 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 14:02:11 INFO - 'branch': 'Firefox', 14:02:11 INFO - 'buildbot_json_path': 'buildprops.json', 14:02:11 INFO - 'config_files': ('talos/linux_config.py',), 14:02:11 INFO - 'default_actions': ('clobber', 14:02:11 INFO - 'read-buildbot-config', 14:02:11 INFO - 'download-and-extract', 14:02:11 INFO - 'populate-webroot', 14:02:11 INFO - 'create-virtualenv', 14:02:11 INFO - 'install', 14:02:11 INFO - 'setup-mitmproxy', 14:02:11 INFO - 'run-tests'), 14:02:11 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 14:02:11 INFO - 'download_minidump_stackwalk': True, 14:02:11 INFO - 'download_symbols': 'ondemand', 14:02:11 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 14:02:11 INFO - 'tooltool.py': '/tools/tooltool.py', 14:02:11 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 14:02:11 INFO - '/tools/misc-python/virtualenv.py')}, 14:02:11 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 14:02:11 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 14:02:11 INFO - 'gecko_profile': False, 14:02:11 INFO - 'gecko_profile_interval': 0, 14:02:11 INFO - 'installer_path': 'installer.exe', 14:02:11 INFO - 'log_level': 'info', 14:02:11 INFO - 'log_name': 'talos', 14:02:11 INFO - 'log_to_console': True, 14:02:11 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 14:02:11 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 14:02:11 INFO - 'opt_config_files': (), 14:02:11 INFO - 'pip_index': False, 14:02:11 INFO - 'suite': 'dromaeojs-e10s', 14:02:11 INFO - 'system_bits': '32', 14:02:11 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 14:02:11 INFO - 'title': 'talos-linux64-ix-003', 14:02:11 INFO - 'tooltool_cache': '/builds/tooltool_cache', 14:02:11 INFO - 'use_talos_json': True, 14:02:11 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 14:02:11 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 14:02:11 INFO - 'work_dir': 'build'} 14:02:11 INFO - [mozharness: 2017-05-30 21:02:11.922078Z] Running clobber step. 14:02:11 INFO - Running pre-action listener: _resource_record_pre_action 14:02:11 INFO - Running main action method: clobber 14:02:11 INFO - rmtree: /builds/slave/test/build 14:02:11 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 14:02:12 INFO - Running post-action listener: _resource_record_post_action 14:02:12 INFO - [mozharness: 2017-05-30 21:02:12.958307Z] Finished clobber step (success) 14:02:12 INFO - [mozharness: 2017-05-30 21:02:12.958409Z] Running read-buildbot-config step. 14:02:12 INFO - Running pre-action listener: _resource_record_pre_action 14:02:12 INFO - Running main action method: read_buildbot_config 14:02:12 INFO - Using buildbot properties: 14:02:12 INFO - { 14:02:12 INFO - "project": "", 14:02:12 INFO - "product": "firefox", 14:02:12 INFO - "who": "ryanvm@gmail.com", 14:02:12 INFO - "installer_path": "public/build/target.tar.bz2", 14:02:12 INFO - "builddir": "mozilla-central_ubuntu64_hw_styloseq_test-dromaeojs-e10s", 14:02:12 INFO - "repository": "https://hg.mozilla.org/mozilla-central/", 14:02:12 INFO - "buildername": "Ubuntu HW 12.04 x64 stylo-sequential mozilla-central talos dromaeojs-e10s", 14:02:12 INFO - "stage_platform": "linux64-stylosequential", 14:02:12 INFO - "basedir": "/builds/slave/test", 14:02:12 INFO - "buildnumber": 34, 14:02:12 INFO - "platform": "ubuntu64_hw_styloseq", 14:02:12 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 14:02:12 INFO - "slavebuilddir": "test", 14:02:12 INFO - "taskId": "LPjGIyG0TCuGfnG5M8PBmg", 14:02:12 INFO - "branch": "mozilla-central", 14:02:12 INFO - "script_repo_revision": "production", 14:02:12 INFO - "revision": "692e277e2b9f3bb36d6d67e1166d135228f2d851", 14:02:12 INFO - "slavename": "talos-linux64-ix-003", 14:02:12 INFO - "repo_path": "mozilla-central" 14:02:12 INFO - } 14:02:12 INFO - Finding installer, test and symbols from parent task. 14:02:12 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/LPjGIyG0TCuGfnG5M8PBmg'}, attempt #1 14:02:13 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/LPjGIyG0TCuGfnG5M8PBmg'}, attempt #1 14:02:13 INFO - Task dependencies: QcHb3q6rSq-29FSDzJWOeg 14:02:13 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/QcHb3q6rSq-29FSDzJWOeg'}, attempt #1 14:02:14 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/QcHb3q6rSq-29FSDzJWOeg/artifacts/public/build/target.tar.bz2 14:02:14 INFO - Set test_url: https://queue.taskcluster.net/v1/task/QcHb3q6rSq-29FSDzJWOeg/artifacts/public/build/test_packages.json 14:02:14 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/QcHb3q6rSq-29FSDzJWOeg/artifacts/public/build/target.crashreporter-symbols.zip 14:02:14 INFO - Running post-action listener: _resource_record_post_action 14:02:14 INFO - [mozharness: 2017-05-30 21:02:14.409721Z] Finished read-buildbot-config step (success) 14:02:14 INFO - [mozharness: 2017-05-30 21:02:14.409943Z] Running download-and-extract step. 14:02:14 INFO - Running pre-action listener: _resource_record_pre_action 14:02:14 INFO - Running main action method: download_and_extract 14:02:14 INFO - mkdir: /builds/slave/test/build/tests 14:02:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:02:14 INFO - trying https://queue.taskcluster.net/v1/task/QcHb3q6rSq-29FSDzJWOeg/artifacts/public/build/target.test_packages.json 14:02:14 INFO - Downloading https://queue.taskcluster.net/v1/task/QcHb3q6rSq-29FSDzJWOeg/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 14:02:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/QcHb3q6rSq-29FSDzJWOeg/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 14:02:14 INFO - Downloaded 986 bytes. 14:02:14 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 14:02:14 INFO - Using the following test package requirements: 14:02:14 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 14:02:14 INFO - u'common': [u'target.common.tests.zip'], 14:02:14 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 14:02:14 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 14:02:14 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 14:02:14 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 14:02:14 INFO - u'mozbase': [u'target.common.tests.zip'], 14:02:14 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 14:02:14 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 14:02:14 INFO - u'web-platform': [u'target.common.tests.zip', 14:02:14 INFO - u'target.web-platform.tests.zip'], 14:02:14 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 14:02:14 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 14:02:14 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/QcHb3q6rSq-29FSDzJWOeg/artifacts/public/build/target.common.tests.zip 14:02:14 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/QcHb3q6rSq-29FSDzJWOeg/artifacts/public/build/target.common.tests.zip'}, attempt #1 14:02:14 INFO - Fetch https://queue.taskcluster.net/v1/task/QcHb3q6rSq-29FSDzJWOeg/artifacts/public/build/target.common.tests.zip into memory 14:02:17 INFO - Content-Length response header: 63526970 14:02:17 INFO - Bytes received: 63526970 14:02:28 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 14:02:28 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/QcHb3q6rSq-29FSDzJWOeg/artifacts/public/build/target.common.tests.zip 14:02:28 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/QcHb3q6rSq-29FSDzJWOeg/artifacts/public/build/target.common.tests.zip'}, attempt #1 14:02:28 INFO - Fetch https://queue.taskcluster.net/v1/task/QcHb3q6rSq-29FSDzJWOeg/artifacts/public/build/target.common.tests.zip into memory 14:02:30 INFO - Content-Length response header: 63526970 14:02:30 INFO - Bytes received: 63526970 14:02:44 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/QcHb3q6rSq-29FSDzJWOeg/artifacts/public/build/target.talos.tests.zip 14:02:44 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/QcHb3q6rSq-29FSDzJWOeg/artifacts/public/build/target.talos.tests.zip'}, attempt #1 14:02:44 INFO - Fetch https://queue.taskcluster.net/v1/task/QcHb3q6rSq-29FSDzJWOeg/artifacts/public/build/target.talos.tests.zip into memory 14:02:45 INFO - Content-Length response header: 14447425 14:02:45 INFO - Bytes received: 14447425 14:02:45 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')]} 14:02:45 INFO - trying https://queue.taskcluster.net/v1/task/QcHb3q6rSq-29FSDzJWOeg/artifacts/public/build/target.tar.bz2 14:02:45 INFO - Downloading https://queue.taskcluster.net/v1/task/QcHb3q6rSq-29FSDzJWOeg/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 14:02:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/QcHb3q6rSq-29FSDzJWOeg/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 14:02:46 INFO - Downloaded 55963681 bytes. 14:02:46 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/QcHb3q6rSq-29FSDzJWOeg/artifacts/public/build/target.tar.bz2 14:02:46 INFO - mkdir: /builds/slave/test/properties 14:02:46 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 14:02:46 INFO - Writing to file /builds/slave/test/properties/build_url 14:02:46 INFO - Contents: 14:02:46 INFO - build_url:https://queue.taskcluster.net/v1/task/QcHb3q6rSq-29FSDzJWOeg/artifacts/public/build/target.tar.bz2 14:02:46 INFO - Running post-action listener: _resource_record_post_action 14:02:46 INFO - Running post-action listener: set_extra_try_arguments 14:02:46 INFO - [mozharness: 2017-05-30 21:02:46.958803Z] Finished download-and-extract step (success) 14:02:46 INFO - [mozharness: 2017-05-30 21:02:46.958901Z] Running populate-webroot step. 14:02:46 INFO - Running pre-action listener: _resource_record_pre_action 14:02:46 INFO - Running main action method: populate_webroot 14:02:46 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 14:02:46 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 14:02:46 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 14:02:46 INFO - '--tppagecycles', 14:02:46 INFO - '7'], 14:02:46 INFO - 'tests': ['tsvgm']}}, 14:02:46 INFO - 'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 14:02:46 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 14:02:46 INFO - 'tests': ['dromaeo_css', 'kraken']}, 14:02:46 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 14:02:46 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 14:02:46 INFO - 'talos_options': ['--disable-e10s'], 14:02:46 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:02:46 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 14:02:46 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:02:46 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 14:02:46 INFO - 'talos_options': ['--disable-e10s'], 14:02:46 INFO - 'tests': ['damp', 'tps']}, 14:02:46 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 14:02:46 INFO - 'tests': ['damp', 'tps']}, 14:02:46 INFO - 'g3': {'talos_options': ['--disable-e10s'], 14:02:46 INFO - 'tests': ['dromaeo_dom']}, 14:02:46 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 14:02:46 INFO - 'g4': {'talos_options': ['--disable-e10s'], 14:02:46 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 14:02:46 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 14:02:46 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 14:02:46 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 14:02:46 INFO - 'other': {'talos_options': ['--disable-e10s'], 14:02:46 INFO - 'tests': ['a11yr', 14:02:46 INFO - 'ts_paint', 14:02:46 INFO - 'tpaint', 14:02:46 INFO - 'sessionrestore', 14:02:46 INFO - 'sessionrestore_no_auto_restore', 14:02:46 INFO - 'tabpaint']}, 14:02:46 INFO - 'other-e10s': {'tests': ['a11yr', 14:02:46 INFO - 'ts_paint', 14:02:46 INFO - 'tpaint', 14:02:46 INFO - 'sessionrestore', 14:02:46 INFO - 'sessionrestore_no_auto_restore', 14:02:46 INFO - 'tabpaint']}, 14:02:46 INFO - 'other-e10s_l64': {'tests': ['a11yr', 14:02:46 INFO - 'ts_paint', 14:02:46 INFO - 'tpaint', 14:02:46 INFO - 'sessionrestore', 14:02:46 INFO - 'sessionrestore_no_auto_restore', 14:02:46 INFO - 'tabpaint']}, 14:02:46 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 14:02:46 INFO - 'ts_paint', 14:02:46 INFO - 'tpaint', 14:02:46 INFO - 'sessionrestore', 14:02:46 INFO - 'sessionrestore_no_auto_restore', 14:02:46 INFO - 'tabpaint']}, 14:02:46 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 14:02:46 INFO - 'tests': ['a11yr', 14:02:46 INFO - 'ts_paint', 14:02:46 INFO - 'tpaint', 14:02:46 INFO - 'sessionrestore', 14:02:46 INFO - 'sessionrestore_no_auto_restore', 14:02:46 INFO - 'tabpaint']}, 14:02:46 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 14:02:46 INFO - 'tests': ['a11yr', 14:02:46 INFO - 'ts_paint', 14:02:46 INFO - 'tpaint', 14:02:46 INFO - 'sessionrestore', 14:02:46 INFO - 'sessionrestore_no_auto_restore', 14:02:46 INFO - 'tabpaint']}, 14:02:46 INFO - 'perf-reftest': {'tests': ['bloom_basic', 'bloom_basic_ref']}, 14:02:46 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic', 14:02:46 INFO - 'bloom_basic_ref']}, 14:02:46 INFO - 'quantum-pageload-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set.zip', 14:02:46 INFO - 'talos_options': ['--mitmproxy', 14:02:46 INFO - 'mitmproxy-recording-1.mp', 14:02:46 INFO - '--firstNonBlankPaint'], 14:02:46 INFO - 'tests': ['Quantum_1']}, 14:02:46 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 14:02:46 INFO - 'tests': ['tsvgx', 14:02:46 INFO - 'tsvgr_opacity', 14:02:46 INFO - 'tart', 14:02:46 INFO - 'tscrollx', 14:02:46 INFO - 'cart', 14:02:46 INFO - 'tsvg_static']}, 14:02:46 INFO - 'svgr-e10s': {'tests': ['tsvgx', 14:02:46 INFO - 'tsvgr_opacity', 14:02:46 INFO - 'tart', 14:02:46 INFO - 'tscrollx', 14:02:46 INFO - 'cart', 14:02:46 INFO - 'tsvg_static']}, 14:02:46 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 14:02:46 INFO - 'talos_options': ['--disable-e10s'], 14:02:46 INFO - 'tests': ['tp5o']}, 14:02:46 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 14:02:46 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 14:02:46 INFO - 'talos_options': ['--disable-e10s', 14:02:46 INFO - '--xperf_path', 14:02:46 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:02:46 INFO - 'tests': ['tp5n']}, 14:02:46 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 14:02:46 INFO - 'talos_options': ['--xperf_path', 14:02:46 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:02:46 INFO - 'tests': ['tp5n']}}, 14:02:46 INFO - 'talos.zip': {'path': '', 14:02:46 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 14:02:46 INFO - Running post-action listener: _resource_record_post_action 14:02:46 INFO - [mozharness: 2017-05-30 21:02:46.973578Z] Finished populate-webroot step (success) 14:02:46 INFO - [mozharness: 2017-05-30 21:02:46.973673Z] Running create-virtualenv step. 14:02:46 INFO - Running pre-action listener: _resource_record_pre_action 14:02:46 INFO - Running main action method: create_virtualenv 14:02:46 INFO - Creating virtualenv /builds/slave/test/build/venv 14:02:46 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 14:02:46 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 14:02:47 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 14:02:47 INFO - Using real prefix '/usr' 14:02:47 INFO - New python executable in /builds/slave/test/build/venv/bin/python 14:02:47 INFO - Installing distribute.............................................................................................................................................................................................done. 14:02:49 INFO - Installing pip.................done. 14:02:49 INFO - Return code: 0 14:02:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 14:02:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 14:02:49 INFO - Reading from file tmpfile_stdout 14:02:49 INFO - Output received: 14:02:49 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) 14:02:49 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 14:02: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')]} 14:02:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:02: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')]} 14:02:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:02:49 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 0x1e153b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fefa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2192ef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x218fe40>, '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 0x2190fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2191440>, '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': '7de08804244eb36560b44971000001c3-1496171457.632463-630333248', '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 14:02:49 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 14:02:49 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 14:02:49 INFO - Using env: {'DISPLAY': ':0', 14:02:49 INFO - 'HOME': '/home/cltbld', 14:02:49 INFO - 'LANG': 'en_US.UTF-8', 14:02:49 INFO - 'LANGUAGE': 'en_US:en', 14:02:49 INFO - 'LOGNAME': 'cltbld', 14:02:49 INFO - 'MAIL': '/var/mail/cltbld', 14:02:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:02:49 INFO - 'MOZ_NO_REMOTE': '1', 14:02:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:02:49 INFO - 'NO_EM_RESTART': '1', 14:02:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:02:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:02:49 INFO - 'PWD': '/builds/slave/test', 14:02:49 INFO - 'SHELL': '/bin/bash', 14:02:49 INFO - 'SHLVL': '1', 14:02:49 INFO - 'TERM': 'linux', 14:02:49 INFO - 'TMOUT': '86400', 14:02:49 INFO - 'USER': 'cltbld', 14:02:49 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1496171457.632463-630333248', 14:02:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:02:49 INFO - '_': '/tools/buildbot/bin/python'} 14:02:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:02:50 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 14:02:50 INFO - Cleaning up... 14:02:50 INFO - Return code: 0 14:02:50 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 14:02:50 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')]} 14:02:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:02:50 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')]} 14:02:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:02:50 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 0x1e153b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fefa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2192ef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x218fe40>, '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 0x2190fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2191440>, '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': '7de08804244eb36560b44971000001c3-1496171457.632463-630333248', '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 14:02:50 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 14:02:50 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 14:02:50 INFO - Using env: {'DISPLAY': ':0', 14:02:50 INFO - 'HOME': '/home/cltbld', 14:02:50 INFO - 'LANG': 'en_US.UTF-8', 14:02:50 INFO - 'LANGUAGE': 'en_US:en', 14:02:50 INFO - 'LOGNAME': 'cltbld', 14:02:50 INFO - 'MAIL': '/var/mail/cltbld', 14:02:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:02:50 INFO - 'MOZ_NO_REMOTE': '1', 14:02:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:02:50 INFO - 'NO_EM_RESTART': '1', 14:02:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:02:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:02:50 INFO - 'PWD': '/builds/slave/test', 14:02:50 INFO - 'SHELL': '/bin/bash', 14:02:50 INFO - 'SHLVL': '1', 14:02:50 INFO - 'TERM': 'linux', 14:02:50 INFO - 'TMOUT': '86400', 14:02:50 INFO - 'USER': 'cltbld', 14:02:50 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1496171457.632463-630333248', 14:02:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:02:50 INFO - '_': '/tools/buildbot/bin/python'} 14:02:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:02:50 INFO - Downloading/unpacking psutil>=3.1.1 14:02:50 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 14:02:50 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 14:02:50 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 14:02:50 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 14:02:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 14:02:51 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:02:51 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:02:51 INFO - Installing collected packages: psutil 14:02:51 INFO - Running setup.py install for psutil 14:02:51 INFO - building 'psutil._psutil_linux' extension 14:02:51 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 14:02:51 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 14:02:51 INFO - building 'psutil._psutil_posix' extension 14:02:51 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 14:02:51 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 14:02:51 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:02:51 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:02:51 INFO - Successfully installed psutil 14:02:51 INFO - Cleaning up... 14:02:51 INFO - Return code: 0 14:02:51 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 14:02:51 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')]} 14:02:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:02:51 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')]} 14:02:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:02:51 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 0x1e153b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fefa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2192ef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x218fe40>, '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 0x2190fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2191440>, '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': '7de08804244eb36560b44971000001c3-1496171457.632463-630333248', '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 14:02:51 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 14:02:52 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 14:02:52 INFO - Using env: {'DISPLAY': ':0', 14:02:52 INFO - 'HOME': '/home/cltbld', 14:02:52 INFO - 'LANG': 'en_US.UTF-8', 14:02:52 INFO - 'LANGUAGE': 'en_US:en', 14:02:52 INFO - 'LOGNAME': 'cltbld', 14:02:52 INFO - 'MAIL': '/var/mail/cltbld', 14:02:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:02:52 INFO - 'MOZ_NO_REMOTE': '1', 14:02:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:02:52 INFO - 'NO_EM_RESTART': '1', 14:02:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:02:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:02:52 INFO - 'PWD': '/builds/slave/test', 14:02:52 INFO - 'SHELL': '/bin/bash', 14:02:52 INFO - 'SHLVL': '1', 14:02:52 INFO - 'TERM': 'linux', 14:02:52 INFO - 'TMOUT': '86400', 14:02:52 INFO - 'USER': 'cltbld', 14:02:52 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1496171457.632463-630333248', 14:02:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:02:52 INFO - '_': '/tools/buildbot/bin/python'} 14:02:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:02:52 INFO - Downloading/unpacking mozsystemmonitor==0.3 14:02:52 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 14:02:52 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 14:02:52 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 14:02:52 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 14:02:53 INFO - Downloading mozsystemmonitor-0.3.tar.gz 14:02:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 14:02:53 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 14:02:53 INFO - Installing collected packages: mozsystemmonitor 14:02:53 INFO - Running setup.py install for mozsystemmonitor 14:02:53 INFO - Successfully installed mozsystemmonitor 14:02:53 INFO - Cleaning up... 14:02:53 INFO - Return code: 0 14:02:53 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 14:02:53 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')]} 14:02:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:02:53 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')]} 14:02:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:02:53 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 0x1e153b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fefa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2192ef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x218fe40>, '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 0x2190fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2191440>, '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': '7de08804244eb36560b44971000001c3-1496171457.632463-630333248', '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 14:02:53 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 14:02:53 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 14:02:53 INFO - Using env: {'DISPLAY': ':0', 14:02:53 INFO - 'HOME': '/home/cltbld', 14:02:53 INFO - 'LANG': 'en_US.UTF-8', 14:02:53 INFO - 'LANGUAGE': 'en_US:en', 14:02:53 INFO - 'LOGNAME': 'cltbld', 14:02:53 INFO - 'MAIL': '/var/mail/cltbld', 14:02:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:02:53 INFO - 'MOZ_NO_REMOTE': '1', 14:02:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:02:53 INFO - 'NO_EM_RESTART': '1', 14:02:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:02:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:02:53 INFO - 'PWD': '/builds/slave/test', 14:02:53 INFO - 'SHELL': '/bin/bash', 14:02:53 INFO - 'SHLVL': '1', 14:02:53 INFO - 'TERM': 'linux', 14:02:53 INFO - 'TMOUT': '86400', 14:02:53 INFO - 'USER': 'cltbld', 14:02:53 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1496171457.632463-630333248', 14:02:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:02:53 INFO - '_': '/tools/buildbot/bin/python'} 14:02:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:02:53 INFO - Downloading/unpacking jsonschema==2.5.1 14:02:53 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 14:02:53 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 14:02:53 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 14:02:53 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 14:02:54 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 14:02:54 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 14:02:54 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 14:02:54 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 14:02:54 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 14:02:54 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 14:02:54 INFO - Downloading functools32-3.2.3-2.tar.gz 14:02:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 14:02:54 INFO - warning: no files found matching '*.txt' 14:02:54 INFO - no previously-included directories found matching 'build' 14:02:54 INFO - no previously-included directories found matching 'dist' 14:02:54 INFO - no previously-included directories found matching '.git*' 14:02:54 INFO - Installing collected packages: jsonschema, functools32 14:02:55 INFO - Running setup.py install for functools32 14:02:55 INFO - warning: no files found matching '*.txt' 14:02:55 INFO - no previously-included directories found matching 'build' 14:02:55 INFO - no previously-included directories found matching 'dist' 14:02:55 INFO - no previously-included directories found matching '.git*' 14:02:55 INFO - Successfully installed jsonschema functools32 14:02:55 INFO - Cleaning up... 14:02:55 INFO - Return code: 0 14:02:55 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 14:02:55 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')]} 14:02:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:02:55 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')]} 14:02:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:02:55 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 0x1e153b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fefa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2192ef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x218fe40>, '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 0x2190fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2191440>, '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': '7de08804244eb36560b44971000001c3-1496171457.632463-630333248', '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 14:02:55 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 14:02:55 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 14:02:55 INFO - Using env: {'DISPLAY': ':0', 14:02:55 INFO - 'HOME': '/home/cltbld', 14:02:55 INFO - 'LANG': 'en_US.UTF-8', 14:02:55 INFO - 'LANGUAGE': 'en_US:en', 14:02:55 INFO - 'LOGNAME': 'cltbld', 14:02:55 INFO - 'MAIL': '/var/mail/cltbld', 14:02:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:02:55 INFO - 'MOZ_NO_REMOTE': '1', 14:02:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:02:55 INFO - 'NO_EM_RESTART': '1', 14:02:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:02:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:02:55 INFO - 'PWD': '/builds/slave/test', 14:02:55 INFO - 'SHELL': '/bin/bash', 14:02:55 INFO - 'SHLVL': '1', 14:02:55 INFO - 'TERM': 'linux', 14:02:55 INFO - 'TMOUT': '86400', 14:02:55 INFO - 'USER': 'cltbld', 14:02:55 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1496171457.632463-630333248', 14:02:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:02:55 INFO - '_': '/tools/buildbot/bin/python'} 14:02:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:02:55 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 14:02:55 INFO - Cleaning up... 14:02:55 INFO - Return code: 0 14:02:55 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 14:02:55 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')]} 14:02:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:02:55 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')]} 14:02:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:02:55 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 0x1e153b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fefa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2192ef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x218fe40>, '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 0x2190fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2191440>, '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': '7de08804244eb36560b44971000001c3-1496171457.632463-630333248', '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 14:02:55 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 14:02:55 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 14:02:55 INFO - Using env: {'DISPLAY': ':0', 14:02:55 INFO - 'HOME': '/home/cltbld', 14:02:55 INFO - 'LANG': 'en_US.UTF-8', 14:02:55 INFO - 'LANGUAGE': 'en_US:en', 14:02:55 INFO - 'LOGNAME': 'cltbld', 14:02:55 INFO - 'MAIL': '/var/mail/cltbld', 14:02:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:02:55 INFO - 'MOZ_NO_REMOTE': '1', 14:02:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:02:55 INFO - 'NO_EM_RESTART': '1', 14:02:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:02:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:02:55 INFO - 'PWD': '/builds/slave/test', 14:02:55 INFO - 'SHELL': '/bin/bash', 14:02:55 INFO - 'SHLVL': '1', 14:02:55 INFO - 'TERM': 'linux', 14:02:55 INFO - 'TMOUT': '86400', 14:02:55 INFO - 'USER': 'cltbld', 14:02:55 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1496171457.632463-630333248', 14:02:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:02:55 INFO - '_': '/tools/buildbot/bin/python'} 14:02:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:02:55 INFO - Downloading/unpacking blobuploader==1.2.4 14:02:55 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 14:02:55 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 14:02:55 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 14:02:55 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 14:02:56 INFO - Downloading blobuploader-1.2.4.tar.gz 14:02:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 14:02:56 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 14:02:56 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 14:02:56 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 14:02:56 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 14:02:56 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 14:02:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 14:02:57 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 14:02:57 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 14:02:57 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 14:02:57 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 14:02:57 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 14:02:57 INFO - Downloading docopt-0.6.1.tar.gz 14:02:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 14:02:57 INFO - Installing collected packages: blobuploader, requests, docopt 14:02:57 INFO - Running setup.py install for blobuploader 14:02:57 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 14:02:57 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 14:02:57 INFO - Running setup.py install for requests 14:02:57 INFO - Running setup.py install for docopt 14:02:57 INFO - Successfully installed blobuploader requests docopt 14:02:57 INFO - Cleaning up... 14:02:57 INFO - Return code: 0 14:02:57 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:02:57 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')]} 14:02:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:02:57 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')]} 14:02:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:02:57 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 0x1e153b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fefa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2192ef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x218fe40>, '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 0x2190fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2191440>, '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': '7de08804244eb36560b44971000001c3-1496171457.632463-630333248', '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 14:02:57 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 14:02:57 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 14:02:57 INFO - Using env: {'DISPLAY': ':0', 14:02:57 INFO - 'HOME': '/home/cltbld', 14:02:57 INFO - 'LANG': 'en_US.UTF-8', 14:02:57 INFO - 'LANGUAGE': 'en_US:en', 14:02:57 INFO - 'LOGNAME': 'cltbld', 14:02:57 INFO - 'MAIL': '/var/mail/cltbld', 14:02:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:02:57 INFO - 'MOZ_NO_REMOTE': '1', 14:02:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:02:57 INFO - 'NO_EM_RESTART': '1', 14:02:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:02:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:02:57 INFO - 'PWD': '/builds/slave/test', 14:02:57 INFO - 'SHELL': '/bin/bash', 14:02:57 INFO - 'SHLVL': '1', 14:02:57 INFO - 'TERM': 'linux', 14:02:57 INFO - 'TMOUT': '86400', 14:02:57 INFO - 'USER': 'cltbld', 14:02:57 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1496171457.632463-630333248', 14:02:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:02:57 INFO - '_': '/tools/buildbot/bin/python'} 14:02:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:02:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:02:58 INFO - Running setup.py (path:/tmp/pip-xfmoIF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:02:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:02:58 INFO - Running setup.py (path:/tmp/pip-v79j3_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:02:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:02:58 INFO - Running setup.py (path:/tmp/pip-agXGVg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:02:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:02:58 INFO - Running setup.py (path:/tmp/pip-1Kjc5G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:02:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:02:58 INFO - Running setup.py (path:/tmp/pip-Vyk0n4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:02:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:02:58 INFO - Running setup.py (path:/tmp/pip-tnM24y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:02:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:02:58 INFO - Running setup.py (path:/tmp/pip-HfMFMo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:02:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:02:58 INFO - Running setup.py (path:/tmp/pip-tjGzCL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:02:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:02:58 INFO - Running setup.py (path:/tmp/pip-1JvGF7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:02:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:02:58 INFO - Running setup.py (path:/tmp/pip-dG51J0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:02:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:02:58 INFO - Running setup.py (path:/tmp/pip-8CyTiz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:02:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:02:58 INFO - Running setup.py (path:/tmp/pip-PCrra4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:02:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:02:58 INFO - Running setup.py (path:/tmp/pip-UOno27-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:02:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:02:58 INFO - Running setup.py (path:/tmp/pip-5gZ49B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:02:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:02:59 INFO - Running setup.py (path:/tmp/pip-lvsILk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:02:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:02:59 INFO - Running setup.py (path:/tmp/pip-YxzZl9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:02:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:02:59 INFO - Running setup.py (path:/tmp/pip-Zb8g8k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:02:59 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 14:02:59 INFO - Running setup.py install for manifestparser 14:02:59 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 14:02:59 INFO - Running setup.py install for mozcrash 14:02:59 INFO - Running setup.py install for mozdebug 14:02:59 INFO - Running setup.py install for mozdevice 14:02:59 INFO - Installing dm script to /builds/slave/test/build/venv/bin 14:02:59 INFO - Running setup.py install for mozfile 14:02:59 INFO - Running setup.py install for mozhttpd 14:02:59 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 14:02:59 INFO - Running setup.py install for mozinfo 14:02:59 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 14:02:59 INFO - Running setup.py install for mozInstall 14:03:00 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 14:03:00 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 14:03:00 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 14:03:00 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 14:03:00 INFO - Running setup.py install for mozleak 14:03:00 INFO - Running setup.py install for mozlog 14:03:00 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 14:03:00 INFO - Running setup.py install for moznetwork 14:03:00 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 14:03:00 INFO - Running setup.py install for mozprocess 14:03:00 INFO - Running setup.py install for mozprofile 14:03:00 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 14:03:00 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 14:03:00 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 14:03:00 INFO - Running setup.py install for mozrunner 14:03:00 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 14:03:00 INFO - Running setup.py install for mozscreenshot 14:03:00 INFO - Running setup.py install for moztest 14:03:00 INFO - Running setup.py install for mozversion 14:03:01 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 14:03:01 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 14:03:01 INFO - Cleaning up... 14:03:01 INFO - Return code: 0 14:03:01 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:03:01 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')]} 14:03:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:03:01 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')]} 14:03:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:03:01 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 0x1e153b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fefa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2192ef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x218fe40>, '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 0x2190fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2191440>, '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': '7de08804244eb36560b44971000001c3-1496171457.632463-630333248', '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 14:03:01 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 14:03:01 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 14:03:01 INFO - Using env: {'DISPLAY': ':0', 14:03:01 INFO - 'HOME': '/home/cltbld', 14:03:01 INFO - 'LANG': 'en_US.UTF-8', 14:03:01 INFO - 'LANGUAGE': 'en_US:en', 14:03:01 INFO - 'LOGNAME': 'cltbld', 14:03:01 INFO - 'MAIL': '/var/mail/cltbld', 14:03:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:03:01 INFO - 'MOZ_NO_REMOTE': '1', 14:03:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:03:01 INFO - 'NO_EM_RESTART': '1', 14:03:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:03:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:03:01 INFO - 'PWD': '/builds/slave/test', 14:03:01 INFO - 'SHELL': '/bin/bash', 14:03:01 INFO - 'SHLVL': '1', 14:03:01 INFO - 'TERM': 'linux', 14:03:01 INFO - 'TMOUT': '86400', 14:03:01 INFO - 'USER': 'cltbld', 14:03:01 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1496171457.632463-630333248', 14:03:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:03:01 INFO - '_': '/tools/buildbot/bin/python'} 14:03:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:03:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:03:01 INFO - Running setup.py (path:/tmp/pip-JW2rvu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:03:01 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)) 14:03:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:03:01 INFO - Running setup.py (path:/tmp/pip-UQZgJi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:03:01 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)) 14:03:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:03:01 INFO - Running setup.py (path:/tmp/pip-UInWQl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:03:01 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)) 14:03:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:03:01 INFO - Running setup.py (path:/tmp/pip-mklvUx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:03:01 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)) 14:03:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:03:01 INFO - Running setup.py (path:/tmp/pip-A5Dy6i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:03:01 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)) 14:03:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:03:01 INFO - Running setup.py (path:/tmp/pip-qMEVc6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:03:01 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)) 14:03:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:03:01 INFO - Running setup.py (path:/tmp/pip-mU_FKS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:03:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 14:03:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:03:01 INFO - Running setup.py (path:/tmp/pip-1Rerm8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:03:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 14:03:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:03:01 INFO - Running setup.py (path:/tmp/pip-AToDKl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:03:01 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)) 14:03:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:03:01 INFO - Running setup.py (path:/tmp/pip-uEuFaM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:03:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 14:03:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:03:01 INFO - Running setup.py (path:/tmp/pip-o0SlGJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:03:02 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)) 14:03:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:03:02 INFO - Running setup.py (path:/tmp/pip-005DRp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:03:02 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)) 14:03:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:03:02 INFO - Running setup.py (path:/tmp/pip-wtRa9y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:03:02 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)) 14:03:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:03:02 INFO - Running setup.py (path:/tmp/pip-ykBuB7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:03:02 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)) 14:03:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:03:02 INFO - Running setup.py (path:/tmp/pip-zCs3c2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:03:02 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)) 14:03:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:03:02 INFO - Running setup.py (path:/tmp/pip-wjaajR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:03:02 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)) 14:03:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:03:02 INFO - Running setup.py (path:/tmp/pip-_f3wJU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:03:02 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)) 14:03:02 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)) 14:03:02 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)) 14:03:02 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)) 14:03:02 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)) 14:03:02 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)) 14:03:02 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 14:03:02 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 14:03:02 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 14:03:02 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 14:03:02 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 14:03:03 INFO - Downloading blessings-1.6.tar.gz 14:03:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 14:03:03 INFO - Installing collected packages: blessings 14:03:03 INFO - Running setup.py install for blessings 14:03:03 INFO - Successfully installed blessings 14:03:03 INFO - Cleaning up... 14:03:03 INFO - Return code: 0 14:03:03 INFO - Done creating virtualenv /builds/slave/test/build/venv. 14:03:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:03:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:03:04 INFO - Reading from file tmpfile_stdout 14:03:04 INFO - Current package versions: 14:03:04 INFO - argparse == 1.2.1 14:03:04 INFO - blessings == 1.6 14:03:04 INFO - blobuploader == 1.2.4 14:03:04 INFO - docopt == 0.6.1 14:03:04 INFO - functools32 == 3.2.3-2 14:03:04 INFO - jsonschema == 2.5.1 14:03:04 INFO - manifestparser == 1.1 14:03:04 INFO - mozInstall == 1.12 14:03:04 INFO - mozcrash == 1.0 14:03:04 INFO - mozdebug == 0.1 14:03:04 INFO - mozdevice == 0.51 14:03:04 INFO - mozfile == 1.2 14:03:04 INFO - mozhttpd == 0.7 14:03:04 INFO - mozinfo == 0.9 14:03:04 INFO - mozleak == 0.1 14:03:04 INFO - mozlog == 3.4 14:03:04 INFO - moznetwork == 0.27 14:03:04 INFO - mozprocess == 0.25 14:03:04 INFO - mozprofile == 0.28 14:03:04 INFO - mozrunner == 6.13 14:03:04 INFO - mozscreenshot == 0.1 14:03:04 INFO - mozsystemmonitor == 0.3 14:03:04 INFO - moztest == 0.8 14:03:04 INFO - mozversion == 1.4 14:03:04 INFO - psutil == 3.1.1 14:03:04 INFO - requests == 1.2.3 14:03:04 INFO - wsgiref == 0.1.2 14:03:04 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:03:04 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')]} 14:03:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:03:04 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')]} 14:03:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:03:04 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 0x1e153b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fefa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2192ef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x218fe40>, '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 0x2190fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2191440>, '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': '7de08804244eb36560b44971000001c3-1496171457.632463-630333248', '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 14:03:04 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 14:03:04 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 14:03:04 INFO - Using env: {'DISPLAY': ':0', 14:03:04 INFO - 'HOME': '/home/cltbld', 14:03:04 INFO - 'LANG': 'en_US.UTF-8', 14:03:04 INFO - 'LANGUAGE': 'en_US:en', 14:03:04 INFO - 'LOGNAME': 'cltbld', 14:03:04 INFO - 'MAIL': '/var/mail/cltbld', 14:03:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:03:04 INFO - 'MOZ_NO_REMOTE': '1', 14:03:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:03:04 INFO - 'NO_EM_RESTART': '1', 14:03:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:03:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:03:04 INFO - 'PWD': '/builds/slave/test', 14:03:04 INFO - 'SHELL': '/bin/bash', 14:03:04 INFO - 'SHLVL': '1', 14:03:04 INFO - 'TERM': 'linux', 14:03:04 INFO - 'TMOUT': '86400', 14:03:04 INFO - 'USER': 'cltbld', 14:03:04 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1496171457.632463-630333248', 14:03:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:03:04 INFO - '_': '/tools/buildbot/bin/python'} 14:03:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:03:04 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)) 14:03:04 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)) 14:03:04 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)) 14:03:04 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)) 14:03:04 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)) 14:03:04 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)) 14:03:04 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)) 14:03:04 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)) 14:03:04 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)) 14:03:04 INFO - Downloading/unpacking marionette-driver>=1.4.0 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 14:03:04 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 14:03:04 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 14:03:04 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 14:03:04 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 14:03:05 INFO - Downloading marionette_driver-1.4.0.tar.gz 14:03:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/marionette-driver/setup.py) egg_info for package marionette-driver 14:03:05 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)) 14:03:05 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)) 14:03:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner>=6.9 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from marionette-driver>=1.4.0->-r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 14:03:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice>=0.37 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozrunner>=6.9->marionette-driver>=1.4.0->-r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 14:03:05 INFO - Installing collected packages: marionette-driver 14:03:05 INFO - Running setup.py install for marionette-driver 14:03:05 INFO - Successfully installed marionette-driver 14:03:05 INFO - Cleaning up... 14:03:05 INFO - Return code: 0 14:03:05 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 14:03:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:03:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:03:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:03:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:03:05 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e153b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fefa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2192ef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x218fe40>, '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 0x2190fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2191440>, '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': '7de08804244eb36560b44971000001c3-1496171457.632463-630333248', '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 14:03:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 14:03:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 14:03:05 INFO - Using env: {'DISPLAY': ':0', 14:03:05 INFO - 'HOME': '/home/cltbld', 14:03:05 INFO - 'LANG': 'en_US.UTF-8', 14:03:05 INFO - 'LANGUAGE': 'en_US:en', 14:03:05 INFO - 'LOGNAME': 'cltbld', 14:03:05 INFO - 'MAIL': '/var/mail/cltbld', 14:03:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:03:05 INFO - 'MOZ_NO_REMOTE': '1', 14:03:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:03:05 INFO - 'NO_EM_RESTART': '1', 14:03:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:03:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:03:05 INFO - 'PWD': '/builds/slave/test', 14:03:05 INFO - 'SHELL': '/bin/bash', 14:03:05 INFO - 'SHLVL': '1', 14:03:05 INFO - 'TERM': 'linux', 14:03:05 INFO - 'TMOUT': '86400', 14:03:05 INFO - 'USER': 'cltbld', 14:03:05 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1496171457.632463-630333248', 14:03:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:03:05 INFO - '_': '/tools/buildbot/bin/python'} 14:03:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:03:05 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 14:03:05 INFO - Cleaning up... 14:03:05 INFO - Return code: 0 14:03:05 INFO - Running post-action listener: _resource_record_post_action 14:03:05 INFO - Running post-action listener: _start_resource_monitoring 14:03:05 INFO - Starting resource monitoring. 14:03:05 INFO - [mozharness: 2017-05-30 21:03:05.822033Z] Finished create-virtualenv step (success) 14:03:05 INFO - [mozharness: 2017-05-30 21:03:05.822544Z] Running install step. 14:03:05 INFO - Running pre-action listener: _resource_record_pre_action 14:03:05 INFO - Running main action method: install 14:03:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:03:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:03:06 INFO - Reading from file tmpfile_stdout 14:03:06 INFO - Detecting whether we're running mozinstall >=1.0... 14:03:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 14:03:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 14:03:06 INFO - Reading from file tmpfile_stdout 14:03:06 INFO - Output received: 14:03:06 INFO - Usage: mozinstall [options] installer 14:03:06 INFO - Options: 14:03:06 INFO - -h, --help show this help message and exit 14:03:06 INFO - -d DEST, --destination=DEST 14:03:06 INFO - Directory to install application into. [default: 14:03:06 INFO - "/builds/slave/test"] 14:03:06 INFO - --app=APP Application being installed. [default: firefox] 14:03:06 INFO - mkdir: /builds/slave/test/build/application 14:03:06 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'] 14:03:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 14:03:22 INFO - Reading from file tmpfile_stdout 14:03:22 INFO - Output received: 14:03:22 INFO - /builds/slave/test/build/application/firefox/firefox 14:03:22 INFO - Running post-action listener: _resource_record_post_action 14:03:22 INFO - [mozharness: 2017-05-30 21:03:22.196348Z] Finished install step (success) 14:03:22 INFO - [mozharness: 2017-05-30 21:03:22.196629Z] Running setup-mitmproxy step. 14:03:22 INFO - Running pre-action listener: _resource_record_pre_action 14:03:22 INFO - Running main action method: setup_mitmproxy 14:03:22 INFO - Skipping: mitmproxy is not required 14:03:22 INFO - Running post-action listener: _resource_record_post_action 14:03:22 INFO - [mozharness: 2017-05-30 21:03:22.197773Z] Finished setup-mitmproxy step (success) 14:03:22 INFO - [mozharness: 2017-05-30 21:03:22.197996Z] Running run-tests step. 14:03:22 INFO - Running pre-action listener: _resource_record_pre_action 14:03:22 INFO - Running main action method: run_tests 14:03:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 14:03:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 14:03:22 INFO - Python 2.7.3 14:03:22 INFO - Return code: 0 14:03:22 INFO - grabbing minidump binary from tooltool 14:03:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:03:22 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 0x218fe40>, '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 0x2190fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2191440>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 14:03:22 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 14:03:22 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 14:03:22 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 14:03:22 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 14:03:22 INFO - Return code: 0 14:03:22 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 14:03:22 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 14:03:22 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 14:03:22 INFO - ENV: RUST_BACKTRACE is now 1 14:03:22 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 14:03:22 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 14:03:22 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/QcHb3q6rSq-29FSDzJWOeg/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-003', '--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 14:03:22 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/QcHb3q6rSq-29FSDzJWOeg/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-003 --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 14:03:22 INFO - Using env: {'DISPLAY': ':0', 14:03:22 INFO - 'HOME': '/home/cltbld', 14:03:22 INFO - 'LANG': 'en_US.UTF-8', 14:03:22 INFO - 'LANGUAGE': 'en_US:en', 14:03:22 INFO - 'LOGNAME': 'cltbld', 14:03:22 INFO - 'MAIL': '/var/mail/cltbld', 14:03:22 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 14:03:22 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 14:03:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:03:22 INFO - 'MOZ_NO_REMOTE': '1', 14:03:22 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 14:03:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:03:22 INFO - 'NO_EM_RESTART': '1', 14:03:22 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:03:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:03:22 INFO - 'PWD': '/builds/slave/test', 14:03:22 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 14:03:22 INFO - 'RUST_BACKTRACE': '1', 14:03:22 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 14:03:22 INFO - 'SHELL': '/bin/bash', 14:03:22 INFO - 'SHLVL': '1', 14:03:22 INFO - 'TERM': 'linux', 14:03:22 INFO - 'TMOUT': '86400', 14:03:22 INFO - 'USER': 'cltbld', 14:03:22 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1496171457.632463-630333248', 14:03:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:03:22 INFO - '_': '/tools/buildbot/bin/python'} 14:03:22 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/QcHb3q6rSq-29FSDzJWOeg/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-003', '--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 14:03:22 INFO - mozversion application_buildid: 20170530200850 14:03:22 INFO - mozversion application_changeset: 692e277e2b9f3bb36d6d67e1166d135228f2d851 14:03:22 INFO - mozversion application_display_name: Nightly 14:03:22 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 14:03:22 INFO - mozversion application_name: Firefox 14:03:22 INFO - mozversion application_remotingname: firefox 14:03:22 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 14:03:22 INFO - mozversion application_vendor: Mozilla 14:03:22 INFO - mozversion application_version: 55.0a1 14:03:22 INFO - mozversion platform_buildid: 20170530200850 14:03:22 INFO - mozversion platform_changeset: 692e277e2b9f3bb36d6d67e1166d135228f2d851 14:03:22 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 14:03:22 INFO - mozversion platform_version: 55.0a1 14:03:22 INFO - using testdate: 1496178202 14:03:22 INFO - actual date: 1496178202 14:03:22 INFO - starting webserver on 'localhost:41831' 14:03:22 INFO - SUITE-START | Running 2 tests 14:03:22 INFO - TEST-START | dromaeo_css 14:03:22 INFO - operating with platform_type : linux_ 14:03:22 INFO - Initialising browser for dromaeo_css test... 14:03:22 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:41831/getInfo.html -profile /tmp/tmpxnHp0Z/profile 14:03:22 INFO - TEST-INFO | started process 3779 (/builds/slave/test/build/application/firefox/firefox http://localhost:41831/getInfo.html) 14:03:58 INFO - TEST-INFO | 3779: killed by SIGTERM 14:03:58 INFO - Browser initialized. 14:03:58 INFO - Running cycle 1/1 for dromaeo_css test... 14:03:58 INFO - TEST-INFO | started process 4001 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpxnHp0Z/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:04:10 INFO - PID 4001 | RSS: Main: 186617856 14:04:10 INFO - PID 4001 | 14:07:15 INFO - PID 4001 | Cycle 1(1): loaded http://localhost:41831/tests/dromaeo/cssquery-dojo.html (next: http://localhost:41831/tests/dromaeo/cssquery-ext.html) 14:07:17 INFO - PID 4001 | RSS: Main: 181272576 14:07:17 INFO - PID 4001 | 14:10:19 INFO - PID 4001 | Cycle 1(1): loaded http://localhost:41831/tests/dromaeo/cssquery-ext.html (next: http://localhost:41831/tests/dromaeo/cssquery-jquery.html) 14:10:19 INFO - PID 4001 | RSS: Main: 187486208 14:10:19 INFO - PID 4001 | 14:13:21 INFO - PID 4001 | Cycle 1(1): loaded http://localhost:41831/tests/dromaeo/cssquery-jquery.html (next: http://localhost:41831/tests/dromaeo/cssquery-mootools.html) 14:13:22 INFO - PID 4001 | RSS: Main: 183590912 14:13:22 INFO - PID 4001 | 14:16:24 INFO - PID 4001 | Cycle 1(1): loaded http://localhost:41831/tests/dromaeo/cssquery-mootools.html (next: http://localhost:41831/tests/dromaeo/cssquery-prototype.html) 14:16:24 INFO - PID 4001 | RSS: Main: 187977728 14:16:24 INFO - PID 4001 | 14:19:27 INFO - PID 4001 | Cycle 1(1): loaded http://localhost:41831/tests/dromaeo/cssquery-prototype.html (next: http://localhost:41831/tests/dromaeo/cssquery-yui.html) 14:19:28 INFO - PID 4001 | RSS: Main: 186847232 14:19:28 INFO - PID 4001 | 14:22:30 INFO - PID 4001 | Cycle 1(1): loaded http://localhost:41831/tests/dromaeo/cssquery-yui.html (next: http://localhost:41831/tests/dromaeo/cssquery-dojo.html) 14:22:30 INFO - PID 4001 | RSS: Main: 184864768 14:22:30 INFO - PID 4001 | 14:22:30 INFO - PID 4001 | __start_tp_report 14:22:30 INFO - PID 4001 | _x_x_mozilla_page_load 14:22:30 INFO - PID 4001 | _x_x_mozilla_page_load_details 14:22:30 INFO - PID 4001 | |i|pagename|runs| 14:22:30 INFO - PID 4001 | |0;dojo.html;2765.5160346939288;2770.044334704526;2785.5821626755983;2808.64891888514;2820.6615206175247;5138.743062846861;5296.973515132424;5299.178627312768;5306.230596563496;5328.813491527797;5135.666181698187;5198.662086964354;5288.497592728694;5316.9734151329185;5321.946780532194;4692.882677933045;4707.011527579212;4738.786754596043;4743;4775.90448191036;4710.505396933324;4723.811047558093;4781.665283430161;4785.21044027735;4849.46655867856;4583.931241031387;4635.327877457784;4719.244920812688;4728.550787675165;4787.80848766049;4632.050429661911;4654.0924519718665;4689.953100468986;4690.64820138491;4709.458412282597;4679.532046795327;4685.1800934836265;4686.7656617169005;4690.132325519789;4713.387259656257;5198.792048318062;5249.947500525022;5255.421903590602;5260.368755749297;5286.762095705702;5547.1679248112705;5605;5624.775008999635;5685.090385538294;5700.97382471155;5741.598088133832;5745.482906538432;5758.078707406795;5780.739866706008;5796.391378905197;5319.547838433777;5325.547328477122;5331.413544510101;5341.412444631087;5348.064088784447;5738.483536481736;5811.680357580289;5858.98262394867;5884.0585506318785;5893.2044174035955;5573.164025396142;5583.664980101125;5587.776488940397;5597.720113994365;5608.9439105609235;5587.804426845122;5635.6618602883955;5645.350784659735;5649.576281778883;5717.113847353667;5518.503334699816;5616.045272303718;5620.578456615688;5626.887462250814;5639.915401268902;5521.558275337963;5596;5616.213730077792;5653;5732.168835518826;4703.529647035269;4704.012157446906;4712.52874712526;4735.431748190239;4749.810007599726;4053.5338436079637;4063.7358571692744;4069.593040695966;4118.897027574335;4121.196366708463;4687.062587482449;4763.04739052191;4778.689385189951;4807.975960120177;4840.878978025577;5728.570357223141;5746.511546518509;5759.769609215585;5780.855478613068;5812.476877081083;4761.381020467317;4778.1399348117675;4793.784279707422;4797.055312375661;4821.300911367832;4870.829520966749;5010.549050585465;5012.3483947085915;5012.523810238022;5013.849584512471;5167.819126330561;5284.762185701576;5339.599530035185;5363.980843639696;5365.839024829262;5497.47773961473;5768.077107662922;5768.50967667753;5779.739911703899;5818.563607729522;5260.631755777059;5283.709395983258;5364.329458817648;5364.356277246756;5373.838784836461;5558.91661625084;5670.347909990404;5677.148427735872;5680.7443665036;5726.828195154152;5542.0301447245765;5616.297962754656;5635.0702134147405;5784.913226301524;5800.59395842287;5518.310211223597;5536.806211782568;5553.389127196086;5584.134459158837;5605.887882242414;5545.584081194007;5575.7490912909825;5580.246666700106;5598.10430331145;5613.607047506799;5432.782688692408;5474.39781624029;5480.725963701879;5481.095619222783;5487.396386397573;5424.403315635356;5515.558755299647;5516.200150978166;5612.943870561406;5626.63426877268;5371.973140134274;5378.220158077135;5398.379186393615;5418.539424148991;5431.37539182999 14:22:30 INFO - PID 4001 | |1;ext.html;600.6546235914348;663.2604645819911;680.0886811672358;1041.6614600254918;1067.3222503710142;29969.400611987774;30706.23234419138;30732.385352292997;30747.69252307479;30861;30197.698023019762;30798.23004424885;30820.38359232814;30830.38339233214;30894.69105308952;6551.1483507144;6670.299618540056;6671.166104236971;6671.166104236971;6675.299093595176;6371.904421433682;6503.642299673516;6532.902006469883;6533.020046992941;6538.640374779386;6540.313267106957;6556.770513032045;6570.408663220309;6570.63861487618;6578.1448411706415;6498.317676643956;6523.412892839668;6529.869402611945;6534.575252608565;6549.1158693576235;6517.315681853384;6580.144581204413;6581.638009909453;6583.407493325576;6585.078089067534;28640.570391444144;28780.568291475643;28854.71145288541;29025.85487072551;29035.12894613165;2691.8923243070253;2704.797140214472;2720.5239083160563;2720.795940304465;2729.235813972091;22621.660675089886;22715.31854044381;22745.658815117786;22756.77243227563;22772.31683049511;2949.5723120147672;2960.896368627109;2962.6000489934013;2968.83671398073;3010.5785190073407;147255;147356;147619.26190369087;154659.99999999886;154906;34974.650253497646;35012.29975400529;35125.64874351224;35183.4722479163;35248;36168.81915590458;36203.09492262662;36280.45579316312;36294.27411451809;37544;10228.284020118668;10290.588376465008;10307.969203079781;10312.896871031344;10341.224408169266;8134.308583770446;8140;8152.918470815334;8160.265576098061;8169.142240064826;11159.553617855196;11164.720881977853;11171.106311495061;11234.438278086227;11384.943075284737;4730.95269047312;4732.242841145469;4734.952650473451;4735.337052812609;4811.4707382187935;789.719649524422;812.1594150054665;814.7148498025643;822.4489591973393;825.005867929144;18956.241750330108;19284.1322140504;19471.902640486707;19518.609627807364;19773.802261977486;863.8315528472014;891.3715830339595;894.5437826708426;894.695803426825;898.5058217980085;9860.654877079267;10191;10343.327683700536;10352.482375881176;10362.274640775073;174770;174849;174948;175266;175436;35482.29035419277;35656.28687426237;35707.64292357095;35776.82111589425;35909.922702318974;1040.38617215843;1072.083368719749;1074.6507385099874;1079.050435616668;1091.2743025887696;18411.066837982355;18820.24719011279;19320.8067919319;19323.51691207675;19616.607667846278;27155.592666109627;27155.86422067877;27177.59233611458;27214.047508337113;27253.45493090167;147859;148067;148163.2591837077;148189;148597;26806;26996.73003270021;27185;27210.31974200661;28288.43423131567;33374.165645859044;33601.15997100092;33696.83151584226;33710.325793483506;33741;24533.754662453146;25380.11169609055;25656.486870262863;25938;26282.211533654023;25004.49991000206;25023.624645630694;25132.371690707878;25773.613395799453;26799;28845.423091538472;28890.711092888803;28911.277218068873;28924.710752892202;28947.85526072356;25059.248222553353;25770.09804656828;30058.69941300559;30261;30462.23844403819;22913.541729165656;24759.381015474035;25650.871745641154;25783.871080644476;25791.355216119748 14:22:30 INFO - PID 4001 | |2;jquery.html;397.34041491124736;398.3844959537514;408.06756561257515;412.19210347718473;414.33706070287536;11988.220765650227;12829.294388808612;16356.345746170155;16999.23503442345;17017.06406147663;15847.683046339067;16480.83519164808;16527.173641317917;16556.50330490084;16591.087490188034;5334.119870221419;5455.290812194409;5477.123660214366;5477.835664930059;5500.477454641803;5368.409474957752;5422.9728851355685;5423.945760542403;5439.972800135994;5446.782128714866;5357.196420536911;5390.272313237721;5402.540784033362;5438.945610543903;5443.782248710067;4946.579540739023;5132;5161.999999999963;5430.511253987141;5435.592330575223;4649.651276154268;4691.15559199344;4694.084653492536;4696.8590942271785;4698.741569213692;20513.282035128697;20676.48308792277;20794.896025519774;20821.37535873926;20835;1599.3282821215118;1627.6500552381294;1629.030726717601;1644.6957312897152;1647.1270226779825;13527.120737152054;13914;14117.082389644744;14160.858391416057;14183.290835458185;2063.7420322459693;2065.514604068043;2119.607872543569;2120.533482633818;2138.6791981202787;101405.31028311231;103767.48116259446;103929;104033;104600;10077.344972576759;10377.273590848568;10529.157667386591;10558.841617375745;10576.41829699374;14805.18571478579;14812.481563145238;14835.629109272139;14849;14851.183184924932;6548.148740663779;6863.553868998599;6871.896921546181;6881.552699074544;6999.720011199597;6220.253569571681;6228.626282423069;6263.091851681481;6305.211848518935;6332.081848131995;6591.901121483182;6670.699818508178;6710.664466776641;6753.189617245962;6843.8973415398805;1863.8415734662435;1918.539550507896;1945.3288615427655;2017.818396344336;2054.784247653975;757.2730179028194;782.8629989751771;785.4815821557744;792.6789650191681;802.9759107226793;15752.291146898417;15793.763093553605;16061.518154455385;16106.838931610768;16358.182090895407;774.9651265693058;783.0564170174925;788.3574886467511;788.8540619985321;815.339574944297;8752.387332886638;8772.473651580925;8946.86579701305;8972.641094356282;9229.584668689926;337376;341379;343393;348565;357626;78992;80320;80939.59530202311;81757.59121204475;82311.5884420574;889.857622780365;913.5112714697605;926.6988228825523;927.939683920543;930.5626355612851;14069.437222511395;14117.717645647235;16142.273597687898;16202.270897809864;17751.289948401918;44896.55103448924;45110.32334514919;47000;47104.7644761774;47381.05237895292;50979.2353114711;51536.48463515317;51544.48455515397;51764.74117629388;51992.220116699034;8798.868016979879;8809.075047120217;8867;8910.153535414125;8929.553522323728;13324.533641322507;14212.715745685235;14331.498397556035;14394.784078238625;14415.855841441871;12279.324637144686;12364.1963272387;12445.62663120108;12454.065945054339;12480.875191247971;11555;11667.416629168678;11669.35818529989;11742.941285293518;11863.34751588671;12432.751344972869;12602.243865368107;12710.300933448749;12776.169548979287;12822.294773787158;8676.089010654043;8808.075152108937;8899.777505562413;8918.286537077149;8987.820243595223;12006.339651318913;12046.397680115784;12090.395480226129;12116.333601651993;12137.332446715516 14:22:30 INFO - PID 4001 | |3;mootools.html;1077.5582011375336;1108.130117857482;1116.475256629384;1132.0434233073056;1136.8749437561867;9909.207263418928;10385.169186465084;10390.16878649708;10590.09984151348;10983.61557345493;10686.839697404526;10781.946090269557;10835.6749297521;10964.671059868197;10971.396573188471;2081.5524662197627;2108.1988844239168;2120.4592828828704;2126.6384714598557;2129.1057755742627;2045.6145079892726;2070.1615845582487;2071.7721050684413;2079.8232150267245;2081.0843228979274;2017.213286818142;2039.88780617066;2042.6221149087467;2044.1925439451409;2045.6624656931588;2000.9099590518463;2003.5091402606308;2015.5666531695683;2022.9190832366687;2026.3313106674761;1911.054028256022;2000.4998750312423;2073.1810934680716;2075.5122546201633;2082.9479263018393;10387.532561034772;10474.528646210938;10474.79050418995;10497.687789026371;10507;5353.2237825515085;5558.471945165203;5568;5592.384837667853;5595.356533998602;3256.2185075581688;3329.6004479462376;3355.6979871811654;3377.290768938526;3399.55805745254;1089.580511503077;1096.8299913513338;1107.6787731557838;1128.2553514680353;1135.7444574970648;14127.15237085778;14419.476591596533;16219.189040548043;16483.58791030222;16559.25483353252;4532.9546704533195;4743.501932297059;4758.833440829554;4759.452662943806;4782.9760851196215;10739.731506712395;10752.892471075189;10762.515686794113;10765.407902565434;10803.891961080446;4875.34182885313;5274.498922602346;5274.630775845654;5303.416624171338;5319.414864364917;4851.757412129379;4859.1496488114435;4862.3922009748785;4892.706437613754;4900.215965445512;3762.8163762816584;3900.1029763154065;3912.374020156761;3935.2129574085297;3940.7438516496336;1114.3091283404178;1118.183725880112;1143.1769126229267;1144.1476100305326;1148.3397046698183;586.6245602814203;600.6966481926686;606.1211243696657;607.3349682098095;608.6986941464004;4760.690555113906;4841.782119804618;4855.490173531728;4911.336969509142;4997.075541024922;516.3081470829108;520.0976306108898;520.3495630461923;749.6214411722045;795.1372760554863;3247.204434913414;3350.447176215946;3413.7098346640814;3461.238527523941;3462.2036931505895;13935.303234838217;14040.297985100704;14515;14521.564353069425;14530.927345363205;14005;14253.216073115871;14330.21183834899;14331.498397556035;14507.274636268145;7078.999999999897;7254.165770936304;7363.595002274927;7381.224971378036;7434.628268586657;5311.893762124813;5418.674879507084;5422.566194704335;5560.7219639018695;5834.241548598655;12200.51197952072;12417.503299867903;12797.488100476248;12999.545015924397;13216.339183041002;12882.162659427107;12936.547220847602;12941.741165176456;13032.218066915637;13116.819486246284;8283.130271321425;8519.23326900582;8589.312854971713;8602.655893764178;8607.698730544402;9502.524873756423;9543.614096475882;9625.470599117116;9636.566354514203;9644.710658680251;7893.605319734105;7920.207979202034;8116.83766324682;8154.266116049584;8300.294474969694;7666.310032097138;7717.723271634769;7730.845383092419;7919.960400197962;7988.081370642451;6954.513184077066;6976.407005404598;6993.510454268152;7020.719171233093;7026.051483049723;4785.090832741768;4814.181589129927;4844.709317440965;4862.781174847211;4894.877628059327;4905.509449055208;4954.628402869871;4976.950230497649;4986.276989836526;5044.369453818273 14:22:30 INFO - PID 4001 | |4;prototype.html;353.4909729988816;361.7883538130194;367.23431645020133;375.56059410489723;380.68022860796924;5544.279243698318;5564.1931919871595;5597.160425936112;5602.915956260659;5610.663360198391;5224.921626175601;5450.182472629108;5475.206095116206;5484.725763711808;5490.6431081979745;4114.855980040692;4115.218108559379;4142.8400047986615;4148.149629325981;4148.585141485857;4127.752334859903;4130.690198235145;4139.317012692902;4139.689523285766;4165.541790403053;4073.5111786585503;4116.567760385161;4116.608922152391;4123.876283711494;4128.071183983609;4112.8149233284275;4118.517333759844;4118.588141185887;4142.834286628561;4143.316352801784;3610.638936106395;3615.1865830188262;3620.456931460276;3620.963790362089;3626.909327266813;5382.255049924566;5396.83809485716;5401.4868587484125;5404.270423492818;5420.457954204588;4888.242322440027;4892.067633284868;4896.922677011052;4903.362562866841;4907.607391408679;5823.912641310384;5835.941640583582;5838.781263119988;5846.21076154718;5848.152017957373;4051.7163798534116;4058.3506638937924;4071.2875246831686;4072.450219220397;4082.142750022499;5807.245058142456;6167.87664246717;6215.923118056546;6228.190335256388;6231.813045608639;4121.608447197512;4126.360414135754;4133.886782651221;4160.167966406731;4167.9583204168175;4201.445465177903;4204.348326009474;4213.47331583552;4214.030772922245;4215.789210539522;4663.790129444184;4794.137055330004;4845.297431872429;4849.515048495122;4849.660523763373;5789.392113828072;5801.042827933428;5808.709564521757;5826.766929322865;5849.473547380671;1445.4579532675248;1452.9273536323353;1462.612407711957;1465.9267036648125;1466.5160497035952;956.6269155029544;976.1605019683067;991.1525645573075;994.2493417469764;999.6701088640731;5012.172991456442;5046.520580544842;5047.87380315495;5048.5203905628905;5050.3434553507805;6011.338752737195;6016.458518733335;6044.788432404845;6050.6672133032225;6059.484943779828;4983.9252411213865;4993.201087825931;4994.07846409847;5010.949890501121;5029.899402011939;3166.5725127108008;3193.297474555594;3202.8558714857886;3215.6302025266928;3222.2749881276527;5579.38626751057;5620.381758006616;5623.493885550321;5624.21261023457;5647.842192350558;6132.908006379907;6145.170401995762;6162.506999440034;6169.876602468015;6213.867777927718;5597;5605.5515558755205;5606.159076138611;5615.410381909923;5620.943790562205;6034.668093254738;6037.516998640186;6061.636301821904;6062.818115456544;6069.696515174312;5944.791932282349;5955.166276721176;5965.612235204698;5967.940320596912;5980.401959804159;5290.064014472005;5559.444055594408;5569.35952365467;5599.664020158803;5623.409541998195;4138.751674899516;4151.56408577095;4172.457580514514;4172.979135104305;4187.66498680111;6037.158666606727;6062.060380641008;6071.787487437919;6090.969545152423;6104.603200791934;5636.605437619492;5837.241158649348;5838.095095260242;5845.240118784531;5848.883022339614;5828.59199856006;5841.678707671119;5856;5856.531477481706;5869.383714709894;5744.770209191753;5745.109508026263;5753.8561535961935;5756.251687280626;5804.448577385142;5911.1428842816695;5940.108983652487;5951.375105614022;5953.3153687324775;5967.701614919323;5710.5717071219;5732.566858285429;5734.254546908875;5735.394089654903;5758.366579676149 14:22:30 INFO - PID 4001 | |5;yui.html;620.0420350558387;628.2429672244946;628.4501061571125;629.9559030867838;632.0203684289356;11998.460069296882;12178.208416452935;12472.937635311822;14951.252437378142;15915.44295949642;14229.78655320171;14382.208978506178;14388.424463021493;14425.63935901603;14441.855581444182;840.8738689196623;843.1694780641063;844.4342290665269;847.9364047696416;849.2102344819316;637.3148864970152;659.6503852957916;667.8096742428409;859.2481578618708;866.1857853617611;690.1028662738445;694.78114393966;699.3530983839928;699.5837476701355;700.5096432497247;687.8074139240971;688.5421194905407;691.1602403080257;699.0004293859779;706.8338940349065;504.3393154967005;508.0372693745332;508.3087001677715;509.71455984648713;514.5806167973127;12215.75568488634;12258.325792081432;12355.567555135616;12376.381180940916;12384.071194660346;14441.638959026004;14856.257187140707;15282.770758438632;15397.769033464507;15411.30649120781;12083.818742718866;12092.455839487244;12294.385280736016;12302.07734419922;12450.81323780144;2896.6958469360834;2904.346522032547;2933.0760810344673;2939.5884576159356;2940.1326608650497;73403.63298183474;73927;74410.62794685992;75045.62477187633;76019;11422.14333924959;11624;11692.415379231004;11899.643010709693;12049.096317776202;18400.53998650018;19195.136218870186;19251.51871203231;19441.222351105796;20230.797692023185;5992.250968628921;6160.10678451622;6171.043488259327;6173.8456538586;6185.010398336244;2805.9859700701772;2929.1798296477023;2997.535382015791;3004.2939909121337;3009.6087508623737;3308.8180150091976;3417.3677869594203;3429.639887811794;3431.7940923544666;3441.552598162273;713.4613366907952;717.7882524655239;717.806192328079;719.910011248594;720.6865013719049;537.1110811606796;548.8271194573697;551.2613098448098;551.737924485874;552.5248286473629;9356.95321523388;10339.327943683787;10627.256092073636;10658.413787241776;10701.83947240792;563.5435297409111;573.2261447046454;574.5920396518435;584.5002522842908;591.5267785771366;4467.930101893162;4707;4717.481077081518;4821.228603423436;4887.511248875155;86022;86920;88235;88529;90966;66179.69831960907;74153.6292318535;74177;74555;74590.62704686442;58734.41265587375;59779.402205977385;60570.91436284505;61139;63767.68116159389;9643.469609171563;9712.805743884941;9860.704178874645;9934.602615895572;10035;27311.59032614552;28013;28087.438251234453;28248.71751282461;28281.858590706914;34833.65166348304;35074.123146921534;35238.47142292817;35549;36029.45955810612;12494.562690305796;13097.279649619362;14075.085119467201;14080.718385632024;14196;14537.273136342928;15325.386984520494;15437.305321260796;15549.84450155484;15573.766393504333;14259.358328875433;14326.140431574138;14595.051321664057;14708.043977141879;15020.399184032516;14027.36876840565;14569.41722331095;14619.85380146185;14659.633509162357;14742.852571474577;14003.789943150658;14498.34757435939;14711.264436777905;14772.63068423298;14847.703045938804;9626.614935402506;9642.325037247325;9968.053034961667;10014.849777253201;10284.2801003929;10360.948195258976;10939.890601093886;10980.560777568808;11726.237794543327;12317.260964342167 14:22:30 INFO - PID 4001 | __end_tp_report 14:22:30 INFO - PID 4001 | __start_cc_report 14:22:30 INFO - PID 4001 | _x_x_mozilla_cycle_collect,372 14:22:30 INFO - PID 4001 | __end_cc_report 14:22:30 INFO - PID 4001 | __startTimestamp1496179350436__endTimestamp 14:22:30 INFO - PID 4001 | 14:22:30 INFO - PID 4001 | ------- Summary: start ------- 14:22:30 INFO - PID 4001 | Number of tests: 6 14:22:30 INFO - PID 4001 | 14:22:30 INFO - PID 4001 | [#0] dojo.html Cycles:165 Average:5197.94 Median:5364.36 stddev:608.98 (11.4%) stddev-sans-first:580.18 14:22:30 INFO - PID 4001 | Values: 2765.5 2770.0 2785.6 2808.6 2820.7 5138.7 5297.0 5299.2 5306.2 5328.8 5135.7 5198.7 5288.5 5317.0 5321.9 4692.9 4707.0 4738.8 4743.0 4775.9 4710.5 4723.8 4781.7 4785.2 4849.5 4583.9 4635.3 4719.2 4728.6 4787.8 4632.1 4654.1 4690.0 4690.6 4709.5 4679.5 4685.2 4686.8 4690.1 4713.4 5198.8 5249.9 5255.4 5260.4 5286.8 5547.2 5605.0 5624.8 5685.1 5701.0 5741.6 5745.5 5758.1 5780.7 5796.4 5319.5 5325.5 5331.4 5341.4 5348.1 5738.5 5811.7 5859.0 5884.1 5893.2 5573.2 5583.7 5587.8 5597.7 5608.9 5587.8 5635.7 5645.4 5649.6 5717.1 5518.5 5616.0 5620.6 5626.9 5639.9 5521.6 5596.0 5616.2 5653.0 5732.2 4703.5 4704.0 4712.5 4735.4 4749.8 4053.5 4063.7 4069.6 4118.9 4121.2 4687.1 4763.0 4778.7 4808.0 4840.9 5728.6 5746.5 5759.8 5780.9 5812.5 4761.4 4778.1 4793.8 4797.1 4821.3 4870.8 5010.5 5012.3 5012.5 5013.8 5167.8 5284.8 5339.6 5364.0 5365.8 5497.5 5768.1 5768.5 5779.7 5818.6 5260.6 5283.7 5364.3 5364.4 5373.8 5558.9 5670.3 5677.1 5680.7 5726.8 5542.0 5616.3 5635.1 5784.9 5800.6 5518.3 5536.8 5553.4 5584.1 5605.9 5545.6 5575.7 5580.2 5598.1 5613.6 5432.8 5474.4 5480.7 5481.1 5487.4 5424.4 5515.6 5516.2 5612.9 5626.6 5372.0 5378.2 5398.4 5418.5 5431.4 14:22:30 INFO - PID 4001 | 14:22:30 INFO - PID 4001 | [#1] ext.html Cycles:180 Average:28901.08 Median:28986.86 stddev:40874.71 (141.0%) stddev-sans-first:40934.14 14:22:30 INFO - PID 4001 | Values: 600.7 663.3 680.1 1041.7 1067.3 29969.4 30706.2 30732.4 30747.7 30861.0 30197.7 30798.2 30820.4 30830.4 30894.7 6551.1 6670.3 6671.2 6671.2 6675.3 6371.9 6503.6 6532.9 6533.0 6538.6 6540.3 6556.8 6570.4 6570.6 6578.1 6498.3 6523.4 6529.9 6534.6 6549.1 6517.3 6580.1 6581.6 6583.4 6585.1 28640.6 28780.6 28854.7 29025.9 29035.1 2691.9 2704.8 2720.5 2720.8 2729.2 22621.7 22715.3 22745.7 22756.8 22772.3 2949.6 2960.9 2962.6 2968.8 3010.6 147255.0 147356.0 147619.3 154660.0 154906.0 34974.7 35012.3 35125.6 35183.5 35248.0 36168.8 36203.1 36280.5 36294.3 37544.0 10228.3 10290.6 10308.0 10312.9 10341.2 8134.3 8140.0 8152.9 8160.3 8169.1 11159.6 11164.7 11171.1 11234.4 11384.9 4731.0 4732.2 4735.0 4735.3 4811.5 789.7 812.2 814.7 822.4 825.0 18956.2 19284.1 19471.9 19518.6 19773.8 863.8 891.4 894.5 894.7 898.5 9860.7 10191.0 10343.3 10352.5 10362.3 174770.0 174849.0 174948.0 175266.0 175436.0 35482.3 35656.3 35707.6 35776.8 35909.9 1040.4 1072.1 1074.7 1079.1 1091.3 18411.1 18820.2 19320.8 19323.5 19616.6 27155.6 27155.9 27177.6 27214.0 27253.5 147859.0 148067.0 148163.3 148189.0 148597.0 26806.0 26996.7 27185.0 27210.3 28288.4 33374.2 33601.2 33696.8 33710.3 33741.0 24533.8 25380.1 25656.5 25938.0 26282.2 25004.5 25023.6 25132.4 25773.6 26799.0 28845.4 28890.7 28911.3 28924.7 28947.9 25059.2 25770.1 30058.7 30261.0 30462.2 22913.5 24759.4 25650.9 25783.9 25791.4 14:22:30 INFO - PID 4001 | 14:22:30 INFO - PID 4001 | [#2] jquery.html Cycles:180 Average:24867.99 Median:397.86 stddev:58522.88 (14709.3%) stddev-sans-first:58658.21 14:22:30 INFO - PID 4001 | Values: 397.3 398.4 408.1 412.2 414.3 11988.2 12829.3 16356.3 16999.2 17017.1 15847.7 16480.8 16527.2 16556.5 16591.1 5334.1 5455.3 5477.1 5477.8 5500.5 5368.4 5423.0 5423.9 5440.0 5446.8 5357.2 5390.3 5402.5 5438.9 5443.8 4946.6 5132.0 5162.0 5430.5 5435.6 4649.7 4691.2 4694.1 4696.9 4698.7 20513.3 20676.5 20794.9 20821.4 20835.0 1599.3 1627.7 1629.0 1644.7 1647.1 13527.1 13914.0 14117.1 14160.9 14183.3 2063.7 2065.5 2119.6 2120.5 2138.7 101405.3 103767.5 103929.0 104033.0 104600.0 10077.3 10377.3 10529.2 10558.8 10576.4 14805.2 14812.5 14835.6 14849.0 14851.2 6548.1 6863.6 6871.9 6881.6 6999.7 6220.3 6228.6 6263.1 6305.2 6332.1 6591.9 6670.7 6710.7 6753.2 6843.9 1863.8 1918.5 1945.3 2017.8 2054.8 757.3 782.9 785.5 792.7 803.0 15752.3 15793.8 16061.5 16106.8 16358.2 775.0 783.1 788.4 788.9 815.3 8752.4 8772.5 8946.9 8972.6 9229.6 337376.0 341379.0 343393.0 348565.0 357626.0 78992.0 80320.0 80939.6 81757.6 82311.6 889.9 913.5 926.7 927.9 930.6 14069.4 14117.7 16142.3 16202.3 17751.3 44896.6 45110.3 47000.0 47104.8 47381.1 50979.2 51536.5 51544.5 51764.7 51992.2 8798.9 8809.1 8867.0 8910.2 8929.6 13324.5 14212.7 14331.5 14394.8 14415.9 12279.3 12364.2 12445.6 12454.1 12480.9 11555.0 11667.4 11669.4 11742.9 11863.3 12432.8 12602.2 12710.3 12776.2 12822.3 8676.1 8808.1 8899.8 8918.3 8987.8 12006.3 12046.4 12090.4 12116.3 12137.3 14:22:30 INFO - PID 4001 | 14:22:30 INFO - PID 4001 | [#3] mootools.html Cycles:180 Average:6296.68 Median:3406.63 stddev:4327.94 (127.0%) stddev-sans-first:4322.31 14:22:30 INFO - PID 4001 | Values: 1077.6 1108.1 1116.5 1132.0 1136.9 9909.2 10385.2 10390.2 10590.1 10983.6 10686.8 10781.9 10835.7 10964.7 10971.4 2081.6 2108.2 2120.5 2126.6 2129.1 2045.6 2070.2 2071.8 2079.8 2081.1 2017.2 2039.9 2042.6 2044.2 2045.7 2000.9 2003.5 2015.6 2022.9 2026.3 1911.1 2000.5 2073.2 2075.5 2082.9 10387.5 10474.5 10474.8 10497.7 10507.0 5353.2 5558.5 5568.0 5592.4 5595.4 3256.2 3329.6 3355.7 3377.3 3399.6 1089.6 1096.8 1107.7 1128.3 1135.7 14127.2 14419.5 16219.2 16483.6 16559.3 4533.0 4743.5 4758.8 4759.5 4783.0 10739.7 10752.9 10762.5 10765.4 10803.9 4875.3 5274.5 5274.6 5303.4 5319.4 4851.8 4859.1 4862.4 4892.7 4900.2 3762.8 3900.1 3912.4 3935.2 3940.7 1114.3 1118.2 1143.2 1144.1 1148.3 586.6 600.7 606.1 607.3 608.7 4760.7 4841.8 4855.5 4911.3 4997.1 516.3 520.1 520.3 749.6 795.1 3247.2 3350.4 3413.7 3461.2 3462.2 13935.3 14040.3 14515.0 14521.6 14530.9 14005.0 14253.2 14330.2 14331.5 14507.3 7079.0 7254.2 7363.6 7381.2 7434.6 5311.9 5418.7 5422.6 5560.7 5834.2 12200.5 12417.5 12797.5 12999.5 13216.3 12882.2 12936.5 12941.7 13032.2 13116.8 8283.1 8519.2 8589.3 8602.7 8607.7 9502.5 9543.6 9625.5 9636.6 9644.7 7893.6 7920.2 8116.8 8154.3 8300.3 7666.3 7717.7 7730.8 7920.0 7988.1 6954.5 6976.4 6993.5 7020.7 7026.1 4785.1 4814.2 4844.7 4862.8 4894.9 4905.5 4954.6 4977.0 4986.3 5044.4 14:22:30 INFO - PID 4001 | 14:22:30 INFO - PID 4001 | [#4] prototype.html Cycles:180 Average:4800.01 Median:5517.46 stddev:1430.76 (25.9%) stddev-sans-first:1395.31 14:22:30 INFO - PID 4001 | Values: 353.5 361.8 367.2 375.6 380.7 5544.3 5564.2 5597.2 5602.9 5610.7 5224.9 5450.2 5475.2 5484.7 5490.6 4114.9 4115.2 4142.8 4148.1 4148.6 4127.8 4130.7 4139.3 4139.7 4165.5 4073.5 4116.6 4116.6 4123.9 4128.1 4112.8 4118.5 4118.6 4142.8 4143.3 3610.6 3615.2 3620.5 3621.0 3626.9 5382.3 5396.8 5401.5 5404.3 5420.5 4888.2 4892.1 4896.9 4903.4 4907.6 5823.9 5835.9 5838.8 5846.2 5848.2 4051.7 4058.4 4071.3 4072.5 4082.1 5807.2 6167.9 6215.9 6228.2 6231.8 4121.6 4126.4 4133.9 4160.2 4168.0 4201.4 4204.3 4213.5 4214.0 4215.8 4663.8 4794.1 4845.3 4849.5 4849.7 5789.4 5801.0 5808.7 5826.8 5849.5 1445.5 1452.9 1462.6 1465.9 1466.5 956.6 976.2 991.2 994.2 999.7 5012.2 5046.5 5047.9 5048.5 5050.3 6011.3 6016.5 6044.8 6050.7 6059.5 4983.9 4993.2 4994.1 5010.9 5029.9 3166.6 3193.3 3202.9 3215.6 3222.3 5579.4 5620.4 5623.5 5624.2 5647.8 6132.9 6145.2 6162.5 6169.9 6213.9 5597.0 5605.6 5606.2 5615.4 5620.9 6034.7 6037.5 6061.6 6062.8 6069.7 5944.8 5955.2 5965.6 5967.9 5980.4 5290.1 5559.4 5569.4 5599.7 5623.4 4138.8 4151.6 4172.5 4173.0 4187.7 6037.2 6062.1 6071.8 6091.0 6104.6 5636.6 5837.2 5838.1 5845.2 5848.9 5828.6 5841.7 5856.0 5856.5 5869.4 5744.8 5745.1 5753.9 5756.3 5804.4 5911.1 5940.1 5951.4 5953.3 5967.7 5710.6 5732.6 5734.3 5735.4 5758.4 14:22:30 INFO - PID 4001 | 14:22:30 INFO - PID 4001 | [#5] yui.html Cycles:180 Average:16613.87 Median:3436.67 stddev:22068.62 (642.2%) stddev-sans-first:22097.85 14:22:30 INFO - PID 4001 | Values: 620.0 628.2 628.5 630.0 632.0 11998.5 12178.2 12472.9 14951.3 15915.4 14229.8 14382.2 14388.4 14425.6 14441.9 840.9 843.2 844.4 847.9 849.2 637.3 659.7 667.8 859.2 866.2 690.1 694.8 699.4 699.6 700.5 687.8 688.5 691.2 699.0 706.8 504.3 508.0 508.3 509.7 514.6 12215.8 12258.3 12355.6 12376.4 12384.1 14441.6 14856.3 15282.8 15397.8 15411.3 12083.8 12092.5 12294.4 12302.1 12450.8 2896.7 2904.3 2933.1 2939.6 2940.1 73403.6 73927.0 74410.6 75045.6 76019.0 11422.1 11624.0 11692.4 11899.6 12049.1 18400.5 19195.1 19251.5 19441.2 20230.8 5992.3 6160.1 6171.0 6173.8 6185.0 2806.0 2929.2 2997.5 3004.3 3009.6 3308.8 3417.4 3429.6 3431.8 3441.6 713.5 717.8 717.8 719.9 720.7 537.1 548.8 551.3 551.7 552.5 9357.0 10339.3 10627.3 10658.4 10701.8 563.5 573.2 574.6 584.5 591.5 4467.9 4707.0 4717.5 4821.2 4887.5 86022.0 86920.0 88235.0 88529.0 90966.0 66179.7 74153.6 74177.0 74555.0 74590.6 58734.4 59779.4 60570.9 61139.0 63767.7 9643.5 9712.8 9860.7 9934.6 10035.0 27311.6 28013.0 28087.4 28248.7 28281.9 34833.7 35074.1 35238.5 35549.0 36029.5 12494.6 13097.3 14075.1 14080.7 14196.0 14537.3 15325.4 15437.3 15549.8 15573.8 14259.4 14326.1 14595.1 14708.0 15020.4 14027.4 14569.4 14619.9 14659.6 14742.9 14003.8 14498.3 14711.3 14772.6 14847.7 9626.6 9642.3 9968.1 10014.8 10284.3 10360.9 10939.9 10980.6 11726.2 12317.3 14:22:30 INFO - PID 4001 | -------- Summary: end -------- 14:22:30 INFO - PID 4001 | 14:22:31 INFO - TEST-INFO | 4001: exit 0 14:22:31 INFO - TEST-OK | dromaeo_css | took 1148809ms 14:22:31 INFO - TEST-START | kraken 14:22:31 INFO - operating with platform_type : linux_ 14:22:31 INFO - Initialising browser for kraken test... 14:22:31 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:41831/getInfo.html -profile /tmp/tmp1dnyDZ/profile 14:22:31 INFO - TEST-INFO | started process 4423 (/builds/slave/test/build/application/firefox/firefox http://localhost:41831/getInfo.html) 14:23:06 INFO - TEST-INFO | 4423: killed by SIGTERM 14:23:06 INFO - Browser initialized. 14:23:06 INFO - Running cycle 1/1 for kraken test... 14:23:06 INFO - TEST-INFO | started process 4644 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp1dnyDZ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:23:18 INFO - PID 4644 | RSS: Main: 186482688 14:23:18 INFO - PID 4644 | 14:23:21 INFO - PID 4644 | Cycle 1(1): loaded http://localhost:41831/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:41831/tests/kraken/driver.html?testName=audio-beat-detection) 14:23:22 INFO - PID 4644 | RSS: Main: 190328832 14:23:22 INFO - PID 4644 | 14:23:25 INFO - PID 4644 | Cycle 1(1): loaded http://localhost:41831/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:41831/tests/kraken/driver.html?testName=audio-dft) 14:23:25 INFO - PID 4644 | RSS: Main: 188727296 14:23:25 INFO - PID 4644 | 14:23:28 INFO - PID 4644 | Cycle 1(1): loaded http://localhost:41831/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:41831/tests/kraken/driver.html?testName=audio-fft) 14:23:29 INFO - PID 4644 | RSS: Main: 185569280 14:23:29 INFO - PID 4644 | 14:23:31 INFO - PID 4644 | Cycle 1(1): loaded http://localhost:41831/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:41831/tests/kraken/driver.html?testName=audio-oscillator) 14:23:32 INFO - PID 4644 | RSS: Main: 185659392 14:23:32 INFO - PID 4644 | 14:23:34 INFO - PID 4644 | Cycle 1(1): loaded http://localhost:41831/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:41831/tests/kraken/driver.html?testName=imaging-gaussian-blur) 14:23:34 INFO - PID 4644 | RSS: Main: 186028032 14:23:34 INFO - PID 4644 | 14:23:38 INFO - PID 4644 | Cycle 1(1): loaded http://localhost:41831/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:41831/tests/kraken/driver.html?testName=imaging-darkroom) 14:23:38 INFO - PID 4644 | RSS: Main: 190435328 14:23:38 INFO - PID 4644 | 14:23:42 INFO - PID 4644 | Cycle 1(1): loaded http://localhost:41831/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:41831/tests/kraken/driver.html?testName=imaging-desaturate) 14:23:42 INFO - PID 4644 | RSS: Main: 186429440 14:23:42 INFO - PID 4644 | 14:23:45 INFO - PID 4644 | Cycle 1(1): loaded http://localhost:41831/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:41831/tests/kraken/driver.html?testName=json-parse-financial) 14:23:46 INFO - PID 4644 | RSS: Main: 186949632 14:23:46 INFO - PID 4644 | 14:23:48 INFO - PID 4644 | Cycle 1(1): loaded http://localhost:41831/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:41831/tests/kraken/driver.html?testName=json-stringify-tinderbox) 14:23:48 INFO - PID 4644 | RSS: Main: 187105280 14:23:48 INFO - PID 4644 | 14:23:50 INFO - PID 4644 | Cycle 1(1): loaded http://localhost:41831/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:41831/tests/kraken/driver.html?testName=stanford-crypto-aes) 14:23:51 INFO - PID 4644 | RSS: Main: 186527744 14:23:51 INFO - PID 4644 | 14:23:53 INFO - PID 4644 | Cycle 1(1): loaded http://localhost:41831/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:41831/tests/kraken/driver.html?testName=stanford-crypto-ccm) 14:23:54 INFO - PID 4644 | RSS: Main: 186257408 14:23:54 INFO - PID 4644 | 14:23:56 INFO - PID 4644 | Cycle 1(1): loaded http://localhost:41831/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:41831/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 14:23:57 INFO - PID 4644 | RSS: Main: 186970112 14:23:57 INFO - PID 4644 | 14:24:00 INFO - PID 4644 | Cycle 1(1): loaded http://localhost:41831/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:41831/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 14:24:01 INFO - PID 4644 | RSS: Main: 186654720 14:24:01 INFO - PID 4644 | 14:24:03 INFO - PID 4644 | Cycle 1(1): loaded http://localhost:41831/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:41831/tests/kraken/driver.html?testName=ai-astar) 14:24:03 INFO - PID 4644 | RSS: Main: 188231680 14:24:03 INFO - PID 4644 | 14:24:03 INFO - PID 4644 | __start_tp_report 14:24:03 INFO - PID 4644 | _x_x_mozilla_page_load 14:24:03 INFO - PID 4644 | _x_x_mozilla_page_load_details 14:24:03 INFO - PID 4644 | |i|pagename|runs| 14:24:03 INFO - PID 4644 | |0;ai-astar;102;113;112;113;113;114;112;116;110;111 14:24:03 INFO - PID 4644 | |1;audio-beat-detection;155;125;124;168;123;129;123;125;150;129 14:24:03 INFO - PID 4644 | |2;audio-dft;166;164;166;166;173;171;167;165;164;165 14:24:03 INFO - PID 4644 | |3;audio-fft;75;73;74;113;79;74;74;74;94;75 14:24:03 INFO - PID 4644 | |4;audio-oscillator;84;83;105;86;84;84;101;83;84;108 14:24:03 INFO - PID 4644 | |5;imaging-gaussian-blur;114;114;114;115;114;114;122;114;114;114 14:24:03 INFO - PID 4644 | |6;imaging-darkroom;152;151;152;151;154;150;151;150;152;150 14:24:03 INFO - PID 4644 | |7;imaging-desaturate;95;95;94;95;95;94;94;95;95;94 14:24:03 INFO - PID 4644 | |8;json-parse-financial;57;55;55;56;55;57;54;56;58;58 14:24:03 INFO - PID 4644 | |9;json-stringify-tinderbox;56;57;57;56;59;57;57;57;57;57 14:24:03 INFO - PID 4644 | |10;stanford-crypto-aes;97;88;87;87;87;87;96;89;117;89 14:24:03 INFO - PID 4644 | |11;stanford-crypto-ccm;131;133;136;141;135;131;128;138;131;149 14:24:03 INFO - PID 4644 | |12;stanford-crypto-pbkdf2;195;194;186;197;190;193;192;194;195;194 14:24:03 INFO - PID 4644 | |13;stanford-crypto-sha256-iterative;73;76;73;76;75;73;76;73;73;75 14:24:03 INFO - PID 4644 | __end_tp_report 14:24:03 INFO - PID 4644 | __start_cc_report 14:24:03 INFO - PID 4644 | _x_x_mozilla_cycle_collect,1008 14:24:03 INFO - PID 4644 | __end_cc_report 14:24:03 INFO - PID 4644 | __startTimestamp1496179443479__endTimestamp 14:24:03 INFO - PID 4644 | 14:24:03 INFO - PID 4644 | ------- Summary: start ------- 14:24:03 INFO - PID 4644 | Number of tests: 14 14:24:03 INFO - PID 4644 | 14:24:03 INFO - PID 4644 | [#0] ai-astar Cycles:10 Average:111.60 Median:113.00 stddev:3.75 (3.3%) stddev-sans-first:1.73 14:24:03 INFO - PID 4644 | Values: 102.0 113.0 112.0 113.0 113.0 114.0 112.0 116.0 110.0 111.0 14:24:03 INFO - PID 4644 | 14:24:03 INFO - PID 4644 | [#1] audio-beat-detection Cycles:10 Average:135.10 Median:129.00 stddev:16.31 (12.6%) stddev-sans-first:15.63 14:24:03 INFO - PID 4644 | Values: 155.0 125.0 124.0 168.0 123.0 129.0 123.0 125.0 150.0 129.0 14:24:03 INFO - PID 4644 | 14:24:03 INFO - PID 4644 | [#2] audio-dft Cycles:10 Average:166.70 Median:166.00 stddev:2.98 (1.8%) stddev-sans-first:3.15 14:24:03 INFO - PID 4644 | Values: 166.0 164.0 166.0 166.0 173.0 171.0 167.0 165.0 164.0 165.0 14:24:03 INFO - PID 4644 | 14:24:03 INFO - PID 4644 | [#3] audio-fft Cycles:10 Average:80.50 Median:74.50 stddev:13.02 (17.5%) stddev-sans-first:13.66 14:24:03 INFO - PID 4644 | Values: 75.0 73.0 74.0 113.0 79.0 74.0 74.0 74.0 94.0 75.0 14:24:03 INFO - PID 4644 | 14:24:03 INFO - PID 4644 | [#4] audio-oscillator Cycles:10 Average:90.20 Median:84.00 stddev:10.15 (12.1%) stddev-sans-first:10.52 14:24:03 INFO - PID 4644 | Values: 84.0 83.0 105.0 86.0 84.0 84.0 101.0 83.0 84.0 108.0 14:24:03 INFO - PID 4644 | 14:24:03 INFO - PID 4644 | [#5] imaging-gaussian-blur Cycles:10 Average:114.90 Median:114.00 stddev:2.51 (2.2%) stddev-sans-first:2.65 14:24:03 INFO - PID 4644 | Values: 114.0 114.0 114.0 115.0 114.0 114.0 122.0 114.0 114.0 114.0 14:24:03 INFO - PID 4644 | 14:24:03 INFO - PID 4644 | [#6] imaging-darkroom Cycles:10 Average:151.30 Median:151.50 stddev:1.25 (0.8%) stddev-sans-first:1.30 14:24:03 INFO - PID 4644 | Values: 152.0 151.0 152.0 151.0 154.0 150.0 151.0 150.0 152.0 150.0 14:24:03 INFO - PID 4644 | 14:24:03 INFO - PID 4644 | [#7] imaging-desaturate Cycles:10 Average:94.60 Median:95.00 stddev:0.52 (0.5%) stddev-sans-first:0.53 14:24:03 INFO - PID 4644 | Values: 95.0 95.0 94.0 95.0 95.0 94.0 94.0 95.0 95.0 94.0 14:24:03 INFO - PID 4644 | 14:24:03 INFO - PID 4644 | [#8] json-parse-financial Cycles:10 Average:56.10 Median:56.50 stddev:1.37 (2.4%) stddev-sans-first:1.41 14:24:03 INFO - PID 4644 | Values: 57.0 55.0 55.0 56.0 55.0 57.0 54.0 56.0 58.0 58.0 14:24:03 INFO - PID 4644 | 14:24:03 INFO - PID 4644 | [#9] json-stringify-tinderbox Cycles:10 Average:57.00 Median:57.00 stddev:0.82 (1.4%) stddev-sans-first:0.78 14:24:03 INFO - PID 4644 | Values: 56.0 57.0 57.0 56.0 59.0 57.0 57.0 57.0 57.0 57.0 14:24:03 INFO - PID 4644 | 14:24:03 INFO - PID 4644 | [#10] stanford-crypto-aes Cycles:10 Average:92.40 Median:88.50 stddev:9.42 (10.6%) stddev-sans-first:9.84 14:24:03 INFO - PID 4644 | Values: 97.0 88.0 87.0 87.0 87.0 87.0 96.0 89.0 117.0 89.0 14:24:03 INFO - PID 4644 | 14:24:03 INFO - PID 4644 | [#11] stanford-crypto-ccm Cycles:10 Average:135.30 Median:135.50 stddev:6.17 (4.6%) stddev-sans-first:6.34 14:24:03 INFO - PID 4644 | Values: 131.0 133.0 136.0 141.0 135.0 131.0 128.0 138.0 131.0 149.0 14:24:03 INFO - PID 4644 | 14:24:03 INFO - PID 4644 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:193.00 Median:194.00 stddev:3.09 (1.6%) stddev-sans-first:3.19 14:24:03 INFO - PID 4644 | Values: 195.0 194.0 186.0 197.0 190.0 193.0 192.0 194.0 195.0 194.0 14:24:03 INFO - PID 4644 | 14:24:03 INFO - PID 4644 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:74.30 Median:75.00 stddev:1.42 (1.9%) stddev-sans-first:1.42 14:24:03 INFO - PID 4644 | Values: 73.0 76.0 73.0 76.0 75.0 73.0 76.0 73.0 73.0 75.0 14:24:03 INFO - PID 4644 | -------- Summary: end -------- 14:24:03 INFO - PID 4644 | 14:24:04 INFO - TEST-INFO | 4644: exit 0 14:24:04 INFO - TEST-OK | kraken | took 93427ms 14:24:04 INFO - SUITE-END | took 1242s 14:24:05 INFO - Completed test suite (00:20:42) 14:24:05 INFO - javascript benchmark 14:24:05 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6563.085072356701, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2765.5160346939288, 2770.044334704526, 2785.5821626755983, 2808.64891888514, 2820.6615206175247, 5138.743062846861, 5296.973515132424, 5299.178627312768, 5306.230596563496, 5328.813491527797, 5135.666181698187, 5198.662086964354, 5288.497592728694, 5316.9734151329185, 5321.946780532194, 4692.882677933045, 4707.011527579212, 4738.786754596043, 4743.0, 4775.90448191036, 4710.505396933324, 4723.811047558093, 4781.665283430161, 4785.21044027735, 4849.46655867856, 4583.931241031387, 4635.327877457784, 4719.244920812688, 4728.550787675165, 4787.80848766049, 4632.050429661911, 4654.0924519718665, 4689.953100468986, 4690.64820138491, 4709.458412282597, 4679.532046795327, 4685.1800934836265, 4686.7656617169005, 4690.132325519789, 4713.387259656257, 5198.792048318062, 5249.947500525022, 5255.421903590602, 5260.368755749297, 5286.762095705702, 5547.1679248112705, 5605.0, 5624.775008999635, 5685.090385538294, 5700.97382471155, 5741.598088133832, 5745.482906538432, 5758.078707406795, 5780.739866706008, 5796.391378905197, 5319.547838433777, 5325.547328477122, 5331.413544510101, 5341.412444631087, 5348.064088784447, 5738.483536481736, 5811.680357580289, 5858.98262394867, 5884.0585506318785, 5893.2044174035955, 5573.164025396142, 5583.664980101125, 5587.776488940397, 5597.720113994365, 5608.9439105609235, 5587.804426845122, 5635.6618602883955, 5645.350784659735, 5649.576281778883, 5717.113847353667, 5518.503334699816, 5616.045272303718, 5620.578456615688, 5626.887462250814, 5639.915401268902, 5521.558275337963, 5596.0, 5616.213730077792, 5653.0, 5732.168835518826, 4703.529647035269, 4704.012157446906, 4712.52874712526, 4735.431748190239, 4749.810007599726, 4053.5338436079637, 4063.7358571692744, 4069.593040695966, 4118.897027574335, 4121.196366708463, 4687.062587482449, 4763.04739052191, 4778.689385189951, 4807.975960120177, 4840.878978025577, 5728.570357223141, 5746.511546518509, 5759.769609215585, 5780.855478613068, 5812.476877081083, 4761.381020467317, 4778.1399348117675, 4793.784279707422, 4797.055312375661, 4821.300911367832, 4870.829520966749, 5010.549050585465, 5012.3483947085915, 5012.523810238022, 5013.849584512471, 5167.819126330561, 5284.762185701576, 5339.599530035185, 5363.980843639696, 5365.839024829262, 5497.47773961473, 5768.077107662922, 5768.50967667753, 5779.739911703899, 5818.563607729522, 5260.631755777059, 5283.709395983258, 5364.329458817648, 5364.356277246756, 5373.838784836461, 5558.91661625084, 5670.347909990404, 5677.148427735872, 5680.7443665036, 5726.828195154152, 5542.0301447245765, 5616.297962754656, 5635.0702134147405, 5784.913226301524, 5800.59395842287, 5518.310211223597, 5536.806211782568, 5553.389127196086, 5584.134459158837, 5605.887882242414, 5545.584081194007, 5575.7490912909825, 5580.246666700106, 5598.10430331145, 5613.607047506799, 5432.782688692408, 5474.39781624029, 5480.725963701879, 5481.095619222783, 5487.396386397573, 5424.403315635356, 5515.558755299647, 5516.200150978166, 5612.943870561406, 5626.63426877268, 5371.973140134274, 5378.220158077135, 5398.379186393615, 5418.539424148991, 5431.37539182999], "value": 5154.373113016287, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [600.6546235914348, 663.2604645819911, 680.0886811672358, 1041.6614600254918, 1067.3222503710142, 29969.400611987774, 30706.23234419138, 30732.385352292997, 30747.69252307479, 30861.0, 30197.698023019762, 30798.23004424885, 30820.38359232814, 30830.38339233214, 30894.69105308952, 6551.1483507144, 6670.299618540056, 6671.166104236971, 6671.166104236971, 6675.299093595176, 6371.904421433682, 6503.642299673516, 6532.902006469883, 6533.020046992941, 6538.640374779386, 6540.313267106957, 6556.770513032045, 6570.408663220309, 6570.63861487618, 6578.1448411706415, 6498.317676643956, 6523.412892839668, 6529.869402611945, 6534.575252608565, 6549.1158693576235, 6517.315681853384, 6580.144581204413, 6581.638009909453, 6583.407493325576, 6585.078089067534, 28640.570391444144, 28780.568291475643, 28854.71145288541, 29025.85487072551, 29035.12894613165, 2691.8923243070253, 2704.797140214472, 2720.5239083160563, 2720.795940304465, 2729.235813972091, 22621.660675089886, 22715.31854044381, 22745.658815117786, 22756.77243227563, 22772.31683049511, 2949.5723120147672, 2960.896368627109, 2962.6000489934013, 2968.83671398073, 3010.5785190073407, 147255.0, 147356.0, 147619.26190369087, 154659.99999999886, 154906.0, 34974.650253497646, 35012.29975400529, 35125.64874351224, 35183.4722479163, 35248.0, 36168.81915590458, 36203.09492262662, 36280.45579316312, 36294.27411451809, 37544.0, 10228.284020118668, 10290.588376465008, 10307.969203079781, 10312.896871031344, 10341.224408169266, 8134.308583770446, 8140.0, 8152.918470815334, 8160.265576098061, 8169.142240064826, 11159.553617855196, 11164.720881977853, 11171.106311495061, 11234.438278086227, 11384.943075284737, 4730.95269047312, 4732.242841145469, 4734.952650473451, 4735.337052812609, 4811.4707382187935, 789.719649524422, 812.1594150054665, 814.7148498025643, 822.4489591973393, 825.005867929144, 18956.241750330108, 19284.1322140504, 19471.902640486707, 19518.609627807364, 19773.802261977486, 863.8315528472014, 891.3715830339595, 894.5437826708426, 894.695803426825, 898.5058217980085, 9860.654877079267, 10191.0, 10343.327683700536, 10352.482375881176, 10362.274640775073, 174770.0, 174849.0, 174948.0, 175266.0, 175436.0, 35482.29035419277, 35656.28687426237, 35707.64292357095, 35776.82111589425, 35909.922702318974, 1040.38617215843, 1072.083368719749, 1074.6507385099874, 1079.050435616668, 1091.2743025887696, 18411.066837982355, 18820.24719011279, 19320.8067919319, 19323.51691207675, 19616.607667846278, 27155.592666109627, 27155.86422067877, 27177.59233611458, 27214.047508337113, 27253.45493090167, 147859.0, 148067.0, 148163.2591837077, 148189.0, 148597.0, 26806.0, 26996.73003270021, 27185.0, 27210.31974200661, 28288.43423131567, 33374.165645859044, 33601.15997100092, 33696.83151584226, 33710.325793483506, 33741.0, 24533.754662453146, 25380.11169609055, 25656.486870262863, 25938.0, 26282.211533654023, 25004.49991000206, 25023.624645630694, 25132.371690707878, 25773.613395799453, 26799.0, 28845.423091538472, 28890.711092888803, 28911.277218068873, 28924.710752892202, 28947.85526072356, 25059.248222553353, 25770.09804656828, 30058.69941300559, 30261.0, 30462.23844403819, 22913.541729165656, 24759.381015474035, 25650.871745641154, 25783.871080644476, 25791.355216119748], "value": 13406.728497857039, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [397.34041491124736, 398.3844959537514, 408.06756561257515, 412.19210347718473, 414.33706070287536, 11988.220765650227, 12829.294388808612, 16356.345746170155, 16999.23503442345, 17017.06406147663, 15847.683046339067, 16480.83519164808, 16527.173641317917, 16556.50330490084, 16591.087490188034, 5334.119870221419, 5455.290812194409, 5477.123660214366, 5477.835664930059, 5500.477454641803, 5368.409474957752, 5422.9728851355685, 5423.945760542403, 5439.972800135994, 5446.782128714866, 5357.196420536911, 5390.272313237721, 5402.540784033362, 5438.945610543903, 5443.782248710067, 4946.579540739023, 5132.0, 5161.999999999963, 5430.511253987141, 5435.592330575223, 4649.651276154268, 4691.15559199344, 4694.084653492536, 4696.8590942271785, 4698.741569213692, 20513.282035128697, 20676.48308792277, 20794.896025519774, 20821.37535873926, 20835.0, 1599.3282821215118, 1627.6500552381294, 1629.030726717601, 1644.6957312897152, 1647.1270226779825, 13527.120737152054, 13914.0, 14117.082389644744, 14160.858391416057, 14183.290835458185, 2063.7420322459693, 2065.514604068043, 2119.607872543569, 2120.533482633818, 2138.6791981202787, 101405.31028311231, 103767.48116259446, 103929.0, 104033.0, 104600.0, 10077.344972576759, 10377.273590848568, 10529.157667386591, 10558.841617375745, 10576.41829699374, 14805.18571478579, 14812.481563145238, 14835.629109272139, 14849.0, 14851.183184924932, 6548.148740663779, 6863.553868998599, 6871.896921546181, 6881.552699074544, 6999.720011199597, 6220.253569571681, 6228.626282423069, 6263.091851681481, 6305.211848518935, 6332.081848131995, 6591.901121483182, 6670.699818508178, 6710.664466776641, 6753.189617245962, 6843.8973415398805, 1863.8415734662435, 1918.539550507896, 1945.3288615427655, 2017.818396344336, 2054.784247653975, 757.2730179028194, 782.8629989751771, 785.4815821557744, 792.6789650191681, 802.9759107226793, 15752.291146898417, 15793.763093553605, 16061.518154455385, 16106.838931610768, 16358.182090895407, 774.9651265693058, 783.0564170174925, 788.3574886467511, 788.8540619985321, 815.339574944297, 8752.387332886638, 8772.473651580925, 8946.86579701305, 8972.641094356282, 9229.584668689926, 337376.0, 341379.0, 343393.0, 348565.0, 357626.0, 78992.0, 80320.0, 80939.59530202311, 81757.59121204475, 82311.5884420574, 889.857622780365, 913.5112714697605, 926.6988228825523, 927.939683920543, 930.5626355612851, 14069.437222511395, 14117.717645647235, 16142.273597687898, 16202.270897809864, 17751.289948401918, 44896.55103448924, 45110.32334514919, 47000.0, 47104.7644761774, 47381.05237895292, 50979.2353114711, 51536.48463515317, 51544.48455515397, 51764.74117629388, 51992.220116699034, 8798.868016979879, 8809.075047120217, 8867.0, 8910.153535414125, 8929.553522323728, 13324.533641322507, 14212.715745685235, 14331.498397556035, 14394.784078238625, 14415.855841441871, 12279.324637144686, 12364.1963272387, 12445.62663120108, 12454.065945054339, 12480.875191247971, 11555.0, 11667.416629168678, 11669.35818529989, 11742.941285293518, 11863.34751588671, 12432.751344972869, 12602.243865368107, 12710.300933448749, 12776.169548979287, 12822.294773787158, 8676.089010654043, 8808.075152108937, 8899.777505562413, 8918.286537077149, 8987.820243595223, 12006.339651318913, 12046.397680115784, 12090.395480226129, 12116.333601651993, 12137.332446715516], "value": 8725.614099036096, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1077.5582011375336, 1108.130117857482, 1116.475256629384, 1132.0434233073056, 1136.8749437561867, 9909.207263418928, 10385.169186465084, 10390.16878649708, 10590.09984151348, 10983.61557345493, 10686.839697404526, 10781.946090269557, 10835.6749297521, 10964.671059868197, 10971.396573188471, 2081.5524662197627, 2108.1988844239168, 2120.4592828828704, 2126.6384714598557, 2129.1057755742627, 2045.6145079892726, 2070.1615845582487, 2071.7721050684413, 2079.8232150267245, 2081.0843228979274, 2017.213286818142, 2039.88780617066, 2042.6221149087467, 2044.1925439451409, 2045.6624656931588, 2000.9099590518463, 2003.5091402606308, 2015.5666531695683, 2022.9190832366687, 2026.3313106674761, 1911.054028256022, 2000.4998750312423, 2073.1810934680716, 2075.5122546201633, 2082.9479263018393, 10387.532561034772, 10474.528646210938, 10474.79050418995, 10497.687789026371, 10507.0, 5353.2237825515085, 5558.471945165203, 5568.0, 5592.384837667853, 5595.356533998602, 3256.2185075581688, 3329.6004479462376, 3355.6979871811654, 3377.290768938526, 3399.55805745254, 1089.580511503077, 1096.8299913513338, 1107.6787731557838, 1128.2553514680353, 1135.7444574970648, 14127.15237085778, 14419.476591596533, 16219.189040548043, 16483.58791030222, 16559.25483353252, 4532.9546704533195, 4743.501932297059, 4758.833440829554, 4759.452662943806, 4782.9760851196215, 10739.731506712395, 10752.892471075189, 10762.515686794113, 10765.407902565434, 10803.891961080446, 4875.34182885313, 5274.498922602346, 5274.630775845654, 5303.416624171338, 5319.414864364917, 4851.757412129379, 4859.1496488114435, 4862.3922009748785, 4892.706437613754, 4900.215965445512, 3762.8163762816584, 3900.1029763154065, 3912.374020156761, 3935.2129574085297, 3940.7438516496336, 1114.3091283404178, 1118.183725880112, 1143.1769126229267, 1144.1476100305326, 1148.3397046698183, 586.6245602814203, 600.6966481926686, 606.1211243696657, 607.3349682098095, 608.6986941464004, 4760.690555113906, 4841.782119804618, 4855.490173531728, 4911.336969509142, 4997.075541024922, 516.3081470829108, 520.0976306108898, 520.3495630461923, 749.6214411722045, 795.1372760554863, 3247.204434913414, 3350.447176215946, 3413.7098346640814, 3461.238527523941, 3462.2036931505895, 13935.303234838217, 14040.297985100704, 14515.0, 14521.564353069425, 14530.927345363205, 14005.0, 14253.216073115871, 14330.21183834899, 14331.498397556035, 14507.274636268145, 7078.999999999897, 7254.165770936304, 7363.595002274927, 7381.224971378036, 7434.628268586657, 5311.893762124813, 5418.674879507084, 5422.566194704335, 5560.7219639018695, 5834.241548598655, 12200.51197952072, 12417.503299867903, 12797.488100476248, 12999.545015924397, 13216.339183041002, 12882.162659427107, 12936.547220847602, 12941.741165176456, 13032.218066915637, 13116.819486246284, 8283.130271321425, 8519.23326900582, 8589.312854971713, 8602.655893764178, 8607.698730544402, 9502.524873756423, 9543.614096475882, 9625.470599117116, 9636.566354514203, 9644.710658680251, 7893.605319734105, 7920.207979202034, 8116.83766324682, 8154.266116049584, 8300.294474969694, 7666.310032097138, 7717.723271634769, 7730.845383092419, 7919.960400197962, 7988.081370642451, 6954.513184077066, 6976.407005404598, 6993.510454268152, 7020.719171233093, 7026.051483049723, 4785.090832741768, 4814.181589129927, 4844.709317440965, 4862.781174847211, 4894.877628059327, 4905.509449055208, 4954.628402869871, 4976.950230497649, 4986.276989836526, 5044.369453818273], "value": 4584.200647030225, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [353.4909729988816, 361.7883538130194, 367.23431645020133, 375.56059410489723, 380.68022860796924, 5544.279243698318, 5564.1931919871595, 5597.160425936112, 5602.915956260659, 5610.663360198391, 5224.921626175601, 5450.182472629108, 5475.206095116206, 5484.725763711808, 5490.6431081979745, 4114.855980040692, 4115.218108559379, 4142.8400047986615, 4148.149629325981, 4148.585141485857, 4127.752334859903, 4130.690198235145, 4139.317012692902, 4139.689523285766, 4165.541790403053, 4073.5111786585503, 4116.567760385161, 4116.608922152391, 4123.876283711494, 4128.071183983609, 4112.8149233284275, 4118.517333759844, 4118.588141185887, 4142.834286628561, 4143.316352801784, 3610.638936106395, 3615.1865830188262, 3620.456931460276, 3620.963790362089, 3626.909327266813, 5382.255049924566, 5396.83809485716, 5401.4868587484125, 5404.270423492818, 5420.457954204588, 4888.242322440027, 4892.067633284868, 4896.922677011052, 4903.362562866841, 4907.607391408679, 5823.912641310384, 5835.941640583582, 5838.781263119988, 5846.21076154718, 5848.152017957373, 4051.7163798534116, 4058.3506638937924, 4071.2875246831686, 4072.450219220397, 4082.142750022499, 5807.245058142456, 6167.87664246717, 6215.923118056546, 6228.190335256388, 6231.813045608639, 4121.608447197512, 4126.360414135754, 4133.886782651221, 4160.167966406731, 4167.9583204168175, 4201.445465177903, 4204.348326009474, 4213.47331583552, 4214.030772922245, 4215.789210539522, 4663.790129444184, 4794.137055330004, 4845.297431872429, 4849.515048495122, 4849.660523763373, 5789.392113828072, 5801.042827933428, 5808.709564521757, 5826.766929322865, 5849.473547380671, 1445.4579532675248, 1452.9273536323353, 1462.612407711957, 1465.9267036648125, 1466.5160497035952, 956.6269155029544, 976.1605019683067, 991.1525645573075, 994.2493417469764, 999.6701088640731, 5012.172991456442, 5046.520580544842, 5047.87380315495, 5048.5203905628905, 5050.3434553507805, 6011.338752737195, 6016.458518733335, 6044.788432404845, 6050.6672133032225, 6059.484943779828, 4983.9252411213865, 4993.201087825931, 4994.07846409847, 5010.949890501121, 5029.899402011939, 3166.5725127108008, 3193.297474555594, 3202.8558714857886, 3215.6302025266928, 3222.2749881276527, 5579.38626751057, 5620.381758006616, 5623.493885550321, 5624.21261023457, 5647.842192350558, 6132.908006379907, 6145.170401995762, 6162.506999440034, 6169.876602468015, 6213.867777927718, 5597.0, 5605.5515558755205, 5606.159076138611, 5615.410381909923, 5620.943790562205, 6034.668093254738, 6037.516998640186, 6061.636301821904, 6062.818115456544, 6069.696515174312, 5944.791932282349, 5955.166276721176, 5965.612235204698, 5967.940320596912, 5980.401959804159, 5290.064014472005, 5559.444055594408, 5569.35952365467, 5599.664020158803, 5623.409541998195, 4138.751674899516, 4151.56408577095, 4172.457580514514, 4172.979135104305, 4187.66498680111, 6037.158666606727, 6062.060380641008, 6071.787487437919, 6090.969545152423, 6104.603200791934, 5636.605437619492, 5837.241158649348, 5838.095095260242, 5845.240118784531, 5848.883022339614, 5828.59199856006, 5841.678707671119, 5856.0, 5856.531477481706, 5869.383714709894, 5744.770209191753, 5745.109508026263, 5753.8561535961935, 5756.251687280626, 5804.448577385142, 5911.1428842816695, 5940.108983652487, 5951.375105614022, 5953.3153687324775, 5967.701614919323, 5710.5717071219, 5732.566858285429, 5734.254546908875, 5735.394089654903, 5758.366579676149], "value": 4354.667656737827, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [620.0420350558387, 628.2429672244946, 628.4501061571125, 629.9559030867838, 632.0203684289356, 11998.460069296882, 12178.208416452935, 12472.937635311822, 14951.252437378142, 15915.44295949642, 14229.78655320171, 14382.208978506178, 14388.424463021493, 14425.63935901603, 14441.855581444182, 840.8738689196623, 843.1694780641063, 844.4342290665269, 847.9364047696416, 849.2102344819316, 637.3148864970152, 659.6503852957916, 667.8096742428409, 859.2481578618708, 866.1857853617611, 690.1028662738445, 694.78114393966, 699.3530983839928, 699.5837476701355, 700.5096432497247, 687.8074139240971, 688.5421194905407, 691.1602403080257, 699.0004293859779, 706.8338940349065, 504.3393154967005, 508.0372693745332, 508.3087001677715, 509.71455984648713, 514.5806167973127, 12215.75568488634, 12258.325792081432, 12355.567555135616, 12376.381180940916, 12384.071194660346, 14441.638959026004, 14856.257187140707, 15282.770758438632, 15397.769033464507, 15411.30649120781, 12083.818742718866, 12092.455839487244, 12294.385280736016, 12302.07734419922, 12450.81323780144, 2896.6958469360834, 2904.346522032547, 2933.0760810344673, 2939.5884576159356, 2940.1326608650497, 73403.63298183474, 73927.0, 74410.62794685992, 75045.62477187633, 76019.0, 11422.14333924959, 11624.0, 11692.415379231004, 11899.643010709693, 12049.096317776202, 18400.53998650018, 19195.136218870186, 19251.51871203231, 19441.222351105796, 20230.797692023185, 5992.250968628921, 6160.10678451622, 6171.043488259327, 6173.8456538586, 6185.010398336244, 2805.9859700701772, 2929.1798296477023, 2997.535382015791, 3004.2939909121337, 3009.6087508623737, 3308.8180150091976, 3417.3677869594203, 3429.639887811794, 3431.7940923544666, 3441.552598162273, 713.4613366907952, 717.7882524655239, 717.806192328079, 719.910011248594, 720.6865013719049, 537.1110811606796, 548.8271194573697, 551.2613098448098, 551.737924485874, 552.5248286473629, 9356.95321523388, 10339.327943683787, 10627.256092073636, 10658.413787241776, 10701.83947240792, 563.5435297409111, 573.2261447046454, 574.5920396518435, 584.5002522842908, 591.5267785771366, 4467.930101893162, 4707.0, 4717.481077081518, 4821.228603423436, 4887.511248875155, 86022.0, 86920.0, 88235.0, 88529.0, 90966.0, 66179.69831960907, 74153.6292318535, 74177.0, 74555.0, 74590.62704686442, 58734.41265587375, 59779.402205977385, 60570.91436284505, 61139.0, 63767.68116159389, 9643.469609171563, 9712.805743884941, 9860.704178874645, 9934.602615895572, 10035.0, 27311.59032614552, 28013.0, 28087.438251234453, 28248.71751282461, 28281.858590706914, 34833.65166348304, 35074.123146921534, 35238.47142292817, 35549.0, 36029.45955810612, 12494.562690305796, 13097.279649619362, 14075.085119467201, 14080.718385632024, 14196.0, 14537.273136342928, 15325.386984520494, 15437.305321260796, 15549.84450155484, 15573.766393504333, 14259.358328875433, 14326.140431574138, 14595.051321664057, 14708.043977141879, 15020.399184032516, 14027.36876840565, 14569.41722331095, 14619.85380146185, 14659.633509162357, 14742.852571474577, 14003.789943150658, 14498.34757435939, 14711.264436777905, 14772.63068423298, 14847.703045938804, 9626.614935402506, 9642.325037247325, 9968.053034961667, 10014.849777253201, 10284.2801003929, 10360.948195258976, 10939.890601093886, 10980.560777568808, 11726.237794543327, 12317.260964342167], "value": 6639.045345000673, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1553.0, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [102.0, 113.0, 112.0, 113.0, 113.0, 114.0, 112.0, 116.0, 110.0, 111.0], "value": 111.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [155.0, 125.0, 124.0, 168.0, 123.0, 129.0, 123.0, 125.0, 150.0, 129.0], "value": 135.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [166.0, 164.0, 166.0, 166.0, 173.0, 171.0, 167.0, 165.0, 164.0, 165.0], "value": 166.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 73.0, 74.0, 113.0, 79.0, 74.0, 74.0, 74.0, 94.0, 75.0], "value": 80.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 83.0, 105.0, 86.0, 84.0, 84.0, 101.0, 83.0, 84.0, 108.0], "value": 90.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 114.0, 114.0, 115.0, 114.0, 114.0, 122.0, 114.0, 114.0, 114.0], "value": 114.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 151.0, 152.0, 151.0, 154.0, 150.0, 151.0, 150.0, 152.0, 150.0], "value": 151.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 94.0, 95.0, 95.0, 94.0, 94.0, 95.0, 95.0, 94.0], "value": 94.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 55.0, 55.0, 56.0, 55.0, 57.0, 54.0, 56.0, 58.0, 58.0], "value": 56.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 57.0, 57.0, 56.0, 59.0, 57.0, 57.0, 57.0, 57.0, 57.0], "value": 57.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [97.0, 88.0, 87.0, 87.0, 87.0, 87.0, 96.0, 89.0, 117.0, 89.0], "value": 92.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [131.0, 133.0, 136.0, 141.0, 135.0, 131.0, 128.0, 138.0, 131.0, 149.0], "value": 135.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [195.0, 194.0, 186.0, 197.0, 190.0, 193.0, 192.0, 194.0, 195.0, 194.0], "value": 193.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 76.0, 73.0, 76.0, 75.0, 73.0, 76.0, 73.0, 73.0, 75.0], "value": 74.3, "unit": "score"}]}]} 14:24:05 INFO - Return code: 0 14:24:05 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 14:24:05 INFO - # TBPL SUCCESS # 14:24:05 INFO - Running post-action listener: _resource_record_post_action 14:24:05 INFO - [mozharness: 2017-05-30 21:24:05.308950Z] Finished run-tests step (success) 14:24:05 INFO - Running post-run listener: _resource_record_post_run 14:24:05 INFO - Total resource usage - Wall time: 1259s; CPU: 13.0%; Read bytes: 4096; Write bytes: 409456640; Read time: 12; Write time: 226076 14:24:05 INFO - TinderboxPrint: CPU usage
12.7% 14:24:05 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 14:24:05 INFO - TinderboxPrint: I/O write bytes / time
409,456,640 / 226,076 14:24:05 INFO - TinderboxPrint: CPU idle
8,774.0 (87.3%) 14:24:05 INFO - TinderboxPrint: CPU user
1,223.0 (12.2%) 14:24:05 INFO - TinderboxPrint: Swap in / out
0 / 0 14:24:05 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 99495936; Read time: 0; Write time: 64648 14:24:05 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 14:24:05 INFO - run-tests - Wall time: 1243s; CPU: 13.0%; Read bytes: 0; Write bytes: 309960704; Read time: 0; Write time: 161428 14:24:05 INFO - Running post-run listener: _upload_blobber_files 14:24:05 INFO - Blob upload gear active. 14:24:05 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 14:24:05 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 14:24:05 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'] 14:24:05 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 14:24:06 INFO - (blobuploader) - INFO - Open directory for files ... 14:24:06 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 14:24:06 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:24:06 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:24:07 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 14:24:07 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:24:07 INFO - (blobuploader) - INFO - Done attempting. 14:24:07 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 14:24:07 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:24:07 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:24:08 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 14:24:08 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:24:08 INFO - (blobuploader) - INFO - Done attempting. 14:24:08 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 14:24:08 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:24:08 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:24:08 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 14:24:08 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:24:08 INFO - (blobuploader) - INFO - Done attempting. 14:24:08 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 14:24:08 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:24:08 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:24:18 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 14:24:18 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:24:18 INFO - (blobuploader) - INFO - Done attempting. 14:24:18 INFO - (blobuploader) - INFO - Iteration through files over. 14:24:18 INFO - Return code: 0 14:24:18 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 14:24:18 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 14:24:18 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/97142fb26788696351bdec149e309eae4392c5942b433bbd1dabdfeb213d7851fb06b08d3b30e9b01a1a49be802dd84ae6ef99a6ea7f9134c395ec950b098464", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c75b5f52235179042697c68a6d01216c9160c340fd04a6da71dca404000ae845b75ead4eee642159bd241054f918ddc4bec8d93a5d72b6b44605a60d4818a260", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/06261c6a8fb049727c40d0246a001093b3f096482bc3def7ea0e04fc825b8cec5acf91f6ffded14c645f167d7b643e7ecd7b5fc866a60d23ffc54f2ea4c60ffa", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8fac50f882be14a94cdfdd141f4f2451ffe9411218ecaa0f1641c93e2d8d17a9ba6a44f836f6ded638e148a143df59b2c16970b1081f1db57238b6296eea4dc9"} 14:24:18 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 14:24:18 INFO - Writing to file /builds/slave/test/properties/blobber_files 14:24:18 INFO - Contents: 14:24:18 INFO - blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/97142fb26788696351bdec149e309eae4392c5942b433bbd1dabdfeb213d7851fb06b08d3b30e9b01a1a49be802dd84ae6ef99a6ea7f9134c395ec950b098464", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c75b5f52235179042697c68a6d01216c9160c340fd04a6da71dca404000ae845b75ead4eee642159bd241054f918ddc4bec8d93a5d72b6b44605a60d4818a260", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/06261c6a8fb049727c40d0246a001093b3f096482bc3def7ea0e04fc825b8cec5acf91f6ffded14c645f167d7b643e7ecd7b5fc866a60d23ffc54f2ea4c60ffa", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8fac50f882be14a94cdfdd141f4f2451ffe9411218ecaa0f1641c93e2d8d17a9ba6a44f836f6ded638e148a143df59b2c16970b1081f1db57238b6296eea4dc9"} 14:24:18 INFO - Running post-run listener: copy_logs_to_upload_dir 14:24:18 INFO - Copying logs to upload dir... 14:24:18 INFO - mkdir: /builds/slave/test/build/upload/logs 14:24:18 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1326.467954 ========= master_lag: 0.11 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 22 mins, 6 secs) (at 2017-05-30 14:24:17.740723) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-30 14:24:17.745780) ========= 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=7de08804244eb36560b44971000001c3-1496171457.632463-630333248 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/97142fb26788696351bdec149e309eae4392c5942b433bbd1dabdfeb213d7851fb06b08d3b30e9b01a1a49be802dd84ae6ef99a6ea7f9134c395ec950b098464", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c75b5f52235179042697c68a6d01216c9160c340fd04a6da71dca404000ae845b75ead4eee642159bd241054f918ddc4bec8d93a5d72b6b44605a60d4818a260", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/06261c6a8fb049727c40d0246a001093b3f096482bc3def7ea0e04fc825b8cec5acf91f6ffded14c645f167d7b643e7ecd7b5fc866a60d23ffc54f2ea4c60ffa", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8fac50f882be14a94cdfdd141f4f2451ffe9411218ecaa0f1641c93e2d8d17a9ba6a44f836f6ded638e148a143df59b2c16970b1081f1db57238b6296eea4dc9"} build_url:https://queue.taskcluster.net/v1/task/QcHb3q6rSq-29FSDzJWOeg/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011314 build_url: 'https://queue.taskcluster.net/v1/task/QcHb3q6rSq-29FSDzJWOeg/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/97142fb26788696351bdec149e309eae4392c5942b433bbd1dabdfeb213d7851fb06b08d3b30e9b01a1a49be802dd84ae6ef99a6ea7f9134c395ec950b098464", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c75b5f52235179042697c68a6d01216c9160c340fd04a6da71dca404000ae845b75ead4eee642159bd241054f918ddc4bec8d93a5d72b6b44605a60d4818a260", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/06261c6a8fb049727c40d0246a001093b3f096482bc3def7ea0e04fc825b8cec5acf91f6ffded14c645f167d7b643e7ecd7b5fc866a60d23ffc54f2ea4c60ffa", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8fac50f882be14a94cdfdd141f4f2451ffe9411218ecaa0f1641c93e2d8d17a9ba6a44f836f6ded638e148a143df59b2c16970b1081f1db57238b6296eea4dc9"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-30 14:24:17.774596) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-30 14:24:17.774996) ========= 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=7de08804244eb36560b44971000001c3-1496171457.632463-630333248 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004568 ========= master_lag: 0.07 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-30 14:24:17.852211) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-30 14:24:17.854676) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-30 14:24:17.855052) ========= ========= Total master_lag: 0.29 =========