builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-041 starttime: 1496966336.2 results: success (0) revision: 5c61d5d5fc653454cb816b2bcf8c6a9f5a71c705 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-06-08 16:58:56.203552) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-06-08 16:58:56.204036) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-06-08 16:58:56.204345) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-06-08 16:58:56.223497) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-06-08 16:58:56.223784) ========= 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=8c6b6742ce8f6f39ef4ce27d000001f1-1496947179.941099-1516635857 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-06-08 16:58:57-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 42.8M=0s 2017-06-08 16:58:57 (42.8 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.122382 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-06-08 16:58:56.362418) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-06-08 16:58:56.362776) ========= 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=8c6b6742ce8f6f39ef4ce27d000001f1-1496947179.941099-1516635857 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.023055 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-06-08 16:58:56.411950) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-06-08 16:58:56.415308) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 5c61d5d5fc653454cb816b2bcf8c6a9f5a71c705 --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 5c61d5d5fc653454cb816b2bcf8c6a9f5a71c705 --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=8c6b6742ce8f6f39ef4ce27d000001f1-1496947179.941099-1516635857 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-06-08 16:58:58,022 truncating revision to first 12 chars 2017-06-08 16:58:58,022 Setting DEBUG logging. 2017-06-08 16:58:58,023 attempt 1/10 2017-06-08 16:58:58,023 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/5c61d5d5fc65?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-06-08 16:58:58,579 unpacking tar archive at: mozilla-central-5c61d5d5fc65/testing/mozharness/ program finished with exit code 0 elapsedTime=0.912665 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-06-08 16:58:57.343260) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-06-08 16:58:57.343598) ========= script_repo_revision: 5c61d5d5fc653454cb816b2bcf8c6a9f5a71c705 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-06-08 16:58:57.343999) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-06-08 16:58:57.344281) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-06-08 16:58:57.353584) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 51 secs) (at 2017-06-08 16:58:57.353863) ========= /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=8c6b6742ce8f6f39ef4ce27d000001f1-1496947179.941099-1516635857 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 16:58:59 INFO - MultiFileLogger online at 20170608 16:58:59 in /builds/slave/test 16:58:59 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 16:58:59 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 16:58:59 INFO - {'append_to_log': False, 16:58:59 INFO - 'base_work_dir': '/builds/slave/test', 16:58:59 INFO - 'blob_upload_branch': 'Firefox', 16:58:59 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 16:58:59 INFO - 'branch': 'Firefox', 16:58:59 INFO - 'buildbot_json_path': 'buildprops.json', 16:58:59 INFO - 'config_files': ('talos/linux_config.py',), 16:58:59 INFO - 'default_actions': ('clobber', 16:58:59 INFO - 'read-buildbot-config', 16:58:59 INFO - 'download-and-extract', 16:58:59 INFO - 'populate-webroot', 16:58:59 INFO - 'create-virtualenv', 16:58:59 INFO - 'install', 16:58:59 INFO - 'setup-mitmproxy', 16:58:59 INFO - 'run-tests'), 16:58:59 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 16:58:59 INFO - 'download_minidump_stackwalk': True, 16:58:59 INFO - 'download_symbols': 'ondemand', 16:58:59 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 16:58:59 INFO - 'tooltool.py': '/tools/tooltool.py', 16:58:59 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 16:58:59 INFO - '/tools/misc-python/virtualenv.py')}, 16:58:59 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 16:58:59 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 16:58:59 INFO - 'gecko_profile': False, 16:58:59 INFO - 'gecko_profile_interval': 0, 16:58:59 INFO - 'installer_path': 'installer.exe', 16:58:59 INFO - 'log_level': 'info', 16:58:59 INFO - 'log_name': 'talos', 16:58:59 INFO - 'log_to_console': True, 16:58:59 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 16:58:59 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 16:58:59 INFO - 'opt_config_files': (), 16:58:59 INFO - 'pip_index': False, 16:58:59 INFO - 'suite': 'dromaeojs-e10s', 16:58:59 INFO - 'system_bits': '32', 16:58:59 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 16:58:59 INFO - 'title': 'talos-linux64-ix-041', 16:58:59 INFO - 'tooltool_cache': '/builds/tooltool_cache', 16:58:59 INFO - 'use_talos_json': True, 16:58:59 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 16:58:59 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 16:58:59 INFO - 'work_dir': 'build'} 16:58:59 INFO - [mozharness: 2017-06-08 23:58:59.061173Z] Running clobber step. 16:58:59 INFO - Running pre-action listener: _resource_record_pre_action 16:58:59 INFO - Running main action method: clobber 16:58:59 INFO - rmtree: /builds/slave/test/build 16:58:59 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 16:59:00 INFO - Running post-action listener: _resource_record_post_action 16:59:00 INFO - [mozharness: 2017-06-08 23:59:00.094112Z] Finished clobber step (success) 16:59:00 INFO - [mozharness: 2017-06-08 23:59:00.094213Z] Running read-buildbot-config step. 16:59:00 INFO - Running pre-action listener: _resource_record_pre_action 16:59:00 INFO - Running main action method: read_buildbot_config 16:59:00 INFO - Using buildbot properties: 16:59:00 INFO - { 16:59:00 INFO - "project": "", 16:59:00 INFO - "product": "firefox", 16:59:00 INFO - "who": "kwierso@gmail.com", 16:59:00 INFO - "installer_path": "public/build/target.tar.bz2", 16:59:00 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 16:59:00 INFO - "repository": "https://hg.mozilla.org/mozilla-central/", 16:59:00 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs-e10s", 16:59:00 INFO - "stage_platform": "linux64-pgo", 16:59:00 INFO - "basedir": "/builds/slave/test", 16:59:00 INFO - "buildnumber": 2, 16:59:00 INFO - "platform": "ubuntu64_hw", 16:59:00 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 16:59:00 INFO - "slavebuilddir": "test", 16:59:00 INFO - "taskId": "BAlKhJhwTS6KZeYCT7gmbg", 16:59:00 INFO - "branch": "mozilla-central", 16:59:00 INFO - "script_repo_revision": "production", 16:59:00 INFO - "revision": "5c61d5d5fc653454cb816b2bcf8c6a9f5a71c705", 16:59:00 INFO - "slavename": "talos-linux64-ix-041", 16:59:00 INFO - "repo_path": "mozilla-central" 16:59:00 INFO - } 16:59:00 INFO - Finding installer, test and symbols from parent task. 16:59:00 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/BAlKhJhwTS6KZeYCT7gmbg'}, attempt #1 16:59:00 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/BAlKhJhwTS6KZeYCT7gmbg'}, attempt #1 16:59:01 INFO - Task dependencies: BISjsZ3uQfqYEix2o48TKA 16:59:01 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/BISjsZ3uQfqYEix2o48TKA'}, attempt #1 16:59:01 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/BISjsZ3uQfqYEix2o48TKA/artifacts/public/build/target.tar.bz2 16:59:01 INFO - Set test_url: https://queue.taskcluster.net/v1/task/BISjsZ3uQfqYEix2o48TKA/artifacts/public/build/test_packages.json 16:59:01 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/BISjsZ3uQfqYEix2o48TKA/artifacts/public/build/target.crashreporter-symbols.zip 16:59:01 INFO - Running post-action listener: _resource_record_post_action 16:59:01 INFO - [mozharness: 2017-06-08 23:59:01.452659Z] Finished read-buildbot-config step (success) 16:59:01 INFO - [mozharness: 2017-06-08 23:59:01.452924Z] Running download-and-extract step. 16:59:01 INFO - Running pre-action listener: _resource_record_pre_action 16:59:01 INFO - Running main action method: download_and_extract 16:59:01 INFO - mkdir: /builds/slave/test/build/tests 16:59: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')]} 16:59:01 INFO - trying https://queue.taskcluster.net/v1/task/BISjsZ3uQfqYEix2o48TKA/artifacts/public/build/target.test_packages.json 16:59:01 INFO - Downloading https://queue.taskcluster.net/v1/task/BISjsZ3uQfqYEix2o48TKA/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 16:59:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/BISjsZ3uQfqYEix2o48TKA/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 16:59:02 INFO - Downloaded 989 bytes. 16:59:02 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 16:59:02 INFO - Using the following test package requirements: 16:59:02 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 16:59:02 INFO - u'common': [u'target.common.tests.zip'], 16:59:02 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 16:59:02 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 16:59:02 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 16:59:02 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 16:59:02 INFO - u'mozbase': [u'target.common.tests.zip'], 16:59:02 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 16:59:02 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 16:59:02 INFO - u'web-platform': [u'target.common.tests.zip', 16:59:02 INFO - u'target.web-platform.tests.tar.gz'], 16:59:02 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 16:59:02 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 16:59:02 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/BISjsZ3uQfqYEix2o48TKA/artifacts/public/build/target.common.tests.zip 16:59:02 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/BISjsZ3uQfqYEix2o48TKA/artifacts/public/build/target.common.tests.zip'}, attempt #1 16:59:02 INFO - Fetch https://queue.taskcluster.net/v1/task/BISjsZ3uQfqYEix2o48TKA/artifacts/public/build/target.common.tests.zip into memory 16:59:03 INFO - Content-Length response header: 68498447 16:59:03 INFO - Bytes received: 68498447 16:59:14 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 16:59:14 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/BISjsZ3uQfqYEix2o48TKA/artifacts/public/build/target.common.tests.zip 16:59:14 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/BISjsZ3uQfqYEix2o48TKA/artifacts/public/build/target.common.tests.zip'}, attempt #1 16:59:14 INFO - Fetch https://queue.taskcluster.net/v1/task/BISjsZ3uQfqYEix2o48TKA/artifacts/public/build/target.common.tests.zip into memory 16:59:16 INFO - Content-Length response header: 68498447 16:59:16 INFO - Bytes received: 68498447 16:59:28 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/BISjsZ3uQfqYEix2o48TKA/artifacts/public/build/target.talos.tests.zip 16:59:28 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/BISjsZ3uQfqYEix2o48TKA/artifacts/public/build/target.talos.tests.zip'}, attempt #1 16:59:28 INFO - Fetch https://queue.taskcluster.net/v1/task/BISjsZ3uQfqYEix2o48TKA/artifacts/public/build/target.talos.tests.zip into memory 16:59:29 INFO - Content-Length response header: 14447568 16:59:29 INFO - Bytes received: 14447568 16:59:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:59:29 INFO - trying https://queue.taskcluster.net/v1/task/BISjsZ3uQfqYEix2o48TKA/artifacts/public/build/target.tar.bz2 16:59:29 INFO - Downloading https://queue.taskcluster.net/v1/task/BISjsZ3uQfqYEix2o48TKA/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 16:59:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/BISjsZ3uQfqYEix2o48TKA/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 16:59:31 INFO - Downloaded 59845278 bytes. 16:59:31 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/BISjsZ3uQfqYEix2o48TKA/artifacts/public/build/target.tar.bz2 16:59:31 INFO - mkdir: /builds/slave/test/properties 16:59:31 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 16:59:31 INFO - Writing to file /builds/slave/test/properties/build_url 16:59:31 INFO - Contents: 16:59:31 INFO - build_url:https://queue.taskcluster.net/v1/task/BISjsZ3uQfqYEix2o48TKA/artifacts/public/build/target.tar.bz2 16:59:31 INFO - Running post-action listener: _resource_record_post_action 16:59:31 INFO - Running post-action listener: set_extra_try_arguments 16:59:31 INFO - [mozharness: 2017-06-08 23:59:31.278731Z] Finished download-and-extract step (success) 16:59:31 INFO - [mozharness: 2017-06-08 23:59:31.278828Z] Running populate-webroot step. 16:59:31 INFO - Running pre-action listener: _resource_record_pre_action 16:59:31 INFO - Running main action method: populate_webroot 16:59:31 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 16:59:31 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 16:59:31 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 16:59:31 INFO - '--tppagecycles', 16:59:31 INFO - '7'], 16:59:31 INFO - 'tests': ['tsvgm']}}, 16:59:31 INFO - 'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 16:59:31 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 16:59:31 INFO - 'tests': ['dromaeo_css', 'kraken']}, 16:59:31 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 16:59:31 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 16:59:31 INFO - 'talos_options': ['--disable-e10s'], 16:59:31 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:59:31 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 16:59:31 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:59:31 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 16:59:31 INFO - 'talos_options': ['--disable-e10s'], 16:59:31 INFO - 'tests': ['damp', 'tps']}, 16:59:31 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 16:59:31 INFO - 'tests': ['damp', 'tps']}, 16:59:31 INFO - 'g3': {'talos_options': ['--disable-e10s'], 16:59:31 INFO - 'tests': ['dromaeo_dom']}, 16:59:31 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 16:59:31 INFO - 'g4': {'talos_options': ['--disable-e10s'], 16:59:31 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 16:59:31 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 16:59:31 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 16:59:31 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 16:59:31 INFO - 'other': {'talos_options': ['--disable-e10s'], 16:59:31 INFO - 'tests': ['a11yr', 16:59:31 INFO - 'ts_paint', 16:59:31 INFO - 'tpaint', 16:59:31 INFO - 'sessionrestore', 16:59:31 INFO - 'sessionrestore_no_auto_restore', 16:59:31 INFO - 'tabpaint']}, 16:59:31 INFO - 'other-e10s': {'tests': ['a11yr', 16:59:31 INFO - 'ts_paint', 16:59:31 INFO - 'tpaint', 16:59:31 INFO - 'sessionrestore', 16:59:31 INFO - 'sessionrestore_no_auto_restore', 16:59:31 INFO - 'tabpaint']}, 16:59:31 INFO - 'other-e10s_l64': {'tests': ['a11yr', 16:59:31 INFO - 'ts_paint', 16:59:31 INFO - 'tpaint', 16:59:31 INFO - 'sessionrestore', 16:59:31 INFO - 'sessionrestore_no_auto_restore', 16:59:31 INFO - 'tabpaint']}, 16:59:31 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 16:59:31 INFO - 'ts_paint', 16:59:31 INFO - 'tpaint', 16:59:31 INFO - 'sessionrestore', 16:59:31 INFO - 'sessionrestore_no_auto_restore', 16:59:31 INFO - 'tabpaint']}, 16:59:31 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 16:59:31 INFO - 'tests': ['a11yr', 16:59:31 INFO - 'ts_paint', 16:59:31 INFO - 'tpaint', 16:59:31 INFO - 'sessionrestore', 16:59:31 INFO - 'sessionrestore_no_auto_restore', 16:59:31 INFO - 'tabpaint']}, 16:59:31 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 16:59:31 INFO - 'tests': ['a11yr', 16:59:31 INFO - 'ts_paint', 16:59:31 INFO - 'tpaint', 16:59:31 INFO - 'sessionrestore', 16:59:31 INFO - 'sessionrestore_no_auto_restore', 16:59:31 INFO - 'tabpaint']}, 16:59:31 INFO - 'perf-reftest': {'tests': ['bloom_basic', 'bloom_basic_ref']}, 16:59:31 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic', 16:59:31 INFO - 'bloom_basic_ref']}, 16:59:31 INFO - 'quantum-pageload-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set.zip', 16:59:31 INFO - 'talos_options': ['--mitmproxy', 16:59:31 INFO - 'mitmproxy-recording-1.mp', 16:59:31 INFO - '--firstNonBlankPaint'], 16:59:31 INFO - 'tests': ['Quantum_1']}, 16:59:31 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 16:59:31 INFO - 'tests': ['tsvgx', 16:59:31 INFO - 'tsvgr_opacity', 16:59:31 INFO - 'tart', 16:59:31 INFO - 'tscrollx', 16:59:31 INFO - 'cart', 16:59:31 INFO - 'tsvg_static']}, 16:59:31 INFO - 'svgr-e10s': {'tests': ['tsvgx', 16:59:31 INFO - 'tsvgr_opacity', 16:59:31 INFO - 'tart', 16:59:31 INFO - 'tscrollx', 16:59:31 INFO - 'cart', 16:59:31 INFO - 'tsvg_static']}, 16:59:31 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 16:59:31 INFO - 'talos_options': ['--disable-e10s'], 16:59:31 INFO - 'tests': ['tp5o']}, 16:59:31 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 16:59:31 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 16:59:31 INFO - 'talos_options': ['--disable-e10s', 16:59:31 INFO - '--xperf_path', 16:59:31 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:59:31 INFO - 'tests': ['tp5n']}, 16:59:31 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 16:59:31 INFO - 'talos_options': ['--xperf_path', 16:59:31 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:59:31 INFO - 'tests': ['tp5n']}}, 16:59:31 INFO - 'talos.zip': {'path': '', 16:59:31 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 16:59:31 INFO - Running post-action listener: _resource_record_post_action 16:59:31 INFO - [mozharness: 2017-06-08 23:59:31.293206Z] Finished populate-webroot step (success) 16:59:31 INFO - [mozharness: 2017-06-08 23:59:31.293302Z] Running create-virtualenv step. 16:59:31 INFO - Running pre-action listener: _resource_record_pre_action 16:59:31 INFO - Running main action method: create_virtualenv 16:59:31 INFO - Creating virtualenv /builds/slave/test/build/venv 16:59:31 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 16:59:31 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 16:59:31 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 16:59:31 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 16:59:31 INFO - Using real prefix '/usr' 16:59:31 INFO - New python executable in /builds/slave/test/build/venv/bin/python 16:59:31 INFO - Installing distribute.............................................................................................................................................................................................done. 16:59:33 INFO - Installing pip.................done. 16:59:33 INFO - Return code: 0 16:59:33 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 16:59:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 16:59:34 INFO - Reading from file tmpfile_stdout 16:59:34 INFO - Output received: 16:59:34 INFO - pip 1.5.5 from /builds/slave/test/build/venv/local/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 16:59:34 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 16:59:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:59:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:59:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:59:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:59:34 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 0x1dd23b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1faca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21509a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x214e140>, '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 0x214ea40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x214eed0>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1496947179.941099-1516635857', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 16:59:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 16:59:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 16:59:34 INFO - Using env: {'DISPLAY': ':0', 16:59:34 INFO - 'HOME': '/home/cltbld', 16:59:34 INFO - 'LANG': 'en_US.UTF-8', 16:59:34 INFO - 'LANGUAGE': 'en_US:en', 16:59:34 INFO - 'LOGNAME': 'cltbld', 16:59:34 INFO - 'MAIL': '/var/mail/cltbld', 16:59:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:59:34 INFO - 'MOZ_NO_REMOTE': '1', 16:59:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:59:34 INFO - 'NO_EM_RESTART': '1', 16:59:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:59:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:59:34 INFO - 'PWD': '/builds/slave/test', 16:59:34 INFO - 'SHELL': '/bin/bash', 16:59:34 INFO - 'SHLVL': '1', 16:59:34 INFO - 'TERM': 'linux', 16:59:34 INFO - 'TMOUT': '86400', 16:59:34 INFO - 'USER': 'cltbld', 16:59:34 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1496947179.941099-1516635857', 16:59:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:59:34 INFO - '_': '/tools/buildbot/bin/python'} 16:59:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:59:34 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 16:59:34 INFO - Cleaning up... 16:59:34 INFO - Return code: 0 16:59:34 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 16:59:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:59:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:59:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:59:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:59:34 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 0x1dd23b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1faca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21509a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x214e140>, '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 0x214ea40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x214eed0>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1496947179.941099-1516635857', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 16:59:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 16:59:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 16:59:34 INFO - Using env: {'DISPLAY': ':0', 16:59:34 INFO - 'HOME': '/home/cltbld', 16:59:34 INFO - 'LANG': 'en_US.UTF-8', 16:59:34 INFO - 'LANGUAGE': 'en_US:en', 16:59:34 INFO - 'LOGNAME': 'cltbld', 16:59:34 INFO - 'MAIL': '/var/mail/cltbld', 16:59:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:59:34 INFO - 'MOZ_NO_REMOTE': '1', 16:59:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:59:34 INFO - 'NO_EM_RESTART': '1', 16:59:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:59:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:59:34 INFO - 'PWD': '/builds/slave/test', 16:59:34 INFO - 'SHELL': '/bin/bash', 16:59:34 INFO - 'SHLVL': '1', 16:59:34 INFO - 'TERM': 'linux', 16:59:34 INFO - 'TMOUT': '86400', 16:59:34 INFO - 'USER': 'cltbld', 16:59:34 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1496947179.941099-1516635857', 16:59:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:59:34 INFO - '_': '/tools/buildbot/bin/python'} 16:59:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:59:34 INFO - Downloading/unpacking psutil>=3.1.1 16:59:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:59:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:59:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:59:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:59:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 16:59:35 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:59:35 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:59:35 INFO - Installing collected packages: psutil 16:59:35 INFO - Running setup.py install for psutil 16:59:35 INFO - building 'psutil._psutil_linux' extension 16:59:35 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 16:59:35 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 16:59:35 INFO - building 'psutil._psutil_posix' extension 16:59:35 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 16:59:36 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 16:59:36 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:59:36 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:59:36 INFO - Successfully installed psutil 16:59:36 INFO - Cleaning up... 16:59:36 INFO - Return code: 0 16:59:36 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 16:59:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:59:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:59:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:59:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:59:36 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 0x1dd23b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1faca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21509a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x214e140>, '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 0x214ea40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x214eed0>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1496947179.941099-1516635857', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 16:59:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 16:59:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 16:59:36 INFO - Using env: {'DISPLAY': ':0', 16:59:36 INFO - 'HOME': '/home/cltbld', 16:59:36 INFO - 'LANG': 'en_US.UTF-8', 16:59:36 INFO - 'LANGUAGE': 'en_US:en', 16:59:36 INFO - 'LOGNAME': 'cltbld', 16:59:36 INFO - 'MAIL': '/var/mail/cltbld', 16:59:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:59:36 INFO - 'MOZ_NO_REMOTE': '1', 16:59:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:59:36 INFO - 'NO_EM_RESTART': '1', 16:59:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:59:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:59:36 INFO - 'PWD': '/builds/slave/test', 16:59:36 INFO - 'SHELL': '/bin/bash', 16:59:36 INFO - 'SHLVL': '1', 16:59:36 INFO - 'TERM': 'linux', 16:59:36 INFO - 'TMOUT': '86400', 16:59:36 INFO - 'USER': 'cltbld', 16:59:36 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1496947179.941099-1516635857', 16:59:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:59:36 INFO - '_': '/tools/buildbot/bin/python'} 16:59:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:59:36 INFO - Downloading/unpacking mozsystemmonitor==0.3 16:59:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:59:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:59:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:59:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:59:37 INFO - Downloading mozsystemmonitor-0.3.tar.gz 16:59:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 16:59:37 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 16:59:37 INFO - Installing collected packages: mozsystemmonitor 16:59:37 INFO - Running setup.py install for mozsystemmonitor 16:59:37 INFO - Successfully installed mozsystemmonitor 16:59:37 INFO - Cleaning up... 16:59:37 INFO - Return code: 0 16:59:37 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 16:59:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:59:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:59:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:59:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:59:37 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 0x1dd23b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1faca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21509a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x214e140>, '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 0x214ea40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x214eed0>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1496947179.941099-1516635857', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 16:59:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 16:59:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 16:59:37 INFO - Using env: {'DISPLAY': ':0', 16:59:37 INFO - 'HOME': '/home/cltbld', 16:59:37 INFO - 'LANG': 'en_US.UTF-8', 16:59:37 INFO - 'LANGUAGE': 'en_US:en', 16:59:37 INFO - 'LOGNAME': 'cltbld', 16:59:37 INFO - 'MAIL': '/var/mail/cltbld', 16:59:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:59:37 INFO - 'MOZ_NO_REMOTE': '1', 16:59:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:59:37 INFO - 'NO_EM_RESTART': '1', 16:59:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:59:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:59:37 INFO - 'PWD': '/builds/slave/test', 16:59:37 INFO - 'SHELL': '/bin/bash', 16:59:37 INFO - 'SHLVL': '1', 16:59:37 INFO - 'TERM': 'linux', 16:59:37 INFO - 'TMOUT': '86400', 16:59:37 INFO - 'USER': 'cltbld', 16:59:37 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1496947179.941099-1516635857', 16:59:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:59:37 INFO - '_': '/tools/buildbot/bin/python'} 16:59:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:59:37 INFO - Downloading/unpacking jsonschema==2.5.1 16:59:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:59:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:59:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:59:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:59:39 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 16:59:39 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 16:59:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:59:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:59:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:59:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:59:39 INFO - Downloading functools32-3.2.3-2.tar.gz 16:59:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 16:59:39 INFO - warning: no files found matching '*.txt' 16:59:39 INFO - no previously-included directories found matching 'build' 16:59:39 INFO - no previously-included directories found matching 'dist' 16:59:39 INFO - no previously-included directories found matching '.git*' 16:59:39 INFO - Installing collected packages: jsonschema, functools32 16:59:39 INFO - Running setup.py install for functools32 16:59:39 INFO - warning: no files found matching '*.txt' 16:59:39 INFO - no previously-included directories found matching 'build' 16:59:39 INFO - no previously-included directories found matching 'dist' 16:59:39 INFO - no previously-included directories found matching '.git*' 16:59:39 INFO - Successfully installed jsonschema functools32 16:59:39 INFO - Cleaning up... 16:59:39 INFO - Return code: 0 16:59:39 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 16:59:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:59:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:59:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:59:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:59:39 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 0x1dd23b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1faca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21509a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x214e140>, '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 0x214ea40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x214eed0>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1496947179.941099-1516635857', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 16:59:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 16:59:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 16:59:39 INFO - Using env: {'DISPLAY': ':0', 16:59:39 INFO - 'HOME': '/home/cltbld', 16:59:39 INFO - 'LANG': 'en_US.UTF-8', 16:59:39 INFO - 'LANGUAGE': 'en_US:en', 16:59:39 INFO - 'LOGNAME': 'cltbld', 16:59:39 INFO - 'MAIL': '/var/mail/cltbld', 16:59:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:59:39 INFO - 'MOZ_NO_REMOTE': '1', 16:59:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:59:39 INFO - 'NO_EM_RESTART': '1', 16:59:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:59:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:59:39 INFO - 'PWD': '/builds/slave/test', 16:59:39 INFO - 'SHELL': '/bin/bash', 16:59:39 INFO - 'SHLVL': '1', 16:59:39 INFO - 'TERM': 'linux', 16:59:39 INFO - 'TMOUT': '86400', 16:59:39 INFO - 'USER': 'cltbld', 16:59:39 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1496947179.941099-1516635857', 16:59:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:59:39 INFO - '_': '/tools/buildbot/bin/python'} 16:59:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:59:39 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 16:59:39 INFO - Cleaning up... 16:59:39 INFO - Return code: 0 16:59:39 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 16:59:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:59:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:59:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:59:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:59:39 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 0x1dd23b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1faca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21509a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x214e140>, '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 0x214ea40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x214eed0>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1496947179.941099-1516635857', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 16:59:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 16:59:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 16:59:39 INFO - Using env: {'DISPLAY': ':0', 16:59:39 INFO - 'HOME': '/home/cltbld', 16:59:39 INFO - 'LANG': 'en_US.UTF-8', 16:59:39 INFO - 'LANGUAGE': 'en_US:en', 16:59:39 INFO - 'LOGNAME': 'cltbld', 16:59:39 INFO - 'MAIL': '/var/mail/cltbld', 16:59:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:59:39 INFO - 'MOZ_NO_REMOTE': '1', 16:59:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:59:39 INFO - 'NO_EM_RESTART': '1', 16:59:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:59:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:59:39 INFO - 'PWD': '/builds/slave/test', 16:59:39 INFO - 'SHELL': '/bin/bash', 16:59:39 INFO - 'SHLVL': '1', 16:59:39 INFO - 'TERM': 'linux', 16:59:39 INFO - 'TMOUT': '86400', 16:59:39 INFO - 'USER': 'cltbld', 16:59:39 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1496947179.941099-1516635857', 16:59:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:59:39 INFO - '_': '/tools/buildbot/bin/python'} 16:59:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:59:39 INFO - Downloading/unpacking blobuploader==1.2.4 16:59:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:59:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:59:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:59:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:59:40 INFO - Downloading blobuploader-1.2.4.tar.gz 16:59:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 16:59:41 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 16:59:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:59:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:59:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:59:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:59:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 16:59:41 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 16:59:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:59:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:59:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:59:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:59:41 INFO - Downloading docopt-0.6.1.tar.gz 16:59:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 16:59:41 INFO - Installing collected packages: blobuploader, requests, docopt 16:59:41 INFO - Running setup.py install for blobuploader 16:59:41 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 16:59:41 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 16:59:41 INFO - Running setup.py install for requests 16:59:41 INFO - Running setup.py install for docopt 16:59:42 INFO - Successfully installed blobuploader requests docopt 16:59:42 INFO - Cleaning up... 16:59:42 INFO - Return code: 0 16:59:42 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:59:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:59:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:59:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:59:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:59:42 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 0x1dd23b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1faca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21509a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x214e140>, '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 0x214ea40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x214eed0>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1496947179.941099-1516635857', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 16:59:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 16:59:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 16:59:42 INFO - Using env: {'DISPLAY': ':0', 16:59:42 INFO - 'HOME': '/home/cltbld', 16:59:42 INFO - 'LANG': 'en_US.UTF-8', 16:59:42 INFO - 'LANGUAGE': 'en_US:en', 16:59:42 INFO - 'LOGNAME': 'cltbld', 16:59:42 INFO - 'MAIL': '/var/mail/cltbld', 16:59:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:59:42 INFO - 'MOZ_NO_REMOTE': '1', 16:59:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:59:42 INFO - 'NO_EM_RESTART': '1', 16:59:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:59:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:59:42 INFO - 'PWD': '/builds/slave/test', 16:59:42 INFO - 'SHELL': '/bin/bash', 16:59:42 INFO - 'SHLVL': '1', 16:59:42 INFO - 'TERM': 'linux', 16:59:42 INFO - 'TMOUT': '86400', 16:59:42 INFO - 'USER': 'cltbld', 16:59:42 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1496947179.941099-1516635857', 16:59:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:59:42 INFO - '_': '/tools/buildbot/bin/python'} 16:59:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:59:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:59:42 INFO - Running setup.py (path:/tmp/pip-7HuHqN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:59:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:59:42 INFO - Running setup.py (path:/tmp/pip-mXPXst-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:59:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:59:42 INFO - Running setup.py (path:/tmp/pip-tXtFkv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:59:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:59:42 INFO - Running setup.py (path:/tmp/pip-Ues6m1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:59:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:59:42 INFO - Running setup.py (path:/tmp/pip-75BUMe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:59:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:59:42 INFO - Running setup.py (path:/tmp/pip-aswT0t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:59:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:59:42 INFO - Running setup.py (path:/tmp/pip-N4_kor-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:59:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:59:42 INFO - Running setup.py (path:/tmp/pip-NYiaht-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:59:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:59:42 INFO - Running setup.py (path:/tmp/pip-YUR0gy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:59:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:59:43 INFO - Running setup.py (path:/tmp/pip-9ssHQX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:59:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:59:43 INFO - Running setup.py (path:/tmp/pip-WQ3OJV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:59:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:59:43 INFO - Running setup.py (path:/tmp/pip-JB1yYW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:59:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:59:43 INFO - Running setup.py (path:/tmp/pip-0v0mNS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:59:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:59:43 INFO - Running setup.py (path:/tmp/pip-v9W6Xo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:59:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:59:43 INFO - Running setup.py (path:/tmp/pip-RZIIVZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:59:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:59:43 INFO - Running setup.py (path:/tmp/pip-OiyKmC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:59:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:59:43 INFO - Running setup.py (path:/tmp/pip-RD8yjc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:59:43 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 16:59:43 INFO - Running setup.py install for manifestparser 16:59:43 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 16:59:43 INFO - Running setup.py install for mozcrash 16:59:43 INFO - Running setup.py install for mozdebug 16:59:43 INFO - Running setup.py install for mozdevice 16:59:43 INFO - Installing dm script to /builds/slave/test/build/venv/bin 16:59:43 INFO - Running setup.py install for mozfile 16:59:44 INFO - Running setup.py install for mozhttpd 16:59:44 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 16:59:44 INFO - Running setup.py install for mozinfo 16:59:44 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 16:59:44 INFO - Running setup.py install for mozInstall 16:59:44 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 16:59:44 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 16:59:44 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 16:59:44 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 16:59:44 INFO - Running setup.py install for mozleak 16:59:44 INFO - Running setup.py install for mozlog 16:59:44 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 16:59:44 INFO - Running setup.py install for moznetwork 16:59:44 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 16:59:44 INFO - Running setup.py install for mozprocess 16:59:44 INFO - Running setup.py install for mozprofile 16:59:44 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 16:59:44 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 16:59:44 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 16:59:44 INFO - Running setup.py install for mozrunner 16:59:45 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 16:59:45 INFO - Running setup.py install for mozscreenshot 16:59:45 INFO - Running setup.py install for moztest 16:59:45 INFO - Running setup.py install for mozversion 16:59:45 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 16:59:45 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 16:59:45 INFO - Cleaning up... 16:59:45 INFO - Return code: 0 16:59:45 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:59: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')]} 16:59:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:59: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')]} 16:59:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:59:45 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 0x1dd23b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1faca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21509a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x214e140>, '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 0x214ea40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x214eed0>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1496947179.941099-1516635857', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 16:59:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 16:59:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 16:59:45 INFO - Using env: {'DISPLAY': ':0', 16:59:45 INFO - 'HOME': '/home/cltbld', 16:59:45 INFO - 'LANG': 'en_US.UTF-8', 16:59:45 INFO - 'LANGUAGE': 'en_US:en', 16:59:45 INFO - 'LOGNAME': 'cltbld', 16:59:45 INFO - 'MAIL': '/var/mail/cltbld', 16:59:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:59:45 INFO - 'MOZ_NO_REMOTE': '1', 16:59:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:59:45 INFO - 'NO_EM_RESTART': '1', 16:59:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:59:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:59:45 INFO - 'PWD': '/builds/slave/test', 16:59:45 INFO - 'SHELL': '/bin/bash', 16:59:45 INFO - 'SHLVL': '1', 16:59:45 INFO - 'TERM': 'linux', 16:59:45 INFO - 'TMOUT': '86400', 16:59:45 INFO - 'USER': 'cltbld', 16:59:45 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1496947179.941099-1516635857', 16:59:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:59:45 INFO - '_': '/tools/buildbot/bin/python'} 16:59:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:59:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:59:45 INFO - Running setup.py (path:/tmp/pip-0pgW_n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:59:45 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 16:59:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:59:45 INFO - Running setup.py (path:/tmp/pip-6yBTJA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:59:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 16:59:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:59:45 INFO - Running setup.py (path:/tmp/pip-INakdd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:59:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 16:59:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:59:45 INFO - Running setup.py (path:/tmp/pip-QxUj9X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:59:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.51 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 16:59:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:59:45 INFO - Running setup.py (path:/tmp/pip-C0oLfk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:59:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 16:59:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:59:45 INFO - Running setup.py (path:/tmp/pip-IEFNdg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:59:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 16:59:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:59:45 INFO - Running setup.py (path:/tmp/pip-o6t9Mf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:59:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.10 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 16:59:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:59:46 INFO - Running setup.py (path:/tmp/pip-vep7ul-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:59:46 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)) 16:59:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:59:46 INFO - Running setup.py (path:/tmp/pip-N2WfPB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:59:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 16:59:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:59:46 INFO - Running setup.py (path:/tmp/pip-Au1Ns8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:59:46 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)) 16:59:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:59:46 INFO - Running setup.py (path:/tmp/pip-LHWOz4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:59:46 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 16:59:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:59:46 INFO - Running setup.py (path:/tmp/pip-UoUb2W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:59:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 16:59:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:59:46 INFO - Running setup.py (path:/tmp/pip-dBjSLx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:59:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 16:59:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:59:46 INFO - Running setup.py (path:/tmp/pip-dxENnb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:59:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 16:59:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:59:46 INFO - Running setup.py (path:/tmp/pip-nCTgxF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:59:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 16:59:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:59:46 INFO - Running setup.py (path:/tmp/pip-cOwc3V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:59:46 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 16:59:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:59:46 INFO - Running setup.py (path:/tmp/pip-_sg6hl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:59:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 16:59:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 16:59:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 16:59:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 16:59:46 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.51->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 16:59:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.51->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 16:59:46 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 16:59:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:59:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:59:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:59:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:59:47 INFO - Downloading blessings-1.6.tar.gz 16:59:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 16:59:47 INFO - Installing collected packages: blessings 16:59:47 INFO - Running setup.py install for blessings 16:59:48 INFO - Successfully installed blessings 16:59:48 INFO - Cleaning up... 16:59:48 INFO - Return code: 0 16:59:48 INFO - Done creating virtualenv /builds/slave/test/build/venv. 16:59:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:59:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:59:48 INFO - Reading from file tmpfile_stdout 16:59:48 INFO - Current package versions: 16:59:48 INFO - argparse == 1.2.1 16:59:48 INFO - blessings == 1.6 16:59:48 INFO - blobuploader == 1.2.4 16:59:48 INFO - docopt == 0.6.1 16:59:48 INFO - functools32 == 3.2.3-2 16:59:48 INFO - jsonschema == 2.5.1 16:59:48 INFO - manifestparser == 1.1 16:59:48 INFO - mozInstall == 1.12 16:59:48 INFO - mozcrash == 1.0 16:59:48 INFO - mozdebug == 0.1 16:59:48 INFO - mozdevice == 0.51 16:59:48 INFO - mozfile == 1.2 16:59:48 INFO - mozhttpd == 0.7 16:59:48 INFO - mozinfo == 0.10 16:59:48 INFO - mozleak == 0.1 16:59:48 INFO - mozlog == 3.4 16:59:48 INFO - moznetwork == 0.27 16:59:48 INFO - mozprocess == 0.25 16:59:48 INFO - mozprofile == 0.28 16:59:48 INFO - mozrunner == 6.13 16:59:48 INFO - mozscreenshot == 0.1 16:59:48 INFO - mozsystemmonitor == 0.3 16:59:48 INFO - moztest == 0.8 16:59:48 INFO - mozversion == 1.4 16:59:48 INFO - psutil == 3.1.1 16:59:48 INFO - requests == 1.2.3 16:59:48 INFO - wsgiref == 0.1.2 16:59:48 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:59:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:59:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:59:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:59:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:59:48 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 0x1dd23b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1faca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21509a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x214e140>, '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 0x214ea40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x214eed0>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1496947179.941099-1516635857', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 16:59:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 16:59:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 16:59:48 INFO - Using env: {'DISPLAY': ':0', 16:59:48 INFO - 'HOME': '/home/cltbld', 16:59:48 INFO - 'LANG': 'en_US.UTF-8', 16:59:48 INFO - 'LANGUAGE': 'en_US:en', 16:59:48 INFO - 'LOGNAME': 'cltbld', 16:59:48 INFO - 'MAIL': '/var/mail/cltbld', 16:59:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:59:48 INFO - 'MOZ_NO_REMOTE': '1', 16:59:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:59:48 INFO - 'NO_EM_RESTART': '1', 16:59:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:59:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:59:48 INFO - 'PWD': '/builds/slave/test', 16:59:48 INFO - 'SHELL': '/bin/bash', 16:59:48 INFO - 'SHLVL': '1', 16:59:48 INFO - 'TERM': 'linux', 16:59:48 INFO - 'TMOUT': '86400', 16:59:48 INFO - 'USER': 'cltbld', 16:59:48 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1496947179.941099-1516635857', 16:59:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:59:48 INFO - '_': '/tools/buildbot/bin/python'} 16:59:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:59:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 16:59:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 16:59:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 16:59:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 16:59:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 16:59:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 16:59:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 16:59:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 16:59:48 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 16:59:48 INFO - Downloading/unpacking marionette-driver>=1.4.0 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 16:59:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:59:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:59:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:59:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:59:49 INFO - Downloading marionette_driver-1.4.0.tar.gz 16:59:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/marionette-driver/setup.py) egg_info for package marionette-driver 16:59:49 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 16:59:49 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 16:59:49 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)) 16:59:49 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)) 16:59:49 INFO - Installing collected packages: marionette-driver 16:59:49 INFO - Running setup.py install for marionette-driver 16:59:49 INFO - Successfully installed marionette-driver 16:59:49 INFO - Cleaning up... 16:59:49 INFO - Return code: 0 16:59:49 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 16:59:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:59:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:59:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:59:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:59: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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1dd23b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1faca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21509a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x214e140>, '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 0x214ea40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x214eed0>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1496947179.941099-1516635857', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 16:59: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', 'jsonschema'] in /builds/slave/test/build 16:59: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 jsonschema 16:59:49 INFO - Using env: {'DISPLAY': ':0', 16:59:49 INFO - 'HOME': '/home/cltbld', 16:59:49 INFO - 'LANG': 'en_US.UTF-8', 16:59:49 INFO - 'LANGUAGE': 'en_US:en', 16:59:49 INFO - 'LOGNAME': 'cltbld', 16:59:49 INFO - 'MAIL': '/var/mail/cltbld', 16:59:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:59:49 INFO - 'MOZ_NO_REMOTE': '1', 16:59:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:59:49 INFO - 'NO_EM_RESTART': '1', 16:59:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:59:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:59:49 INFO - 'PWD': '/builds/slave/test', 16:59:49 INFO - 'SHELL': '/bin/bash', 16:59:49 INFO - 'SHLVL': '1', 16:59:49 INFO - 'TERM': 'linux', 16:59:49 INFO - 'TMOUT': '86400', 16:59:49 INFO - 'USER': 'cltbld', 16:59:49 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1496947179.941099-1516635857', 16:59:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:59:49 INFO - '_': '/tools/buildbot/bin/python'} 16:59:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:59:50 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 16:59:50 INFO - Cleaning up... 16:59:50 INFO - Return code: 0 16:59:50 INFO - Running post-action listener: _resource_record_post_action 16:59:50 INFO - Running post-action listener: _start_resource_monitoring 16:59:50 INFO - Starting resource monitoring. 16:59:50 INFO - [mozharness: 2017-06-08 23:59:50.119486Z] Finished create-virtualenv step (success) 16:59:50 INFO - [mozharness: 2017-06-08 23:59:50.119948Z] Running install step. 16:59:50 INFO - Running pre-action listener: _resource_record_pre_action 16:59:50 INFO - Running main action method: install 16:59:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:59:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:59:50 INFO - Reading from file tmpfile_stdout 16:59:50 INFO - Detecting whether we're running mozinstall >=1.0... 16:59:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 16:59:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 16:59:50 INFO - Reading from file tmpfile_stdout 16:59:50 INFO - Output received: 16:59:50 INFO - Usage: mozinstall [options] installer 16:59:50 INFO - Options: 16:59:50 INFO - -h, --help show this help message and exit 16:59:50 INFO - -d DEST, --destination=DEST 16:59:50 INFO - Directory to install application into. [default: 16:59:50 INFO - "/builds/slave/test"] 16:59:50 INFO - --app=APP Application being installed. [default: firefox] 16:59:50 INFO - mkdir: /builds/slave/test/build/application 16:59:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/target.tar.bz2', '--destination', '/builds/slave/test/build/application'] 16:59:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 17:00:07 INFO - Reading from file tmpfile_stdout 17:00:07 INFO - Output received: 17:00:07 INFO - /builds/slave/test/build/application/firefox/firefox 17:00:07 INFO - Running post-action listener: _resource_record_post_action 17:00:07 INFO - [mozharness: 2017-06-09 00:00:07.275116Z] Finished install step (success) 17:00:07 INFO - [mozharness: 2017-06-09 00:00:07.275393Z] Running setup-mitmproxy step. 17:00:07 INFO - Running pre-action listener: _resource_record_pre_action 17:00:07 INFO - Running main action method: setup_mitmproxy 17:00:07 INFO - Skipping: mitmproxy is not required 17:00:07 INFO - Running post-action listener: _resource_record_post_action 17:00:07 INFO - [mozharness: 2017-06-09 00:00:07.276508Z] Finished setup-mitmproxy step (success) 17:00:07 INFO - [mozharness: 2017-06-09 00:00:07.276727Z] Running run-tests step. 17:00:07 INFO - Running pre-action listener: _resource_record_pre_action 17:00:07 INFO - Running main action method: run_tests 17:00:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 17:00:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 17:00:07 INFO - Python 2.7.3 17:00:07 INFO - Return code: 0 17:00:07 INFO - grabbing minidump binary from tooltool 17:00:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:00:07 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 0x214e140>, '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 0x214ea40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x214eed0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 17:00:07 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 17:00:07 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 17:00:07 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 17:00:07 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 17:00:07 INFO - Return code: 0 17:00:07 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 17:00:07 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 17:00:07 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 17:00:07 INFO - ENV: RUST_BACKTRACE is now 1 17:00:07 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 17:00:07 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 17:00:07 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/BISjsZ3uQfqYEix2o48TKA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-041', '--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 17:00:07 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/BISjsZ3uQfqYEix2o48TKA/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-041 --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 17:00:07 INFO - Using env: {'DISPLAY': ':0', 17:00:07 INFO - 'HOME': '/home/cltbld', 17:00:07 INFO - 'LANG': 'en_US.UTF-8', 17:00:07 INFO - 'LANGUAGE': 'en_US:en', 17:00:07 INFO - 'LOGNAME': 'cltbld', 17:00:07 INFO - 'MAIL': '/var/mail/cltbld', 17:00:07 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 17:00:07 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 17:00:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:00:07 INFO - 'MOZ_NO_REMOTE': '1', 17:00:07 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 17:00:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:00:07 INFO - 'NO_EM_RESTART': '1', 17:00:07 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:00:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:00:07 INFO - 'PWD': '/builds/slave/test', 17:00:07 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 17:00:07 INFO - 'RUST_BACKTRACE': '1', 17:00:07 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 17:00:07 INFO - 'SHELL': '/bin/bash', 17:00:07 INFO - 'SHLVL': '1', 17:00:07 INFO - 'TERM': 'linux', 17:00:07 INFO - 'TMOUT': '86400', 17:00:07 INFO - 'USER': 'cltbld', 17:00:07 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1496947179.941099-1516635857', 17:00:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:00:07 INFO - '_': '/tools/buildbot/bin/python'} 17:00:07 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/BISjsZ3uQfqYEix2o48TKA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-041', '--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 17:00:07 INFO - mozversion application_buildid: 20170608230934 17:00:07 INFO - mozversion application_changeset: 5c61d5d5fc653454cb816b2bcf8c6a9f5a71c705 17:00:07 INFO - mozversion application_display_name: Nightly 17:00:07 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 17:00:07 INFO - mozversion application_name: Firefox 17:00:07 INFO - mozversion application_remotingname: firefox 17:00:07 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 17:00:07 INFO - mozversion application_vendor: Mozilla 17:00:07 INFO - mozversion application_version: 55.0a1 17:00:07 INFO - mozversion platform_buildid: 20170608230934 17:00:07 INFO - mozversion platform_changeset: 5c61d5d5fc653454cb816b2bcf8c6a9f5a71c705 17:00:07 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 17:00:07 INFO - mozversion platform_version: 55.0a1 17:00:07 INFO - using testdate: 1496966407 17:00:07 INFO - actual date: 1496966407 17:00:07 INFO - starting webserver on 'localhost:45165' 17:00:07 INFO - SUITE-START | Running 2 tests 17:00:07 INFO - TEST-START | dromaeo_css 17:00:07 INFO - operating with platform_type : linux_ 17:00:07 INFO - Initialising browser for dromaeo_css test... 17:00:07 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:45165/getInfo.html -profile /tmp/tmplfb2lG/profile 17:00:07 INFO - TEST-INFO | started process 7950 (/builds/slave/test/build/application/firefox/firefox http://localhost:45165/getInfo.html) 17:00:42 INFO - TEST-INFO | 7950: killed by SIGTERM 17:00:42 INFO - Browser initialized. 17:00:42 INFO - Running cycle 1/1 for dromaeo_css test... 17:00:42 INFO - TEST-INFO | started process 8157 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmplfb2lG/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:00:54 INFO - PID 8157 | RSS: Main: 177278976 17:00:54 INFO - PID 8157 | 17:03:54 INFO - PID 8157 | Cycle 1(1): loaded http://localhost:45165/tests/dromaeo/cssquery-dojo.html (next: http://localhost:45165/tests/dromaeo/cssquery-ext.html) 17:03:55 INFO - PID 8157 | RSS: Main: 176205824 17:03:55 INFO - PID 8157 | 17:06:57 INFO - PID 8157 | Cycle 1(1): loaded http://localhost:45165/tests/dromaeo/cssquery-ext.html (next: http://localhost:45165/tests/dromaeo/cssquery-jquery.html) 17:06:58 INFO - PID 8157 | RSS: Main: 180498432 17:06:58 INFO - PID 8157 | 17:09:59 INFO - PID 8157 | Cycle 1(1): loaded http://localhost:45165/tests/dromaeo/cssquery-jquery.html (next: http://localhost:45165/tests/dromaeo/cssquery-mootools.html) 17:10:00 INFO - PID 8157 | RSS: Main: 177004544 17:10:00 INFO - PID 8157 | 17:13:01 INFO - PID 8157 | Cycle 1(1): loaded http://localhost:45165/tests/dromaeo/cssquery-mootools.html (next: http://localhost:45165/tests/dromaeo/cssquery-prototype.html) 17:13:02 INFO - PID 8157 | RSS: Main: 180604928 17:13:02 INFO - PID 8157 | 17:16:04 INFO - PID 8157 | Cycle 1(1): loaded http://localhost:45165/tests/dromaeo/cssquery-prototype.html (next: http://localhost:45165/tests/dromaeo/cssquery-yui.html) 17:16:05 INFO - PID 8157 | RSS: Main: 179265536 17:16:05 INFO - PID 8157 | 17:19:07 INFO - PID 8157 | Cycle 1(1): loaded http://localhost:45165/tests/dromaeo/cssquery-yui.html (next: http://localhost:45165/tests/dromaeo/cssquery-dojo.html) 17:19:07 INFO - PID 8157 | RSS: Main: 180867072 17:19:07 INFO - PID 8157 | 17:19:07 INFO - PID 8157 | __start_tp_report 17:19:07 INFO - PID 8157 | _x_x_mozilla_page_load 17:19:07 INFO - PID 8157 | _x_x_mozilla_page_load_details 17:19:07 INFO - PID 8157 | |i|pagename|runs| 17:19:07 INFO - PID 8157 | |0;dojo.html;3350.8324583770805;3380.391529524686;3388.271521622852;3388.6441923598013;3397.1337308986235;5847.298324201101;5918.1122831575285;5960.165576819249;5987.461128498434;6008.128821320911;5913.497352725013;5925.822225333236;5964.105384192373;6014.097885317205;6040.758369665219;4927.310176575283;5179.870503237412;5290.285811415458;5308.734563271841;5336.30628018357;5333.066713325172;5378.46215378461;5397.62216644835;5400.540954018913;5407.864803379907;5199.766010529497;5202.06362854686;5203.19350500673;5311.840644780663;5327.881144959563;5321.574274058066;5343.545798607123;5350.892982140374;5355.437679043684;5357;5304.602154838364;5323.520883120537;5326.733663316857;5343;5351.438098999627;5728.570357223225;5844.444777746107;5930.258717660293;5939.406059394069;5976.372480889488;6405.135306733578;6446.097546343516;6476.6114033158165;6480.125183100268;6492.188476440445;6516.478681705452;6517.771877984248;6528.347165283481;6530.216374035146;6554.1151944487365;5880.617759845596;5943.375945525744;5973.671448070398;6067.332593414721;6074.997625391805;6525.151730275129;6528.738850446024;6540.37866402691;6557.278699343068;6566.24488183865;6115.696722738819;6135.049067394561;6261.499080073583;6268.122462855204;6269.592476489013;6423.357664233633;6427.453666438405;6444.323346048691;6449.516286278454;6465.288818229991;6194.721237544321;6280.340564240781;6358.872822543523;6387.297397286295;6442.613443193423;6422.518311126684;6426.971684530453;6435.324290949477;6447.806565803034;6472.482201423874;4893.898872753602;4895.559399654048;4896.804127834846;4912.992836468516;4918.065567542156;4204.4324016257415;4247.766372849523;4299.871003869889;4321.611055005002;4333.523312435629;5863.882722345529;5885.529157667376;5906.940930590725;5961.493273071751;5964.522838172936;6445.775302692474;6520.836979075561;6539.771108011197;6546.3453654635105;6556;5815.214945982323;5975.462208401264;6012.669303188279;6028.186194863725;6028.487578555784;5387.272718182995;5387.542058925035;5408.134698448308;5452.482014208644;5478.698671573022;6701.899471507932;6743.460523158135;6745;6745.763898263537;6746.257911629717;6419.743210271724;6454.322296158835;6516.706748196248;6535.2811190768025;6536.607803531803;6531.085648009187;6541.542092053701;6638.137042184485;6638.767643132467;6712.731490740316;6378.904316435164;6393.328700486382;6401.551891367746;6407.16706828128;6408.359164083555;6288.528360373082;6526.216853977553;6526.543141980016;6542.34576542342;6544.803655890331;6206.038064100072;6268.4671802897265;6345.777897773556;6372.649504277124;6378.2983871774995;6341.365863413622;6345.841353966003;6355.110284560073;6380.330065343072;6389.4888408926245;6232.345603711545;6350.68246587678;6356.682165891594;6356.841078972878;6358.93641063602;6124.3809352984035;6211.937880621317;6245.7189426476825;6319.8104056878365;6336.271328797063;6176.69116544162;6213.03697926822;6218.098375735583;6218.595791273553;6219.440250377488 17:19:07 INFO - PID 8157 | |1;ext.html;777.3081957058216;839.1943734015344;860.3805260212648;1151.2344291046454;1167.8131498960167;36812.263754724925;38463.80768096159;38592.228155436875;38621.22757544847;38669.226615467676;40737.79631101848;41264;41310;41313.38029929553;41335;7106.786796396116;7186.425085993121;7298.854022919539;7299.89050164248;7307.159676637175;7147.821304467404;7197.208307086216;7224.096987876515;7229.602371869545;7231.529950553224;7230.855382892339;7267.018952441432;7299.635018249093;7300.780976570712;7302.634868256592;7157.498975071747;7225.42196624274;7230.891536626955;7243.8913416299065;7258.782236532912;6742.2246441659345;6789.93210067898;6803.727850886008;6834.282400347991;6868.8322985092655;37665.246695065944;37729;37853.62146378528;37916;38020.80989595062;3473.9131521711906;3483.6690514401093;3498.6851183393615;3517.4196257617464;3521.9471707924404;29136.708632913822;29160.270993225127;29276.560851587245;29289;29306.853465732536;3693.132113953219;3708.295423869456;3714.832832522543;3725.2921944830396;3737.1965027519213;165223;168401.15799421046;170024;204811;205004;43689.56310436918;44013;44039.55960440419;44081;44166.77916610397;45302.546974530494;45388.77305613517;45665.543344566126;45702.5429745705;45803.77098114488;15328.540143795704;15390.3074361654;15590.844091559165;15591.532254032398;15592.844071559139;12487.625371238877;12542.05934554912;12620.432080556213;12621.93689031549;12638.620841374774;14430;14496.202708851115;14536.636584085483;14602.853971460361;14771.33528991198;5791.131330300489;5803.419658034163;5858.77366600689;5916.911246331309;5949.732262048218;1044.8641676582147;1063.7978784031009;1073.0717928991521;1088.7985722641338;1092.3664274720643;25156.24531264065;26130.216093517225;26714.866425667748;26763;27045;1151.3322273081592;1160.9593664221711;1179.5694571481347;1199.748052908899;1201.0331682995097;13369.866301337057;13667.17996920188;13952.86047139536;13992.440302387995;14013.299335033207;259195;259911;261262;261441;262442;54433.72783136059;54597.1810422844;54643;54924;55183.44816551863;1449.5868677426884;1499.9025063370846;1511.078242272235;1513.7805018272509;1520.361448191762;24373.878130609235;29440.263993400335;30847;31628.683713162573;31643;51932;52277.69305767386;52415;52536.21195681991;52571.474285256656;231722;232607;233689;234396;234973;36215;37429.4385584211;38124.2375152501;38298.425523616614;38399.232015358975;48523.5147648519;48780;49376.25935611041;49681.50318496914;50057.24914126218;34982.65017349896;36032.4595131068;36037.63962360343;36197;36573.63426365809;33547.83226083854;33706.325873482885;34650.82674586712;35080.298394032485;36399.63600363962;41999.370009449274;42011.579884200764;42497.15005699931;42717.35923961081;42791;35154.12114697153;35207;35447.64552354546;35848.64151358453;36057.63942360648;26525.204243872715;29211;29535.26161845971;29567.408651827274;29615.851920740257 17:19:07 INFO - PID 8157 | |2;jquery.html;490.95916656687825;502.9471905449928;505.3531479705978;507.8984203159368;517.9352580927384;20567.485812854688;21313.57372852542;21328;22065.448363790874;22950.540989180205;24124.517509649795;24546.140885069028;24638.384040399;24694;24701.505969880593;5635.464630860061;5666.801661941833;5759.68321742304;5760.0783874580075;5764.106563482667;5299.417064122943;5334.226537152111;5349.09065458871;5352.384475785276;5352.57179425645;5245.86885327866;5262.552683021948;5425.484578965012;5472.425395333493;5474.42518535552;5887.911681324784;5904.940950590482;5906.291245050578;5947.583669143161;5948.196993405878;5469.234307196995;5502.147167189092;5502.2296878437055;5512.779488820443;5529.778808847641;27879.303017424525;27892.581611275848;28363.858180709172;28609.427811443864;28764.42471150586;2192.2875065603744;2240.1487434774845;2246.4159318577126;2246.539459410817;2249.1228420915854;17716.114194290232;18188.636227275514;18191.181396837175;18198.818011819978;18228;2238.0935721033006;2247.685324054634;2265.569541787055;2313.745487996319;2313.9421514462274;131180;131985;137306;137701.3114934429;137963;14371.304343573132;14496.202708851115;14496.202708851115;14511.854881451261;14809.947633554253;21713.348599542038;21875.343739687836;21936.341909742732;21936.341909742732;21985.340439786833;9126.863097053549;9290.303227257982;9450.85823712645;9583.856242156373;9609;8960.148785865333;8963;9002.639894404281;9081.636734530544;9126.13301736334;8554.743357699279;8748.8687669685;8777.648894044294;8863.290936725047;8982.101789820965;2538.13703340865;2602.1803132013733;2615.5553555895544;2619.2404202781363;2690.4753573053067;1009.6365308488938;1029.8609687692065;1034.622362837574;1044.070777008448;1045.581767293089;20759.896200518902;23308.184213552446;26591.33521661974;26768.33079172997;27126.321841954108;1045.8692663417073;1061.3737894642197;1081.0648788797632;1089.2484185911696;1104.6962085426571;11364.147688923364;11600.76798464026;11676;11852;12182.269063856196;542157;544462;544574;544867;545750;110487;113639;116242.41878790552;117355.41322293333;119165.40417298031;1212.430157825838;1232.6548566401423;1301.5574704600292;1312.520929860613;1318.756030134428;20869.269575564784;22189.223377181723;22688.88655556712;22704.205352812573;22739.204127855446;54436;54876;54951;55339;56450.71774641101;67758.66120669365;67793;68084;68573.65713171402;69972;11684.649460515859;11833.11251656112;11918.52325906954;11954.103442241692;11961.700957476132;17881.105944702973;18809.341673041377;18823.529411764815;18950.810491895456;19165.520861978006;15602.219889005277;15756.448524301595;15757;15788.526344209693;15838.68322633564;14106.435742570182;14453.78319325232;14457.421703132177;14540.127592344494;14549.054311469721;15538.844611553739;15725.05649661024;16363.100029498491;16461.67076658436;16519.66960660756;11898.22661526998;11910.225835320676;11969.700757481132;12058;12138.393080345772;14977.176255306063;15476.767848482057;15495.767563486783;15515.84484155144;15730.292136854097 17:19:07 INFO - PID 8157 | |3;mootools.html;1393.895457840662;1449.7245523350557;1457.0237940579816;1457.8323492798331;1459.7153555056761;12806.1035727499;13370.197788132695;13421.396037178338;13462.46150153994;13687.520936767216;13390.598282051555;13583.25292108936;13584.388702508386;13624.318784060806;13638.181709097462;2405.7353691093967;2450.9387265318333;2454.410941374066;2455.8403703759286;2456.1894574790276;2360.7285162206394;2378.8929498172624;2396.6405039244164;2409.0363854458183;2413.722421921475;2384.916527921523;2398.772116648924;2405.338531903723;2410.7227668818045;2411.686480757499;2299.5056062946546;2338.497223097034;2341.1337805012167;2343.355577216262;2353.9411514712097;2240.1263507232193;2326.127702111708;2389.0563227525204;2393.270052633946;2394.8682822444757;13466.663333416645;13511.864881351257;13576.93211533946;13596.252206128658;13601.931990340085;6843.076184715099;7071.7878463646175;7087.645617719145;7127;7127.287271272831;4183.1215444756635;4244.129953359554;4267.338562522814;4293.2701440755145;4377.1683380157665;1565.3425561264296;1596.8962017468828;1606.1567676969566;1610.484644913628;1637.1977730911767;21262.681059784114;21289.574208515744;21313.999999999844;21334.679979800316;21362.679559806616;5747.3103227612955;5790.71046447676;5812.912806307909;5849.853753656193;5929.644221346733;15048.849511504744;15129.47046853355;15162.772558411632;15175.089494630358;15194.164320962233;6893.4829887758615;6925.6190909499455;6965.268646792115;6970.895436568456;7008.614526201006;6395.072714456378;6434.774782882577;6436.3241859605005;6506.674666266667;6532.771353002717;4651.5813576778255;4678.391809064799;4766.809327626856;4775.283707443842;4814.566688998007;1325.2114991579995;1360.3130419138272;1360.6938438851378;1384.5984664447399;1391.464286249801;899.4378513429107;938.0525669074284;953.9046095390405;958.6213445688913;961.6153538584482;8084.514929104273;8219.136990616018;8263.214994575506;8284.212999765012;8392.370572207108;997.2869398380047;1015.1168483419473;1020.3316827478013;1037.227265687053;1063.229158859836;5204.219367094966;5378.677279363251;5387;5545.667259964415;5639.928413601403;17800.643987120446;18563.90718046401;18594.721079183822;18925.337613183474;18930.905345473184;18336.174872130785;18534.351297704514;18710.532236693918;18716.06419679038;18746.156422961;10062.849057264148;10415.791684166274;10458.52936617854;10563;10633.840492392621;7703.383729301754;7709.113451952873;8195.344372450309;8319.292860106716;8326.25063744266;16001.199940003185;16049.919750401174;16113.710903127956;16136.354545818505;16153.596160095622;16410.425635102714;16502.092384918946;16551.75172372391;16915.746263805806;17176.22706978164;11119.888801111885;11435.428228588704;11438.370889601152;11445;11491.253068550517;12479.87520124787;12528.812067819172;12671.366431678563;12785.61643150707;12862.935685321889;10577.206709496664;10640.361578305326;10674.62638807638;10747.193960452842;11078.723031924266;10151.84772228432;10162.085412312927;10181.541830617789;10183.592656293666;10513.158947284352;9532.475713835529;9742.123208910949;9778.60885564598;9791.46146961924;9792.461414622265;6960.7215711373;6993.860122797414;7302.123745150616;7421.480496365202;7611.619419028915;6591.439727623014;6629.502787290876;6923.099997000358;6959.756408525677;7113.075300211147 17:19:07 INFO - PID 8157 | |4;prototype.html;449.63579500604493;463.77506909149065;465.62051927678937;474.2554189921822;479.1351610343329;6280.497560195185;6292;6315.747370105202;6348.904766428495;6375.872482550346;5937.792177273796;6148.200733904598;6156.476699480539;6169;6184.690765461732;4780.235162374021;4792.13741526526;4825.445073816503;4839.758012099399;4846.830360937368;4810.807567697288;4815.146168725031;4818.253170758538;4840.201366774478;4854.1990571555825;4782.83260085897;4790.688605240665;4822.228443449048;4823.927641085386;4832.782524786376;4835.903281934359;4837.879053023667;4856.830010949635;4862.6596138270515;4864.246041863516;4327.350897365421;4336.739795612273;4351.891202719926;4353.08585197109;4360.822577903979;6058.939410605882;6177.752889884399;6183.721732522047;6184.288806787232;6185.938140618581;5707.6290041147195;5756.568257380672;5768.105943578752;5776.306843178803;5783;6678.298778628223;6684.16447944007;6686.1642294713165;6696.8995465068065;6722.327767223287;4862.513748625109;4892.0949624319255;4898.191798353268;4904.681195722266;4905.533974272438;6553.213614366259;6878.449724022066;6894.655267236668;6916.515843890929;6962.721491140348;4999.500049994971;5025.949740502621;5042;5042.798288068436;5050.924236136461;5049.495050494921;5076.466970968069;5092;5096.159133742965;5096.847094587169;5525.254090697785;5714.7428365723645;5722.227499287543;5722.713864306768;5743.971280143573;6610.140681711347;6652.634105124264;6663.733450661919;6664.366885145903;6666.699998499982;1738.97391539127;1761.3923196497187;1762;1763.8500727438054;1775.7780277465317;1182.6392950150287;1225.730339325347;1237.4802582915197;1241.453760345445;1244.7883859743865;6209.6895155242055;6209.789091127277;6222.844428889314;6231.688415579203;6262.405071518198;6764.651497508765;6779.593224406552;6782.796516104426;6794.8301292467095;6859.485538584626;6143.354947730513;6172.382761723792;6185.381461853869;6195.96902015487;6205.751769929243;3567.839447224881;3583.9785661086466;3587.7667951583585;3612.8916132516065;3639.6178401268016;7064.7527336544;7087.858242835217;7093.574385536885;7097.680604372816;7103.2541583133025;6975.441964642918;7033.788986330418;7037.788866334018;7043;7063.470239732041;6948.93051069493;7028.472864535078;7137.928620713727;7147.392471639969;7155.245230586158;6792.694328755119;6801.523893327618;6829.590224586541;6832.795016149524;6858.451323894176;6059.757749661397;6606;6748.966255168692;6758.493113016445;6783.626900520321;7045.436365090883;7046.929530704832;7049.048378468841;7056.54132481387;7085.574865508086;4990.0269447457395;4998.475160108282;5002.623753716955;5009.849704508871;5027.371578552681;6662.800115996528;6828.531865648909;6832.419244364086;6856.828579285558;6866.519343645897;6613.933860661525;6653.2016158059405;6657.833554161185;6663.833404164935;6695.732170713117;6631.0716499689115;6642.701078451578;6659.367360100783;6702.262751097278;6727.697253623696;6583.374579414948;6668.566543174872;6668.633225172662;6676.532642714963;6680.899786503109;6669.6665166740495;6685.39831415175;6686.665666716742;6703.832404189934;6721.798346049626;6470.22357317125;6474.701480974187;6474.838129046811;6483.902741458976;6512.869742605216 17:19:07 INFO - PID 8157 | |5;yui.html;833.4832403909577;847.4533925617976;859.5444414460338;860.7331727164577;867.1198733285717;16818.66362672746;16914.32342706292;17034.7223958203;19088;19631.901840490777;15755.684886302268;15984.520464386058;16001.119938403383;16032.83967160328;16082.195890205501;984.1929617713478;1011.332520536446;1014.8071866345408;1016.7508960304699;1016.8017236638858;981.0679854138561;1011.8886922438526;1012.1194560732173;1012.2256473797551;1014.822406078937;1043.415687215162;1057.6615483045427;1058.5130839813694;1059.7827445373719;1059.9629012984547;1062.113135531828;1062.941538215398;1064.2284343850724;1065.7815147894662;1067.6423398161587;768.0898135709147;771.6758961236238;773.0414286285022;773.1997382708869;774.4191856107919;16787.2445739942;17116.486505404733;18172.091395430307;18284.908575457037;18494.53763655906;18086.90956545222;18322.816771832244;18530.07349632513;18609.62780744391;18648.347307844295;14746.483873064499;15386.0768353898;15405;15408;15435.768463473058;3118.1113382685826;3364.327134573071;3476.721862251014;3500.4924285978645;3506.947395789065;97095;98662.50668746683;98855;99107;100603.49698251535;14427.49503767363;14592.197429141499;14865.405383784744;15055.924720376328;15185.088894666356;27343;27857.58213626797;27921.72078279232;28210.43579128406;28290.43419131647;7696.7306144284685;7785.766427007199;7804.804879877935;7928;7987.8402431951035;3856.2865869814173;3901.1027463682944;3917.4319723639915;3923.352646813301;3946.861859834892;4712.717236965725;4763.976180119146;4794.568488836021;4815.903681926412;5066.08810414129;976.6630512473328;982.1308142293979;1000.6247657128577;1005.6982905128579;1010.8989101089833;623.7317953280133;631.255118959632;631.5863109663178;632.772202007277;662.2285037930853;12078.396080195955;12119.697007574881;12753.362331883554;13438.395272212774;13559;696.7909627111846;702.4836744992426;713.3009650542498;719.5502810743285;728.5847067171767;5930.34766175729;6192.256929168439;6221.4089661482085;6225.719842607094;6255.218097737783;113232;113987;114145.42927285476;114805.4259728696;117667.41166294114;99507;99701;100446.4977675107;101624;102327;85119.57440212759;86992.56503717441;89077.55461222652;89573.10426895648;91186;11041.447927603427;11184.161187910777;11632.418379081182;12069.336186509827;12199.451024703732;41564;42045.15909681728;42226.155476890905;42905;42962;53901;54277.45722542882;54627;54921.176182356496;56218;15891.443799466962;16169.67660646804;16206;16346.591335216239;16387.59031024234;16735.49793506197;17066.658666826843;19977.900110499355;20649.348052156092;21436;18955;19782.90108549448;19877.60244795067;19973.60052798965;20289.28987485431;16988.235529401452;18665.253389864796;18975.14611842443;19317.61364772725;19364.8063519363;17179.742303865703;17185.484435466955;17909.10454477297;18198.818011819712;18592.256309747998;12595.181313214613;12793.552225672429;13074.349220259406;13402.664933376744;13479.932600336935;12486.12597118193;13414;14281.515723614713;14866.182359969873;15092.773608395662 17:19:07 INFO - PID 8157 | __end_tp_report 17:19:07 INFO - PID 8157 | __start_cc_report 17:19:07 INFO - PID 8157 | _x_x_mozilla_cycle_collect,329 17:19:07 INFO - PID 8157 | __end_cc_report 17:19:07 INFO - PID 8157 | __startTimestamp1496967547492__endTimestamp 17:19:07 INFO - PID 8157 | 17:19:07 INFO - PID 8157 | ------- Summary: start ------- 17:19:07 INFO - PID 8157 | Number of tests: 6 17:19:07 INFO - PID 8157 | 17:19:07 INFO - PID 8157 | [#0] dojo.html Cycles:165 Average:5934.90 Median:6213.04 stddev:728.12 (11.7%) stddev-sans-first:701.57 17:19:07 INFO - PID 8157 | Values: 3350.8 3380.4 3388.3 3388.6 3397.1 5847.3 5918.1 5960.2 5987.5 6008.1 5913.5 5925.8 5964.1 6014.1 6040.8 4927.3 5179.9 5290.3 5308.7 5336.3 5333.1 5378.5 5397.6 5400.5 5407.9 5199.8 5202.1 5203.2 5311.8 5327.9 5321.6 5343.5 5350.9 5355.4 5357.0 5304.6 5323.5 5326.7 5343.0 5351.4 5728.6 5844.4 5930.3 5939.4 5976.4 6405.1 6446.1 6476.6 6480.1 6492.2 6516.5 6517.8 6528.3 6530.2 6554.1 5880.6 5943.4 5973.7 6067.3 6075.0 6525.2 6528.7 6540.4 6557.3 6566.2 6115.7 6135.0 6261.5 6268.1 6269.6 6423.4 6427.5 6444.3 6449.5 6465.3 6194.7 6280.3 6358.9 6387.3 6442.6 6422.5 6427.0 6435.3 6447.8 6472.5 4893.9 4895.6 4896.8 4913.0 4918.1 4204.4 4247.8 4299.9 4321.6 4333.5 5863.9 5885.5 5906.9 5961.5 5964.5 6445.8 6520.8 6539.8 6546.3 6556.0 5815.2 5975.5 6012.7 6028.2 6028.5 5387.3 5387.5 5408.1 5452.5 5478.7 6701.9 6743.5 6745.0 6745.8 6746.3 6419.7 6454.3 6516.7 6535.3 6536.6 6531.1 6541.5 6638.1 6638.8 6712.7 6378.9 6393.3 6401.6 6407.2 6408.4 6288.5 6526.2 6526.5 6542.3 6544.8 6206.0 6268.5 6345.8 6372.6 6378.3 6341.4 6345.8 6355.1 6380.3 6389.5 6232.3 6350.7 6356.7 6356.8 6358.9 6124.4 6211.9 6245.7 6319.8 6336.3 6176.7 6213.0 6218.1 6218.6 6219.4 17:19:07 INFO - PID 8157 | 17:19:07 INFO - PID 8157 | [#1] ext.html Cycles:180 Average:40294.03 Median:36307.32 stddev:59316.17 (163.4%) stddev-sans-first:59408.35 17:19:07 INFO - PID 8157 | Values: 777.3 839.2 860.4 1151.2 1167.8 36812.3 38463.8 38592.2 38621.2 38669.2 40737.8 41264.0 41310.0 41313.4 41335.0 7106.8 7186.4 7298.9 7299.9 7307.2 7147.8 7197.2 7224.1 7229.6 7231.5 7230.9 7267.0 7299.6 7300.8 7302.6 7157.5 7225.4 7230.9 7243.9 7258.8 6742.2 6789.9 6803.7 6834.3 6868.8 37665.2 37729.0 37853.6 37916.0 38020.8 3473.9 3483.7 3498.7 3517.4 3521.9 29136.7 29160.3 29276.6 29289.0 29306.9 3693.1 3708.3 3714.8 3725.3 3737.2 165223.0 168401.2 170024.0 204811.0 205004.0 43689.6 44013.0 44039.6 44081.0 44166.8 45302.5 45388.8 45665.5 45702.5 45803.8 15328.5 15390.3 15590.8 15591.5 15592.8 12487.6 12542.1 12620.4 12621.9 12638.6 14430.0 14496.2 14536.6 14602.9 14771.3 5791.1 5803.4 5858.8 5916.9 5949.7 1044.9 1063.8 1073.1 1088.8 1092.4 25156.2 26130.2 26714.9 26763.0 27045.0 1151.3 1161.0 1179.6 1199.7 1201.0 13369.9 13667.2 13952.9 13992.4 14013.3 259195.0 259911.0 261262.0 261441.0 262442.0 54433.7 54597.2 54643.0 54924.0 55183.4 1449.6 1499.9 1511.1 1513.8 1520.4 24373.9 29440.3 30847.0 31628.7 31643.0 51932.0 52277.7 52415.0 52536.2 52571.5 231722.0 232607.0 233689.0 234396.0 234973.0 36215.0 37429.4 38124.2 38298.4 38399.2 48523.5 48780.0 49376.3 49681.5 50057.2 34982.7 36032.5 36037.6 36197.0 36573.6 33547.8 33706.3 34650.8 35080.3 36399.6 41999.4 42011.6 42497.2 42717.4 42791.0 35154.1 35207.0 35447.6 35848.6 36057.6 26525.2 29211.0 29535.3 29567.4 29615.9 17:19:07 INFO - PID 8157 | 17:19:07 INFO - PID 8157 | [#2] jquery.html Cycles:180 Average:35470.27 Median:2246.48 stddev:91014.20 (4051.4%) stddev-sans-first:91231.62 17:19:07 INFO - PID 8157 | Values: 491.0 502.9 505.4 507.9 517.9 20567.5 21313.6 21328.0 22065.4 22950.5 24124.5 24546.1 24638.4 24694.0 24701.5 5635.5 5666.8 5759.7 5760.1 5764.1 5299.4 5334.2 5349.1 5352.4 5352.6 5245.9 5262.6 5425.5 5472.4 5474.4 5887.9 5904.9 5906.3 5947.6 5948.2 5469.2 5502.1 5502.2 5512.8 5529.8 27879.3 27892.6 28363.9 28609.4 28764.4 2192.3 2240.1 2246.4 2246.5 2249.1 17716.1 18188.6 18191.2 18198.8 18228.0 2238.1 2247.7 2265.6 2313.7 2313.9 131180.0 131985.0 137306.0 137701.3 137963.0 14371.3 14496.2 14496.2 14511.9 14809.9 21713.3 21875.3 21936.3 21936.3 21985.3 9126.9 9290.3 9450.9 9583.9 9609.0 8960.1 8963.0 9002.6 9081.6 9126.1 8554.7 8748.9 8777.6 8863.3 8982.1 2538.1 2602.2 2615.6 2619.2 2690.5 1009.6 1029.9 1034.6 1044.1 1045.6 20759.9 23308.2 26591.3 26768.3 27126.3 1045.9 1061.4 1081.1 1089.2 1104.7 11364.1 11600.8 11676.0 11852.0 12182.3 542157.0 544462.0 544574.0 544867.0 545750.0 110487.0 113639.0 116242.4 117355.4 119165.4 1212.4 1232.7 1301.6 1312.5 1318.8 20869.3 22189.2 22688.9 22704.2 22739.2 54436.0 54876.0 54951.0 55339.0 56450.7 67758.7 67793.0 68084.0 68573.7 69972.0 11684.6 11833.1 11918.5 11954.1 11961.7 17881.1 18809.3 18823.5 18950.8 19165.5 15602.2 15756.4 15757.0 15788.5 15838.7 14106.4 14453.8 14457.4 14540.1 14549.1 15538.8 15725.1 16363.1 16461.7 16519.7 11898.2 11910.2 11969.7 12058.0 12138.4 14977.2 15476.8 15495.8 15515.8 15730.3 17:19:07 INFO - PID 8157 | 17:19:07 INFO - PID 8157 | [#3] mootools.html Cycles:180 Average:8375.49 Median:2312.82 stddev:5693.93 (246.2%) stddev-sans-first:5685.73 17:19:07 INFO - PID 8157 | Values: 1393.9 1449.7 1457.0 1457.8 1459.7 12806.1 13370.2 13421.4 13462.5 13687.5 13390.6 13583.3 13584.4 13624.3 13638.2 2405.7 2450.9 2454.4 2455.8 2456.2 2360.7 2378.9 2396.6 2409.0 2413.7 2384.9 2398.8 2405.3 2410.7 2411.7 2299.5 2338.5 2341.1 2343.4 2353.9 2240.1 2326.1 2389.1 2393.3 2394.9 13466.7 13511.9 13576.9 13596.3 13601.9 6843.1 7071.8 7087.6 7127.0 7127.3 4183.1 4244.1 4267.3 4293.3 4377.2 1565.3 1596.9 1606.2 1610.5 1637.2 21262.7 21289.6 21314.0 21334.7 21362.7 5747.3 5790.7 5812.9 5849.9 5929.6 15048.8 15129.5 15162.8 15175.1 15194.2 6893.5 6925.6 6965.3 6970.9 7008.6 6395.1 6434.8 6436.3 6506.7 6532.8 4651.6 4678.4 4766.8 4775.3 4814.6 1325.2 1360.3 1360.7 1384.6 1391.5 899.4 938.1 953.9 958.6 961.6 8084.5 8219.1 8263.2 8284.2 8392.4 997.3 1015.1 1020.3 1037.2 1063.2 5204.2 5378.7 5387.0 5545.7 5639.9 17800.6 18563.9 18594.7 18925.3 18930.9 18336.2 18534.4 18710.5 18716.1 18746.2 10062.8 10415.8 10458.5 10563.0 10633.8 7703.4 7709.1 8195.3 8319.3 8326.3 16001.2 16049.9 16113.7 16136.4 16153.6 16410.4 16502.1 16551.8 16915.7 17176.2 11119.9 11435.4 11438.4 11445.0 11491.3 12479.9 12528.8 12671.4 12785.6 12862.9 10577.2 10640.4 10674.6 10747.2 11078.7 10151.8 10162.1 10181.5 10183.6 10513.2 9532.5 9742.1 9778.6 9791.5 9792.5 6960.7 6993.9 7302.1 7421.5 7611.6 6591.4 6629.5 6923.1 6959.8 7113.1 17:19:07 INFO - PID 8157 | 17:19:07 INFO - PID 8157 | [#4] prototype.html Cycles:180 Average:5605.49 Median:6207.72 stddev:1627.33 (26.2%) stddev-sans-first:1585.21 17:19:07 INFO - PID 8157 | Values: 449.6 463.8 465.6 474.3 479.1 6280.5 6292.0 6315.7 6348.9 6375.9 5937.8 6148.2 6156.5 6169.0 6184.7 4780.2 4792.1 4825.4 4839.8 4846.8 4810.8 4815.1 4818.3 4840.2 4854.2 4782.8 4790.7 4822.2 4823.9 4832.8 4835.9 4837.9 4856.8 4862.7 4864.2 4327.4 4336.7 4351.9 4353.1 4360.8 6058.9 6177.8 6183.7 6184.3 6185.9 5707.6 5756.6 5768.1 5776.3 5783.0 6678.3 6684.2 6686.2 6696.9 6722.3 4862.5 4892.1 4898.2 4904.7 4905.5 6553.2 6878.4 6894.7 6916.5 6962.7 4999.5 5025.9 5042.0 5042.8 5050.9 5049.5 5076.5 5092.0 5096.2 5096.8 5525.3 5714.7 5722.2 5722.7 5744.0 6610.1 6652.6 6663.7 6664.4 6666.7 1739.0 1761.4 1762.0 1763.9 1775.8 1182.6 1225.7 1237.5 1241.5 1244.8 6209.7 6209.8 6222.8 6231.7 6262.4 6764.7 6779.6 6782.8 6794.8 6859.5 6143.4 6172.4 6185.4 6196.0 6205.8 3567.8 3584.0 3587.8 3612.9 3639.6 7064.8 7087.9 7093.6 7097.7 7103.3 6975.4 7033.8 7037.8 7043.0 7063.5 6948.9 7028.5 7137.9 7147.4 7155.2 6792.7 6801.5 6829.6 6832.8 6858.5 6059.8 6606.0 6749.0 6758.5 6783.6 7045.4 7046.9 7049.0 7056.5 7085.6 4990.0 4998.5 5002.6 5009.8 5027.4 6662.8 6828.5 6832.4 6856.8 6866.5 6613.9 6653.2 6657.8 6663.8 6695.7 6631.1 6642.7 6659.4 6702.3 6727.7 6583.4 6668.6 6668.6 6676.5 6680.9 6669.7 6685.4 6686.7 6703.8 6721.8 6470.2 6474.7 6474.8 6483.9 6512.9 17:19:07 INFO - PID 8157 | 17:19:07 INFO - PID 8157 | [#5] yui.html Cycles:180 Average:22371.06 Median:18656.80 stddev:30210.86 (161.9%) stddev-sans-first:30252.33 17:19:07 INFO - PID 8157 | Values: 833.5 847.5 859.5 860.7 867.1 16818.7 16914.3 17034.7 19088.0 19631.9 15755.7 15984.5 16001.1 16032.8 16082.2 984.2 1011.3 1014.8 1016.8 1016.8 981.1 1011.9 1012.1 1012.2 1014.8 1043.4 1057.7 1058.5 1059.8 1060.0 1062.1 1062.9 1064.2 1065.8 1067.6 768.1 771.7 773.0 773.2 774.4 16787.2 17116.5 18172.1 18284.9 18494.5 18086.9 18322.8 18530.1 18609.6 18648.3 14746.5 15386.1 15405.0 15408.0 15435.8 3118.1 3364.3 3476.7 3500.5 3506.9 97095.0 98662.5 98855.0 99107.0 100603.5 14427.5 14592.2 14865.4 15055.9 15185.1 27343.0 27857.6 27921.7 28210.4 28290.4 7696.7 7785.8 7804.8 7928.0 7987.8 3856.3 3901.1 3917.4 3923.4 3946.9 4712.7 4764.0 4794.6 4815.9 5066.1 976.7 982.1 1000.6 1005.7 1010.9 623.7 631.3 631.6 632.8 662.2 12078.4 12119.7 12753.4 13438.4 13559.0 696.8 702.5 713.3 719.6 728.6 5930.3 6192.3 6221.4 6225.7 6255.2 113232.0 113987.0 114145.4 114805.4 117667.4 99507.0 99701.0 100446.5 101624.0 102327.0 85119.6 86992.6 89077.6 89573.1 91186.0 11041.4 11184.2 11632.4 12069.3 12199.5 41564.0 42045.2 42226.2 42905.0 42962.0 53901.0 54277.5 54627.0 54921.2 56218.0 15891.4 16169.7 16206.0 16346.6 16387.6 16735.5 17066.7 19977.9 20649.3 21436.0 18955.0 19782.9 19877.6 19973.6 20289.3 16988.2 18665.3 18975.1 19317.6 19364.8 17179.7 17185.5 17909.1 18198.8 18592.3 12595.2 12793.6 13074.3 13402.7 13479.9 12486.1 13414.0 14281.5 14866.2 15092.8 17:19:07 INFO - PID 8157 | -------- Summary: end -------- 17:19:07 INFO - PID 8157 | 17:19:08 INFO - TEST-INFO | 8157: exit 0 17:19:08 INFO - TEST-OK | dromaeo_css | took 1140823ms 17:19:08 INFO - TEST-START | kraken 17:19:08 INFO - operating with platform_type : linux_ 17:19:08 INFO - Initialising browser for kraken test... 17:19:08 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:45165/getInfo.html -profile /tmp/tmpUYNL03/profile 17:19:08 INFO - TEST-INFO | started process 8572 (/builds/slave/test/build/application/firefox/firefox http://localhost:45165/getInfo.html) 17:19:43 INFO - TEST-INFO | 8572: killed by SIGTERM 17:19:43 INFO - Browser initialized. 17:19:43 INFO - Running cycle 1/1 for kraken test... 17:19:43 INFO - TEST-INFO | started process 8781 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpUYNL03/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:19:54 INFO - PID 8781 | RSS: Main: 177291264 17:19:54 INFO - PID 8781 | 17:19:57 INFO - PID 8781 | Cycle 1(1): loaded http://localhost:45165/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:45165/tests/kraken/driver.html?testName=audio-beat-detection) 17:19:58 INFO - PID 8781 | RSS: Main: 183066624 17:19:58 INFO - PID 8781 | 17:20:00 INFO - PID 8781 | Cycle 1(1): loaded http://localhost:45165/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:45165/tests/kraken/driver.html?testName=audio-dft) 17:20:01 INFO - PID 8781 | RSS: Main: 181280768 17:20:01 INFO - PID 8781 | 17:20:04 INFO - PID 8781 | Cycle 1(1): loaded http://localhost:45165/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:45165/tests/kraken/driver.html?testName=audio-fft) 17:20:05 INFO - PID 8781 | RSS: Main: 176459776 17:20:05 INFO - PID 8781 | 17:20:07 INFO - PID 8781 | Cycle 1(1): loaded http://localhost:45165/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:45165/tests/kraken/driver.html?testName=audio-oscillator) 17:20:07 INFO - PID 8781 | RSS: Main: 177659904 17:20:07 INFO - PID 8781 | 17:20:09 INFO - PID 8781 | Cycle 1(1): loaded http://localhost:45165/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:45165/tests/kraken/driver.html?testName=imaging-gaussian-blur) 17:20:10 INFO - PID 8781 | RSS: Main: 177717248 17:20:10 INFO - PID 8781 | 17:20:13 INFO - PID 8781 | Cycle 1(1): loaded http://localhost:45165/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:45165/tests/kraken/driver.html?testName=imaging-darkroom) 17:20:14 INFO - PID 8781 | RSS: Main: 178589696 17:20:14 INFO - PID 8781 | 17:20:17 INFO - PID 8781 | Cycle 1(1): loaded http://localhost:45165/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:45165/tests/kraken/driver.html?testName=imaging-desaturate) 17:20:18 INFO - PID 8781 | RSS: Main: 179810304 17:20:18 INFO - PID 8781 | 17:20:21 INFO - PID 8781 | Cycle 1(1): loaded http://localhost:45165/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:45165/tests/kraken/driver.html?testName=json-parse-financial) 17:20:21 INFO - PID 8781 | RSS: Main: 179171328 17:20:21 INFO - PID 8781 | 17:20:23 INFO - PID 8781 | Cycle 1(1): loaded http://localhost:45165/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:45165/tests/kraken/driver.html?testName=json-stringify-tinderbox) 17:20:23 INFO - PID 8781 | RSS: Main: 178941952 17:20:23 INFO - PID 8781 | 17:20:25 INFO - PID 8781 | Cycle 1(1): loaded http://localhost:45165/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:45165/tests/kraken/driver.html?testName=stanford-crypto-aes) 17:20:26 INFO - PID 8781 | RSS: Main: 178733056 17:20:26 INFO - PID 8781 | 17:20:28 INFO - PID 8781 | Cycle 1(1): loaded http://localhost:45165/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:45165/tests/kraken/driver.html?testName=stanford-crypto-ccm) 17:20:28 INFO - PID 8781 | RSS: Main: 178814976 17:20:28 INFO - PID 8781 | 17:20:31 INFO - PID 8781 | Cycle 1(1): loaded http://localhost:45165/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:45165/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 17:20:32 INFO - PID 8781 | RSS: Main: 178589696 17:20:32 INFO - PID 8781 | 17:20:35 INFO - PID 8781 | Cycle 1(1): loaded http://localhost:45165/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:45165/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 17:20:35 INFO - PID 8781 | RSS: Main: 178868224 17:20:35 INFO - PID 8781 | 17:20:37 INFO - PID 8781 | Cycle 1(1): loaded http://localhost:45165/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:45165/tests/kraken/driver.html?testName=ai-astar) 17:20:37 INFO - PID 8781 | RSS: Main: 180830208 17:20:37 INFO - PID 8781 | 17:20:37 INFO - PID 8781 | __start_tp_report 17:20:37 INFO - PID 8781 | _x_x_mozilla_page_load 17:20:37 INFO - PID 8781 | _x_x_mozilla_page_load_details 17:20:37 INFO - PID 8781 | |i|pagename|runs| 17:20:37 INFO - PID 8781 | |0;ai-astar;107;109;100;108;109;109;108;107;117;122 17:20:37 INFO - PID 8781 | |1;audio-beat-detection;151;116;150;170;118;156;151;118;164;118 17:20:37 INFO - PID 8781 | |2;audio-dft;162;163;163;161;163;161;163;164;165;167 17:20:37 INFO - PID 8781 | |3;audio-fft;72;75;73;189;73;76;73;72;164;74 17:20:37 INFO - PID 8781 | |4;audio-oscillator;81;82;135;82;82;81;141;82;81;140 17:20:37 INFO - PID 8781 | |5;imaging-gaussian-blur;113;113;114;113;115;113;114;114;114;113 17:20:37 INFO - PID 8781 | |6;imaging-darkroom;152;150;149;148;148;150;149;148;148;149 17:20:37 INFO - PID 8781 | |7;imaging-desaturate;95;95;94;95;94;94;94;95;95;94 17:20:37 INFO - PID 8781 | |8;json-parse-financial;47;48;48;48;53;53;48;53;47;49 17:20:37 INFO - PID 8781 | |9;json-stringify-tinderbox;55;56;55;54;55;54;55;55;55;54 17:20:37 INFO - PID 8781 | |10;stanford-crypto-aes;85;85;85;85;84;85;86;82;106;83 17:20:37 INFO - PID 8781 | |11;stanford-crypto-ccm;124;123;129;124;121;120;122;122;135;124 17:20:37 INFO - PID 8781 | |12;stanford-crypto-pbkdf2;177;178;174;183;176;188;189;172;180;185 17:20:37 INFO - PID 8781 | |13;stanford-crypto-sha256-iterative;66;66;62;62;63;65;71;66;64;65 17:20:37 INFO - PID 8781 | __end_tp_report 17:20:37 INFO - PID 8781 | __start_cc_report 17:20:37 INFO - PID 8781 | _x_x_mozilla_cycle_collect,896 17:20:37 INFO - PID 8781 | __end_cc_report 17:20:37 INFO - PID 8781 | __startTimestamp1496967637673__endTimestamp 17:20:37 INFO - PID 8781 | 17:20:37 INFO - PID 8781 | ------- Summary: start ------- 17:20:37 INFO - PID 8781 | Number of tests: 14 17:20:37 INFO - PID 8781 | 17:20:37 INFO - PID 8781 | [#0] ai-astar Cycles:10 Average:109.60 Median:109.00 stddev:5.97 (5.5%) stddev-sans-first:6.25 17:20:37 INFO - PID 8781 | Values: 107.0 109.0 100.0 108.0 109.0 109.0 108.0 107.0 117.0 122.0 17:20:37 INFO - PID 8781 | 17:20:37 INFO - PID 8781 | [#1] audio-beat-detection Cycles:10 Average:141.20 Median:151.00 stddev:21.31 (14.1%) stddev-sans-first:22.31 17:20:37 INFO - PID 8781 | Values: 151.0 116.0 150.0 170.0 118.0 156.0 151.0 118.0 164.0 118.0 17:20:37 INFO - PID 8781 | 17:20:37 INFO - PID 8781 | [#2] audio-dft Cycles:10 Average:163.20 Median:163.00 stddev:1.81 (1.1%) stddev-sans-first:1.87 17:20:37 INFO - PID 8781 | Values: 162.0 163.0 163.0 161.0 163.0 161.0 163.0 164.0 165.0 167.0 17:20:37 INFO - PID 8781 | 17:20:37 INFO - PID 8781 | [#3] audio-fft Cycles:10 Average:94.10 Median:73.00 stddev:43.84 (60.1%) stddev-sans-first:45.77 17:20:37 INFO - PID 8781 | Values: 72.0 75.0 73.0 189.0 73.0 76.0 73.0 72.0 164.0 74.0 17:20:37 INFO - PID 8781 | 17:20:37 INFO - PID 8781 | [#4] audio-oscillator Cycles:10 Average:98.70 Median:81.50 stddev:27.62 (33.9%) stddev-sans-first:28.55 17:20:37 INFO - PID 8781 | Values: 81.0 82.0 135.0 82.0 82.0 81.0 141.0 82.0 81.0 140.0 17:20:37 INFO - PID 8781 | 17:20:37 INFO - PID 8781 | [#5] imaging-gaussian-blur Cycles:10 Average:113.60 Median:114.00 stddev:0.70 (0.6%) stddev-sans-first:0.71 17:20:37 INFO - PID 8781 | Values: 113.0 113.0 114.0 113.0 115.0 113.0 114.0 114.0 114.0 113.0 17:20:37 INFO - PID 8781 | 17:20:37 INFO - PID 8781 | [#6] imaging-darkroom Cycles:10 Average:149.10 Median:149.00 stddev:1.29 (0.9%) stddev-sans-first:0.83 17:20:37 INFO - PID 8781 | Values: 152.0 150.0 149.0 148.0 148.0 150.0 149.0 148.0 148.0 149.0 17:20:37 INFO - PID 8781 | 17:20:37 INFO - PID 8781 | [#7] imaging-desaturate Cycles:10 Average:94.50 Median:95.00 stddev:0.53 (0.6%) stddev-sans-first:0.53 17:20:37 INFO - PID 8781 | Values: 95.0 95.0 94.0 95.0 94.0 94.0 94.0 95.0 95.0 94.0 17:20:37 INFO - PID 8781 | 17:20:37 INFO - PID 8781 | [#8] json-parse-financial Cycles:10 Average:49.40 Median:48.50 stddev:2.55 (5.3%) stddev-sans-first:2.55 17:20:37 INFO - PID 8781 | Values: 47.0 48.0 48.0 48.0 53.0 53.0 48.0 53.0 47.0 49.0 17:20:37 INFO - PID 8781 | 17:20:37 INFO - PID 8781 | [#9] json-stringify-tinderbox Cycles:10 Average:54.80 Median:55.00 stddev:0.63 (1.1%) stddev-sans-first:0.67 17:20:37 INFO - PID 8781 | Values: 55.0 56.0 55.0 54.0 55.0 54.0 55.0 55.0 55.0 54.0 17:20:37 INFO - PID 8781 | 17:20:37 INFO - PID 8781 | [#10] stanford-crypto-aes Cycles:10 Average:86.60 Median:85.00 stddev:6.92 (8.1%) stddev-sans-first:7.31 17:20:37 INFO - PID 8781 | Values: 85.0 85.0 85.0 85.0 84.0 85.0 86.0 82.0 106.0 83.0 17:20:37 INFO - PID 8781 | 17:20:37 INFO - PID 8781 | [#11] stanford-crypto-ccm Cycles:10 Average:124.40 Median:124.00 stddev:4.45 (3.6%) stddev-sans-first:4.72 17:20:37 INFO - PID 8781 | Values: 124.0 123.0 129.0 124.0 121.0 120.0 122.0 122.0 135.0 124.0 17:20:37 INFO - PID 8781 | 17:20:37 INFO - PID 8781 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:180.20 Median:181.50 stddev:5.85 (3.2%) stddev-sans-first:6.09 17:20:37 INFO - PID 8781 | Values: 177.0 178.0 174.0 183.0 176.0 188.0 189.0 172.0 180.0 185.0 17:20:37 INFO - PID 8781 | 17:20:37 INFO - PID 8781 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.00 Median:65.50 stddev:2.62 (4.0%) stddev-sans-first:2.76 17:20:37 INFO - PID 8781 | Values: 66.0 66.0 62.0 62.0 63.0 65.0 71.0 66.0 64.0 65.0 17:20:37 INFO - PID 8781 | -------- Summary: end -------- 17:20:37 INFO - PID 8781 | 17:20:38 INFO - PID 8781 | [Parent 8781] WARNING: waitpid failed pid:8882 errno:10: file /home/worker/workspace/build/src/ipc/chromium/src/base/process_util_posix.cc, line 276 17:20:38 INFO - TEST-INFO | 8781: exit 0 17:20:38 INFO - TEST-OK | kraken | took 90472ms 17:20:38 INFO - SUITE-END | took 1231s 17:20:38 INFO - Completed test suite (00:20:31) 17:20:38 INFO - javascript benchmark 17:20:38 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8286.668838758564, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3350.8324583770805, 3380.391529524686, 3388.271521622852, 3388.6441923598013, 3397.1337308986235, 5847.298324201101, 5918.1122831575285, 5960.165576819249, 5987.461128498434, 6008.128821320911, 5913.497352725013, 5925.822225333236, 5964.105384192373, 6014.097885317205, 6040.758369665219, 4927.310176575283, 5179.870503237412, 5290.285811415458, 5308.734563271841, 5336.30628018357, 5333.066713325172, 5378.46215378461, 5397.62216644835, 5400.540954018913, 5407.864803379907, 5199.766010529497, 5202.06362854686, 5203.19350500673, 5311.840644780663, 5327.881144959563, 5321.574274058066, 5343.545798607123, 5350.892982140374, 5355.437679043684, 5357.0, 5304.602154838364, 5323.520883120537, 5326.733663316857, 5343.0, 5351.438098999627, 5728.570357223225, 5844.444777746107, 5930.258717660293, 5939.406059394069, 5976.372480889488, 6405.135306733578, 6446.097546343516, 6476.6114033158165, 6480.125183100268, 6492.188476440445, 6516.478681705452, 6517.771877984248, 6528.347165283481, 6530.216374035146, 6554.1151944487365, 5880.617759845596, 5943.375945525744, 5973.671448070398, 6067.332593414721, 6074.997625391805, 6525.151730275129, 6528.738850446024, 6540.37866402691, 6557.278699343068, 6566.24488183865, 6115.696722738819, 6135.049067394561, 6261.499080073583, 6268.122462855204, 6269.592476489013, 6423.357664233633, 6427.453666438405, 6444.323346048691, 6449.516286278454, 6465.288818229991, 6194.721237544321, 6280.340564240781, 6358.872822543523, 6387.297397286295, 6442.613443193423, 6422.518311126684, 6426.971684530453, 6435.324290949477, 6447.806565803034, 6472.482201423874, 4893.898872753602, 4895.559399654048, 4896.804127834846, 4912.992836468516, 4918.065567542156, 4204.4324016257415, 4247.766372849523, 4299.871003869889, 4321.611055005002, 4333.523312435629, 5863.882722345529, 5885.529157667376, 5906.940930590725, 5961.493273071751, 5964.522838172936, 6445.775302692474, 6520.836979075561, 6539.771108011197, 6546.3453654635105, 6556.0, 5815.214945982323, 5975.462208401264, 6012.669303188279, 6028.186194863725, 6028.487578555784, 5387.272718182995, 5387.542058925035, 5408.134698448308, 5452.482014208644, 5478.698671573022, 6701.899471507932, 6743.460523158135, 6745.0, 6745.763898263537, 6746.257911629717, 6419.743210271724, 6454.322296158835, 6516.706748196248, 6535.2811190768025, 6536.607803531803, 6531.085648009187, 6541.542092053701, 6638.137042184485, 6638.767643132467, 6712.731490740316, 6378.904316435164, 6393.328700486382, 6401.551891367746, 6407.16706828128, 6408.359164083555, 6288.528360373082, 6526.216853977553, 6526.543141980016, 6542.34576542342, 6544.803655890331, 6206.038064100072, 6268.4671802897265, 6345.777897773556, 6372.649504277124, 6378.2983871774995, 6341.365863413622, 6345.841353966003, 6355.110284560073, 6380.330065343072, 6389.4888408926245, 6232.345603711545, 6350.68246587678, 6356.682165891594, 6356.841078972878, 6358.93641063602, 6124.3809352984035, 6211.937880621317, 6245.7189426476825, 6319.8104056878365, 6336.271328797063, 6176.69116544162, 6213.03697926822, 6218.098375735583, 6218.595791273553, 6219.440250377488], "value": 5882.111971950468, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [777.3081957058216, 839.1943734015344, 860.3805260212648, 1151.2344291046454, 1167.8131498960167, 36812.263754724925, 38463.80768096159, 38592.228155436875, 38621.22757544847, 38669.226615467676, 40737.79631101848, 41264.0, 41310.0, 41313.38029929553, 41335.0, 7106.786796396116, 7186.425085993121, 7298.854022919539, 7299.89050164248, 7307.159676637175, 7147.821304467404, 7197.208307086216, 7224.096987876515, 7229.602371869545, 7231.529950553224, 7230.855382892339, 7267.018952441432, 7299.635018249093, 7300.780976570712, 7302.634868256592, 7157.498975071747, 7225.42196624274, 7230.891536626955, 7243.8913416299065, 7258.782236532912, 6742.2246441659345, 6789.93210067898, 6803.727850886008, 6834.282400347991, 6868.8322985092655, 37665.246695065944, 37729.0, 37853.62146378528, 37916.0, 38020.80989595062, 3473.9131521711906, 3483.6690514401093, 3498.6851183393615, 3517.4196257617464, 3521.9471707924404, 29136.708632913822, 29160.270993225127, 29276.560851587245, 29289.0, 29306.853465732536, 3693.132113953219, 3708.295423869456, 3714.832832522543, 3725.2921944830396, 3737.1965027519213, 165223.0, 168401.15799421046, 170024.0, 204811.0, 205004.0, 43689.56310436918, 44013.0, 44039.55960440419, 44081.0, 44166.77916610397, 45302.546974530494, 45388.77305613517, 45665.543344566126, 45702.5429745705, 45803.77098114488, 15328.540143795704, 15390.3074361654, 15590.844091559165, 15591.532254032398, 15592.844071559139, 12487.625371238877, 12542.05934554912, 12620.432080556213, 12621.93689031549, 12638.620841374774, 14430.0, 14496.202708851115, 14536.636584085483, 14602.853971460361, 14771.33528991198, 5791.131330300489, 5803.419658034163, 5858.77366600689, 5916.911246331309, 5949.732262048218, 1044.8641676582147, 1063.7978784031009, 1073.0717928991521, 1088.7985722641338, 1092.3664274720643, 25156.24531264065, 26130.216093517225, 26714.866425667748, 26763.0, 27045.0, 1151.3322273081592, 1160.9593664221711, 1179.5694571481347, 1199.748052908899, 1201.0331682995097, 13369.866301337057, 13667.17996920188, 13952.86047139536, 13992.440302387995, 14013.299335033207, 259195.0, 259911.0, 261262.0, 261441.0, 262442.0, 54433.72783136059, 54597.1810422844, 54643.0, 54924.0, 55183.44816551863, 1449.5868677426884, 1499.9025063370846, 1511.078242272235, 1513.7805018272509, 1520.361448191762, 24373.878130609235, 29440.263993400335, 30847.0, 31628.683713162573, 31643.0, 51932.0, 52277.69305767386, 52415.0, 52536.21195681991, 52571.474285256656, 231722.0, 232607.0, 233689.0, 234396.0, 234973.0, 36215.0, 37429.4385584211, 38124.2375152501, 38298.425523616614, 38399.232015358975, 48523.5147648519, 48780.0, 49376.25935611041, 49681.50318496914, 50057.24914126218, 34982.65017349896, 36032.4595131068, 36037.63962360343, 36197.0, 36573.63426365809, 33547.83226083854, 33706.325873482885, 34650.82674586712, 35080.298394032485, 36399.63600363962, 41999.370009449274, 42011.579884200764, 42497.15005699931, 42717.35923961081, 42791.0, 35154.12114697153, 35207.0, 35447.64552354546, 35848.64151358453, 36057.63942360648, 26525.204243872715, 29211.0, 29535.26161845971, 29567.408651827274, 29615.851920740257], "value": 17726.648620849337, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [490.95916656687825, 502.9471905449928, 505.3531479705978, 507.8984203159368, 517.9352580927384, 20567.485812854688, 21313.57372852542, 21328.0, 22065.448363790874, 22950.540989180205, 24124.517509649795, 24546.140885069028, 24638.384040399, 24694.0, 24701.505969880593, 5635.464630860061, 5666.801661941833, 5759.68321742304, 5760.0783874580075, 5764.106563482667, 5299.417064122943, 5334.226537152111, 5349.09065458871, 5352.384475785276, 5352.57179425645, 5245.86885327866, 5262.552683021948, 5425.484578965012, 5472.425395333493, 5474.42518535552, 5887.911681324784, 5904.940950590482, 5906.291245050578, 5947.583669143161, 5948.196993405878, 5469.234307196995, 5502.147167189092, 5502.2296878437055, 5512.779488820443, 5529.778808847641, 27879.303017424525, 27892.581611275848, 28363.858180709172, 28609.427811443864, 28764.42471150586, 2192.2875065603744, 2240.1487434774845, 2246.4159318577126, 2246.539459410817, 2249.1228420915854, 17716.114194290232, 18188.636227275514, 18191.181396837175, 18198.818011819978, 18228.0, 2238.0935721033006, 2247.685324054634, 2265.569541787055, 2313.745487996319, 2313.9421514462274, 131180.0, 131985.0, 137306.0, 137701.3114934429, 137963.0, 14371.304343573132, 14496.202708851115, 14496.202708851115, 14511.854881451261, 14809.947633554253, 21713.348599542038, 21875.343739687836, 21936.341909742732, 21936.341909742732, 21985.340439786833, 9126.863097053549, 9290.303227257982, 9450.85823712645, 9583.856242156373, 9609.0, 8960.148785865333, 8963.0, 9002.639894404281, 9081.636734530544, 9126.13301736334, 8554.743357699279, 8748.8687669685, 8777.648894044294, 8863.290936725047, 8982.101789820965, 2538.13703340865, 2602.1803132013733, 2615.5553555895544, 2619.2404202781363, 2690.4753573053067, 1009.6365308488938, 1029.8609687692065, 1034.622362837574, 1044.070777008448, 1045.581767293089, 20759.896200518902, 23308.184213552446, 26591.33521661974, 26768.33079172997, 27126.321841954108, 1045.8692663417073, 1061.3737894642197, 1081.0648788797632, 1089.2484185911696, 1104.6962085426571, 11364.147688923364, 11600.76798464026, 11676.0, 11852.0, 12182.269063856196, 542157.0, 544462.0, 544574.0, 544867.0, 545750.0, 110487.0, 113639.0, 116242.41878790552, 117355.41322293333, 119165.40417298031, 1212.430157825838, 1232.6548566401423, 1301.5574704600292, 1312.520929860613, 1318.756030134428, 20869.269575564784, 22189.223377181723, 22688.88655556712, 22704.205352812573, 22739.204127855446, 54436.0, 54876.0, 54951.0, 55339.0, 56450.71774641101, 67758.66120669365, 67793.0, 68084.0, 68573.65713171402, 69972.0, 11684.649460515859, 11833.11251656112, 11918.52325906954, 11954.103442241692, 11961.700957476132, 17881.105944702973, 18809.341673041377, 18823.529411764815, 18950.810491895456, 19165.520861978006, 15602.219889005277, 15756.448524301595, 15757.0, 15788.526344209693, 15838.68322633564, 14106.435742570182, 14453.78319325232, 14457.421703132177, 14540.127592344494, 14549.054311469721, 15538.844611553739, 15725.05649661024, 16363.100029498491, 16461.67076658436, 16519.66960660756, 11898.22661526998, 11910.225835320676, 11969.700757481132, 12058.0, 12138.393080345772, 14977.176255306063, 15476.767848482057, 15495.767563486783, 15515.84484155144, 15730.292136854097], "value": 11376.763366573365, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1393.895457840662, 1449.7245523350557, 1457.0237940579816, 1457.8323492798331, 1459.7153555056761, 12806.1035727499, 13370.197788132695, 13421.396037178338, 13462.46150153994, 13687.520936767216, 13390.598282051555, 13583.25292108936, 13584.388702508386, 13624.318784060806, 13638.181709097462, 2405.7353691093967, 2450.9387265318333, 2454.410941374066, 2455.8403703759286, 2456.1894574790276, 2360.7285162206394, 2378.8929498172624, 2396.6405039244164, 2409.0363854458183, 2413.722421921475, 2384.916527921523, 2398.772116648924, 2405.338531903723, 2410.7227668818045, 2411.686480757499, 2299.5056062946546, 2338.497223097034, 2341.1337805012167, 2343.355577216262, 2353.9411514712097, 2240.1263507232193, 2326.127702111708, 2389.0563227525204, 2393.270052633946, 2394.8682822444757, 13466.663333416645, 13511.864881351257, 13576.93211533946, 13596.252206128658, 13601.931990340085, 6843.076184715099, 7071.7878463646175, 7087.645617719145, 7127.0, 7127.287271272831, 4183.1215444756635, 4244.129953359554, 4267.338562522814, 4293.2701440755145, 4377.1683380157665, 1565.3425561264296, 1596.8962017468828, 1606.1567676969566, 1610.484644913628, 1637.1977730911767, 21262.681059784114, 21289.574208515744, 21313.999999999844, 21334.679979800316, 21362.679559806616, 5747.3103227612955, 5790.71046447676, 5812.912806307909, 5849.853753656193, 5929.644221346733, 15048.849511504744, 15129.47046853355, 15162.772558411632, 15175.089494630358, 15194.164320962233, 6893.4829887758615, 6925.6190909499455, 6965.268646792115, 6970.895436568456, 7008.614526201006, 6395.072714456378, 6434.774782882577, 6436.3241859605005, 6506.674666266667, 6532.771353002717, 4651.5813576778255, 4678.391809064799, 4766.809327626856, 4775.283707443842, 4814.566688998007, 1325.2114991579995, 1360.3130419138272, 1360.6938438851378, 1384.5984664447399, 1391.464286249801, 899.4378513429107, 938.0525669074284, 953.9046095390405, 958.6213445688913, 961.6153538584482, 8084.514929104273, 8219.136990616018, 8263.214994575506, 8284.212999765012, 8392.370572207108, 997.2869398380047, 1015.1168483419473, 1020.3316827478013, 1037.227265687053, 1063.229158859836, 5204.219367094966, 5378.677279363251, 5387.0, 5545.667259964415, 5639.928413601403, 17800.643987120446, 18563.90718046401, 18594.721079183822, 18925.337613183474, 18930.905345473184, 18336.174872130785, 18534.351297704514, 18710.532236693918, 18716.06419679038, 18746.156422961, 10062.849057264148, 10415.791684166274, 10458.52936617854, 10563.0, 10633.840492392621, 7703.383729301754, 7709.113451952873, 8195.344372450309, 8319.292860106716, 8326.25063744266, 16001.199940003185, 16049.919750401174, 16113.710903127956, 16136.354545818505, 16153.596160095622, 16410.425635102714, 16502.092384918946, 16551.75172372391, 16915.746263805806, 17176.22706978164, 11119.888801111885, 11435.428228588704, 11438.370889601152, 11445.0, 11491.253068550517, 12479.87520124787, 12528.812067819172, 12671.366431678563, 12785.61643150707, 12862.935685321889, 10577.206709496664, 10640.361578305326, 10674.62638807638, 10747.193960452842, 11078.723031924266, 10151.84772228432, 10162.085412312927, 10181.541830617789, 10183.592656293666, 10513.158947284352, 9532.475713835529, 9742.123208910949, 9778.60885564598, 9791.46146961924, 9792.461414622265, 6960.7215711373, 6993.860122797414, 7302.123745150616, 7421.480496365202, 7611.619419028915, 6591.439727623014, 6629.502787290876, 6923.099997000358, 6959.756408525677, 7113.075300211147], "value": 6099.987929966053, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [449.63579500604493, 463.77506909149065, 465.62051927678937, 474.2554189921822, 479.1351610343329, 6280.497560195185, 6292.0, 6315.747370105202, 6348.904766428495, 6375.872482550346, 5937.792177273796, 6148.200733904598, 6156.476699480539, 6169.0, 6184.690765461732, 4780.235162374021, 4792.13741526526, 4825.445073816503, 4839.758012099399, 4846.830360937368, 4810.807567697288, 4815.146168725031, 4818.253170758538, 4840.201366774478, 4854.1990571555825, 4782.83260085897, 4790.688605240665, 4822.228443449048, 4823.927641085386, 4832.782524786376, 4835.903281934359, 4837.879053023667, 4856.830010949635, 4862.6596138270515, 4864.246041863516, 4327.350897365421, 4336.739795612273, 4351.891202719926, 4353.08585197109, 4360.822577903979, 6058.939410605882, 6177.752889884399, 6183.721732522047, 6184.288806787232, 6185.938140618581, 5707.6290041147195, 5756.568257380672, 5768.105943578752, 5776.306843178803, 5783.0, 6678.298778628223, 6684.16447944007, 6686.1642294713165, 6696.8995465068065, 6722.327767223287, 4862.513748625109, 4892.0949624319255, 4898.191798353268, 4904.681195722266, 4905.533974272438, 6553.213614366259, 6878.449724022066, 6894.655267236668, 6916.515843890929, 6962.721491140348, 4999.500049994971, 5025.949740502621, 5042.0, 5042.798288068436, 5050.924236136461, 5049.495050494921, 5076.466970968069, 5092.0, 5096.159133742965, 5096.847094587169, 5525.254090697785, 5714.7428365723645, 5722.227499287543, 5722.713864306768, 5743.971280143573, 6610.140681711347, 6652.634105124264, 6663.733450661919, 6664.366885145903, 6666.699998499982, 1738.97391539127, 1761.3923196497187, 1762.0, 1763.8500727438054, 1775.7780277465317, 1182.6392950150287, 1225.730339325347, 1237.4802582915197, 1241.453760345445, 1244.7883859743865, 6209.6895155242055, 6209.789091127277, 6222.844428889314, 6231.688415579203, 6262.405071518198, 6764.651497508765, 6779.593224406552, 6782.796516104426, 6794.8301292467095, 6859.485538584626, 6143.354947730513, 6172.382761723792, 6185.381461853869, 6195.96902015487, 6205.751769929243, 3567.839447224881, 3583.9785661086466, 3587.7667951583585, 3612.8916132516065, 3639.6178401268016, 7064.7527336544, 7087.858242835217, 7093.574385536885, 7097.680604372816, 7103.2541583133025, 6975.441964642918, 7033.788986330418, 7037.788866334018, 7043.0, 7063.470239732041, 6948.93051069493, 7028.472864535078, 7137.928620713727, 7147.392471639969, 7155.245230586158, 6792.694328755119, 6801.523893327618, 6829.590224586541, 6832.795016149524, 6858.451323894176, 6059.757749661397, 6606.0, 6748.966255168692, 6758.493113016445, 6783.626900520321, 7045.436365090883, 7046.929530704832, 7049.048378468841, 7056.54132481387, 7085.574865508086, 4990.0269447457395, 4998.475160108282, 5002.623753716955, 5009.849704508871, 5027.371578552681, 6662.800115996528, 6828.531865648909, 6832.419244364086, 6856.828579285558, 6866.519343645897, 6613.933860661525, 6653.2016158059405, 6657.833554161185, 6663.833404164935, 6695.732170713117, 6631.0716499689115, 6642.701078451578, 6659.367360100783, 6702.262751097278, 6727.697253623696, 6583.374579414948, 6668.566543174872, 6668.633225172662, 6676.532642714963, 6680.899786503109, 6669.6665166740495, 6685.39831415175, 6686.665666716742, 6703.832404189934, 6721.798346049626, 6470.22357317125, 6474.701480974187, 6474.838129046811, 6483.902741458976, 6512.869742605216], "value": 5113.469217884873, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [833.4832403909577, 847.4533925617976, 859.5444414460338, 860.7331727164577, 867.1198733285717, 16818.66362672746, 16914.32342706292, 17034.7223958203, 19088.0, 19631.901840490777, 15755.684886302268, 15984.520464386058, 16001.119938403383, 16032.83967160328, 16082.195890205501, 984.1929617713478, 1011.332520536446, 1014.8071866345408, 1016.7508960304699, 1016.8017236638858, 981.0679854138561, 1011.8886922438526, 1012.1194560732173, 1012.2256473797551, 1014.822406078937, 1043.415687215162, 1057.6615483045427, 1058.5130839813694, 1059.7827445373719, 1059.9629012984547, 1062.113135531828, 1062.941538215398, 1064.2284343850724, 1065.7815147894662, 1067.6423398161587, 768.0898135709147, 771.6758961236238, 773.0414286285022, 773.1997382708869, 774.4191856107919, 16787.2445739942, 17116.486505404733, 18172.091395430307, 18284.908575457037, 18494.53763655906, 18086.90956545222, 18322.816771832244, 18530.07349632513, 18609.62780744391, 18648.347307844295, 14746.483873064499, 15386.0768353898, 15405.0, 15408.0, 15435.768463473058, 3118.1113382685826, 3364.327134573071, 3476.721862251014, 3500.4924285978645, 3506.947395789065, 97095.0, 98662.50668746683, 98855.0, 99107.0, 100603.49698251535, 14427.49503767363, 14592.197429141499, 14865.405383784744, 15055.924720376328, 15185.088894666356, 27343.0, 27857.58213626797, 27921.72078279232, 28210.43579128406, 28290.43419131647, 7696.7306144284685, 7785.766427007199, 7804.804879877935, 7928.0, 7987.8402431951035, 3856.2865869814173, 3901.1027463682944, 3917.4319723639915, 3923.352646813301, 3946.861859834892, 4712.717236965725, 4763.976180119146, 4794.568488836021, 4815.903681926412, 5066.08810414129, 976.6630512473328, 982.1308142293979, 1000.6247657128577, 1005.6982905128579, 1010.8989101089833, 623.7317953280133, 631.255118959632, 631.5863109663178, 632.772202007277, 662.2285037930853, 12078.396080195955, 12119.697007574881, 12753.362331883554, 13438.395272212774, 13559.0, 696.7909627111846, 702.4836744992426, 713.3009650542498, 719.5502810743285, 728.5847067171767, 5930.34766175729, 6192.256929168439, 6221.4089661482085, 6225.719842607094, 6255.218097737783, 113232.0, 113987.0, 114145.42927285476, 114805.4259728696, 117667.41166294114, 99507.0, 99701.0, 100446.4977675107, 101624.0, 102327.0, 85119.57440212759, 86992.56503717441, 89077.55461222652, 89573.10426895648, 91186.0, 11041.447927603427, 11184.161187910777, 11632.418379081182, 12069.336186509827, 12199.451024703732, 41564.0, 42045.15909681728, 42226.155476890905, 42905.0, 42962.0, 53901.0, 54277.45722542882, 54627.0, 54921.176182356496, 56218.0, 15891.443799466962, 16169.67660646804, 16206.0, 16346.591335216239, 16387.59031024234, 16735.49793506197, 17066.658666826843, 19977.900110499355, 20649.348052156092, 21436.0, 18955.0, 19782.90108549448, 19877.60244795067, 19973.60052798965, 20289.28987485431, 16988.235529401452, 18665.253389864796, 18975.14611842443, 19317.61364772725, 19364.8063519363, 17179.742303865703, 17185.484435466955, 17909.10454477297, 18198.818011819712, 18592.256309747998, 12595.181313214613, 12793.552225672429, 13074.349220259406, 13402.664933376744, 13479.932600336935, 12486.12597118193, 13414.0, 14281.515723614713, 14866.182359969873, 15092.773608395662], "value": 8750.418509861966, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1524.4, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [107.0, 109.0, 100.0, 108.0, 109.0, 109.0, 108.0, 107.0, 117.0, 122.0], "value": 109.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 116.0, 150.0, 170.0, 118.0, 156.0, 151.0, 118.0, 164.0, 118.0], "value": 141.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 163.0, 163.0, 161.0, 163.0, 161.0, 163.0, 164.0, 165.0, 167.0], "value": 163.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 75.0, 73.0, 189.0, 73.0, 76.0, 73.0, 72.0, 164.0, 74.0], "value": 94.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 82.0, 135.0, 82.0, 82.0, 81.0, 141.0, 82.0, 81.0, 140.0], "value": 98.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 113.0, 114.0, 113.0, 115.0, 113.0, 114.0, 114.0, 114.0, 113.0], "value": 113.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 150.0, 149.0, 148.0, 148.0, 150.0, 149.0, 148.0, 148.0, 149.0], "value": 149.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 94.0, 95.0, 94.0, 94.0, 94.0, 95.0, 95.0, 94.0], "value": 94.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [47.0, 48.0, 48.0, 48.0, 53.0, 53.0, 48.0, 53.0, 47.0, 49.0], "value": 49.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 56.0, 55.0, 54.0, 55.0, 54.0, 55.0, 55.0, 55.0, 54.0], "value": 54.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 85.0, 85.0, 85.0, 84.0, 85.0, 86.0, 82.0, 106.0, 83.0], "value": 86.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [124.0, 123.0, 129.0, 124.0, 121.0, 120.0, 122.0, 122.0, 135.0, 124.0], "value": 124.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [177.0, 178.0, 174.0, 183.0, 176.0, 188.0, 189.0, 172.0, 180.0, 185.0], "value": 180.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 66.0, 62.0, 62.0, 63.0, 65.0, 71.0, 66.0, 64.0, 65.0], "value": 65.0, "unit": "score"}]}]} 17:20:38 INFO - Return code: 0 17:20:39 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 17:20:39 INFO - # TBPL SUCCESS # 17:20:39 INFO - Running post-action listener: _resource_record_post_action 17:20:39 INFO - [mozharness: 2017-06-09 00:20:39.038213Z] Finished run-tests step (success) 17:20:39 INFO - Running post-run listener: _resource_record_post_run 17:20:39 INFO - Total resource usage - Wall time: 1248s; CPU: 13.0%; Read bytes: 4096; Write bytes: 421081088; Read time: 12; Write time: 317100 17:20:39 INFO - TinderboxPrint: CPU usage
12.6% 17:20:39 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 17:20:39 INFO - TinderboxPrint: I/O write bytes / time
421,081,088 / 317,100 17:20:39 INFO - TinderboxPrint: CPU idle
8,708.2 (87.4%) 17:20:39 INFO - TinderboxPrint: CPU user
1,199.1 (12.0%) 17:20:39 INFO - TinderboxPrint: Swap in / out
0 / 0 17:20:39 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 99373056; Read time: 0; Write time: 106436 17:20:39 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 17:20:39 INFO - run-tests - Wall time: 1232s; CPU: 13.0%; Read bytes: 0; Write bytes: 321708032; Read time: 0; Write time: 210664 17:20:39 INFO - Running post-run listener: _upload_blobber_files 17:20:39 INFO - Blob upload gear active. 17:20:39 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 17:20:39 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 17:20:39 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'] 17:20:39 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 17:20:40 INFO - (blobuploader) - INFO - Open directory for files ... 17:20:40 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 17:20:40 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:20:40 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:20:47 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 17:20:47 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:20:47 INFO - (blobuploader) - INFO - Done attempting. 17:20:47 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 17:20:47 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:20:47 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:20:48 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 17:20:48 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:20:48 INFO - (blobuploader) - INFO - Done attempting. 17:20:48 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 17:20:48 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:20:48 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:20:49 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 17:20:49 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:20:49 INFO - (blobuploader) - INFO - Done attempting. 17:20:49 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 17:20:49 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:20:49 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:20:49 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 17:20:49 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:20:49 INFO - (blobuploader) - INFO - Done attempting. 17:20:49 INFO - (blobuploader) - INFO - Iteration through files over. 17:20:49 INFO - Return code: 0 17:20:49 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 17:20:49 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 17:20:49 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bc6948d4ac994410696565285078558b634a98a8b10b27dea694e67a677d235dbb8b828b72fe09e71db0b14cd506066b1d7501675c30206a624dbfccc9b4b8e7", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8b9fdfbfc9e059244051ae4b15c2bd6bef388a974af1b938bcb0fc4ce87178fc5db85bf1a43136338268514d0945b6044fe9e5f240d26d11564f1439286cfd50", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f8825add850b9dab6c751fec9b73e63dfc5cb0364697f3b3ede250b274d11ffda0d0250a033a99fb542af717e542442443af125785df974b82e693d348a99399", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/fbb0755d1dd08ff5ec52fee80258ca7a045435c4ca9683755299a004db3489b8768294e179bdd9b715f2f7c3f69b701072621d26f17a280845f7970090525768"} 17:20:49 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 17:20:49 INFO - Writing to file /builds/slave/test/properties/blobber_files 17:20:49 INFO - Contents: 17:20:49 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bc6948d4ac994410696565285078558b634a98a8b10b27dea694e67a677d235dbb8b828b72fe09e71db0b14cd506066b1d7501675c30206a624dbfccc9b4b8e7", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8b9fdfbfc9e059244051ae4b15c2bd6bef388a974af1b938bcb0fc4ce87178fc5db85bf1a43136338268514d0945b6044fe9e5f240d26d11564f1439286cfd50", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f8825add850b9dab6c751fec9b73e63dfc5cb0364697f3b3ede250b274d11ffda0d0250a033a99fb542af717e542442443af125785df974b82e693d348a99399", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/fbb0755d1dd08ff5ec52fee80258ca7a045435c4ca9683755299a004db3489b8768294e179bdd9b715f2f7c3f69b701072621d26f17a280845f7970090525768"} 17:20:49 INFO - Running post-run listener: copy_logs_to_upload_dir 17:20:49 INFO - Copying logs to upload dir... 17:20:49 INFO - mkdir: /builds/slave/test/build/upload/logs 17:20:49 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1311.085751 ========= master_lag: 0.45 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 51 secs) (at 2017-06-08 17:20:48.891870) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-06-08 17:20:48.900546) ========= 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=8c6b6742ce8f6f39ef4ce27d000001f1-1496947179.941099-1516635857 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bc6948d4ac994410696565285078558b634a98a8b10b27dea694e67a677d235dbb8b828b72fe09e71db0b14cd506066b1d7501675c30206a624dbfccc9b4b8e7", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8b9fdfbfc9e059244051ae4b15c2bd6bef388a974af1b938bcb0fc4ce87178fc5db85bf1a43136338268514d0945b6044fe9e5f240d26d11564f1439286cfd50", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f8825add850b9dab6c751fec9b73e63dfc5cb0364697f3b3ede250b274d11ffda0d0250a033a99fb542af717e542442443af125785df974b82e693d348a99399", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/fbb0755d1dd08ff5ec52fee80258ca7a045435c4ca9683755299a004db3489b8768294e179bdd9b715f2f7c3f69b701072621d26f17a280845f7970090525768"} build_url:https://queue.taskcluster.net/v1/task/BISjsZ3uQfqYEix2o48TKA/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011195 build_url: 'https://queue.taskcluster.net/v1/task/BISjsZ3uQfqYEix2o48TKA/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bc6948d4ac994410696565285078558b634a98a8b10b27dea694e67a677d235dbb8b828b72fe09e71db0b14cd506066b1d7501675c30206a624dbfccc9b4b8e7", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8b9fdfbfc9e059244051ae4b15c2bd6bef388a974af1b938bcb0fc4ce87178fc5db85bf1a43136338268514d0945b6044fe9e5f240d26d11564f1439286cfd50", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f8825add850b9dab6c751fec9b73e63dfc5cb0364697f3b3ede250b274d11ffda0d0250a033a99fb542af717e542442443af125785df974b82e693d348a99399", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/fbb0755d1dd08ff5ec52fee80258ca7a045435c4ca9683755299a004db3489b8768294e179bdd9b715f2f7c3f69b701072621d26f17a280845f7970090525768"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-06-08 17:20:48.926026) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-06-08 17:20:48.926378) ========= 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=8c6b6742ce8f6f39ef4ce27d000001f1-1496947179.941099-1516635857 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004419 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-06-08 17:20:49.014055) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-06-08 17:20:49.014389) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-06-08 17:20:49.014725) ========= ========= Total master_lag: 0.61 =========