builder: mozilla-central_ubuntu64_hw_styloseq_test-dromaeojs-e10s slave: talos-linux64-ix-009 starttime: 1496164616.04 results: success (0) revision: ae492e1619671ca2b5f55369b70d97c7da67dd72 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-05-30 10:16:56.043384) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-05-30 10:16:56.043760) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-30 10:16:56.044021) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-30 10:16:56.149997) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-30 10:16:56.150252) ========= 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=17051fcd5208b27b50bedfeb000001dd-1496163639.7311-460824820 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-05-30 10:16:56-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 39.9M=0s 2017-05-30 10:16:56 (39.9 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.134320 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-30 10:16:56.316723) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-30 10:16:56.316997) ========= 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=17051fcd5208b27b50bedfeb000001dd-1496163639.7311-460824820 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018762 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-30 10:16:56.372587) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-05-30 10:16:56.372869) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev ae492e1619671ca2b5f55369b70d97c7da67dd72 --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 ae492e1619671ca2b5f55369b70d97c7da67dd72 --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=17051fcd5208b27b50bedfeb000001dd-1496163639.7311-460824820 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-05-30 10:16:56,912 truncating revision to first 12 chars 2017-05-30 10:16:56,912 Setting DEBUG logging. 2017-05-30 10:16:56,912 attempt 1/10 2017-05-30 10:16:56,912 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/ae492e161967?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-05-30 10:16:57,855 unpacking tar archive at: mozilla-central-ae492e161967/testing/mozharness/ program finished with exit code 0 elapsedTime=1.280325 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-05-30 10:16:57.668054) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-30 10:16:57.671378) ========= script_repo_revision: ae492e1619671ca2b5f55369b70d97c7da67dd72 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-30 10:16:57.671757) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-30 10:16:57.672012) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-30 10:16:57.688844) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 22 mins, 4 secs) (at 2017-05-30 10:16:57.689099) ========= /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=17051fcd5208b27b50bedfeb000001dd-1496163639.7311-460824820 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 10:16:58 INFO - MultiFileLogger online at 20170530 10:16:58 in /builds/slave/test 10:16:58 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 10:16:58 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 10:16:58 INFO - {'append_to_log': False, 10:16:58 INFO - 'base_work_dir': '/builds/slave/test', 10:16:58 INFO - 'blob_upload_branch': 'Firefox', 10:16:58 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 10:16:58 INFO - 'branch': 'Firefox', 10:16:58 INFO - 'buildbot_json_path': 'buildprops.json', 10:16:58 INFO - 'config_files': ('talos/linux_config.py',), 10:16:58 INFO - 'default_actions': ('clobber', 10:16:58 INFO - 'read-buildbot-config', 10:16:58 INFO - 'download-and-extract', 10:16:58 INFO - 'populate-webroot', 10:16:58 INFO - 'create-virtualenv', 10:16:58 INFO - 'install', 10:16:58 INFO - 'setup-mitmproxy', 10:16:58 INFO - 'run-tests'), 10:16:58 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 10:16:58 INFO - 'download_minidump_stackwalk': True, 10:16:58 INFO - 'download_symbols': 'ondemand', 10:16:58 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 10:16:58 INFO - 'tooltool.py': '/tools/tooltool.py', 10:16:58 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 10:16:58 INFO - '/tools/misc-python/virtualenv.py')}, 10:16:58 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 10:16:58 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 10:16:58 INFO - 'gecko_profile': False, 10:16:58 INFO - 'gecko_profile_interval': 0, 10:16:58 INFO - 'installer_path': 'installer.exe', 10:16:58 INFO - 'log_level': 'info', 10:16:58 INFO - 'log_name': 'talos', 10:16:58 INFO - 'log_to_console': True, 10:16:58 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 10:16:58 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 10:16:58 INFO - 'opt_config_files': (), 10:16:58 INFO - 'pip_index': False, 10:16:58 INFO - 'suite': 'dromaeojs-e10s', 10:16:58 INFO - 'system_bits': '32', 10:16:58 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 10:16:58 INFO - 'title': 'talos-linux64-ix-009', 10:16:58 INFO - 'tooltool_cache': '/builds/tooltool_cache', 10:16:58 INFO - 'use_talos_json': True, 10:16:58 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 10:16:58 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 10:16:58 INFO - 'work_dir': 'build'} 10:16:58 INFO - [mozharness: 2017-05-30 17:16:58.330401Z] Running clobber step. 10:16:58 INFO - Running pre-action listener: _resource_record_pre_action 10:16:58 INFO - Running main action method: clobber 10:16:58 INFO - rmtree: /builds/slave/test/build 10:16:58 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 10:16:59 INFO - Running post-action listener: _resource_record_post_action 10:16:59 INFO - [mozharness: 2017-05-30 17:16:59.358038Z] Finished clobber step (success) 10:16:59 INFO - [mozharness: 2017-05-30 17:16:59.358140Z] Running read-buildbot-config step. 10:16:59 INFO - Running pre-action listener: _resource_record_pre_action 10:16:59 INFO - Running main action method: read_buildbot_config 10:16:59 INFO - Using buildbot properties: 10:16:59 INFO - { 10:16:59 INFO - "project": "", 10:16:59 INFO - "product": "firefox", 10:16:59 INFO - "who": "ryanvm@gmail.com", 10:16:59 INFO - "installer_path": "public/build/target.tar.bz2", 10:16:59 INFO - "builddir": "mozilla-central_ubuntu64_hw_styloseq_test-dromaeojs-e10s", 10:16:59 INFO - "repository": "https://hg.mozilla.org/mozilla-central/", 10:16:59 INFO - "buildername": "Ubuntu HW 12.04 x64 stylo-sequential mozilla-central talos dromaeojs-e10s", 10:16:59 INFO - "stage_platform": "linux64-stylosequential", 10:16:59 INFO - "basedir": "/builds/slave/test", 10:16:59 INFO - "buildnumber": 33, 10:16:59 INFO - "platform": "ubuntu64_hw_styloseq", 10:16:59 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 10:16:59 INFO - "slavebuilddir": "test", 10:16:59 INFO - "taskId": "VzzGuFM3SbGMJFTDGREsNw", 10:16:59 INFO - "branch": "mozilla-central", 10:16:59 INFO - "script_repo_revision": "production", 10:16:59 INFO - "revision": "ae492e1619671ca2b5f55369b70d97c7da67dd72", 10:16:59 INFO - "slavename": "talos-linux64-ix-009", 10:16:59 INFO - "repo_path": "mozilla-central" 10:16:59 INFO - } 10:16:59 INFO - Finding installer, test and symbols from parent task. 10:16:59 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/VzzGuFM3SbGMJFTDGREsNw'}, attempt #1 10:16:59 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/VzzGuFM3SbGMJFTDGREsNw'}, attempt #1 10:17:00 INFO - Task dependencies: HBqQiDo4QyKrkFlGz4wrrQ 10:17:00 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/HBqQiDo4QyKrkFlGz4wrrQ'}, attempt #1 10:17:00 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/HBqQiDo4QyKrkFlGz4wrrQ/artifacts/public/build/target.tar.bz2 10:17:00 INFO - Set test_url: https://queue.taskcluster.net/v1/task/HBqQiDo4QyKrkFlGz4wrrQ/artifacts/public/build/test_packages.json 10:17:00 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/HBqQiDo4QyKrkFlGz4wrrQ/artifacts/public/build/target.crashreporter-symbols.zip 10:17:00 INFO - Running post-action listener: _resource_record_post_action 10:17:00 INFO - [mozharness: 2017-05-30 17:17:00.711280Z] Finished read-buildbot-config step (success) 10:17:00 INFO - [mozharness: 2017-05-30 17:17:00.711500Z] Running download-and-extract step. 10:17:00 INFO - Running pre-action listener: _resource_record_pre_action 10:17:00 INFO - Running main action method: download_and_extract 10:17:00 INFO - mkdir: /builds/slave/test/build/tests 10:17:00 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')]} 10:17:00 INFO - trying https://queue.taskcluster.net/v1/task/HBqQiDo4QyKrkFlGz4wrrQ/artifacts/public/build/target.test_packages.json 10:17:00 INFO - Downloading https://queue.taskcluster.net/v1/task/HBqQiDo4QyKrkFlGz4wrrQ/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 10:17:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/HBqQiDo4QyKrkFlGz4wrrQ/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 10:17:01 INFO - Downloaded 986 bytes. 10:17:01 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 10:17:01 INFO - Using the following test package requirements: 10:17:01 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 10:17:01 INFO - u'common': [u'target.common.tests.zip'], 10:17:01 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 10:17:01 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 10:17:01 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 10:17:01 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 10:17:01 INFO - u'mozbase': [u'target.common.tests.zip'], 10:17:01 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 10:17:01 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 10:17:01 INFO - u'web-platform': [u'target.common.tests.zip', 10:17:01 INFO - u'target.web-platform.tests.zip'], 10:17:01 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 10:17:01 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 10:17:01 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/HBqQiDo4QyKrkFlGz4wrrQ/artifacts/public/build/target.common.tests.zip 10:17:01 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/HBqQiDo4QyKrkFlGz4wrrQ/artifacts/public/build/target.common.tests.zip'}, attempt #1 10:17:01 INFO - Fetch https://queue.taskcluster.net/v1/task/HBqQiDo4QyKrkFlGz4wrrQ/artifacts/public/build/target.common.tests.zip into memory 10:17:03 INFO - Content-Length response header: 63528732 10:17:03 INFO - Bytes received: 63528732 10:17:14 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 10:17:14 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/HBqQiDo4QyKrkFlGz4wrrQ/artifacts/public/build/target.common.tests.zip 10:17:14 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/HBqQiDo4QyKrkFlGz4wrrQ/artifacts/public/build/target.common.tests.zip'}, attempt #1 10:17:14 INFO - Fetch https://queue.taskcluster.net/v1/task/HBqQiDo4QyKrkFlGz4wrrQ/artifacts/public/build/target.common.tests.zip into memory 10:17:16 INFO - Content-Length response header: 63528732 10:17:16 INFO - Bytes received: 63528732 10:17:28 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/HBqQiDo4QyKrkFlGz4wrrQ/artifacts/public/build/target.talos.tests.zip 10:17:28 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/HBqQiDo4QyKrkFlGz4wrrQ/artifacts/public/build/target.talos.tests.zip'}, attempt #1 10:17:28 INFO - Fetch https://queue.taskcluster.net/v1/task/HBqQiDo4QyKrkFlGz4wrrQ/artifacts/public/build/target.talos.tests.zip into memory 10:17:29 INFO - Content-Length response header: 14447425 10:17:29 INFO - Bytes received: 14447425 10:17: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')]} 10:17:29 INFO - trying https://queue.taskcluster.net/v1/task/HBqQiDo4QyKrkFlGz4wrrQ/artifacts/public/build/target.tar.bz2 10:17:29 INFO - Downloading https://queue.taskcluster.net/v1/task/HBqQiDo4QyKrkFlGz4wrrQ/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 10:17:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/HBqQiDo4QyKrkFlGz4wrrQ/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 10:17:31 INFO - Downloaded 55952704 bytes. 10:17:31 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/HBqQiDo4QyKrkFlGz4wrrQ/artifacts/public/build/target.tar.bz2 10:17:31 INFO - mkdir: /builds/slave/test/properties 10:17:31 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 10:17:31 INFO - Writing to file /builds/slave/test/properties/build_url 10:17:31 INFO - Contents: 10:17:31 INFO - build_url:https://queue.taskcluster.net/v1/task/HBqQiDo4QyKrkFlGz4wrrQ/artifacts/public/build/target.tar.bz2 10:17:31 INFO - Running post-action listener: _resource_record_post_action 10:17:31 INFO - Running post-action listener: set_extra_try_arguments 10:17:31 INFO - [mozharness: 2017-05-30 17:17:31.389819Z] Finished download-and-extract step (success) 10:17:31 INFO - [mozharness: 2017-05-30 17:17:31.389961Z] Running populate-webroot step. 10:17:31 INFO - Running pre-action listener: _resource_record_pre_action 10:17:31 INFO - Running main action method: populate_webroot 10:17:31 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 10:17:31 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 10:17:31 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 10:17:31 INFO - '--tppagecycles', 10:17:31 INFO - '7'], 10:17:31 INFO - 'tests': ['tsvgm']}}, 10:17:31 INFO - 'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 10:17:31 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 10:17:31 INFO - 'tests': ['dromaeo_css', 'kraken']}, 10:17:31 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 10:17:31 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 10:17:31 INFO - 'talos_options': ['--disable-e10s'], 10:17:31 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:17:31 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 10:17:31 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:17:31 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 10:17:31 INFO - 'talos_options': ['--disable-e10s'], 10:17:31 INFO - 'tests': ['damp', 'tps']}, 10:17:31 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 10:17:31 INFO - 'tests': ['damp', 'tps']}, 10:17:31 INFO - 'g3': {'talos_options': ['--disable-e10s'], 10:17:31 INFO - 'tests': ['dromaeo_dom']}, 10:17:31 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 10:17:31 INFO - 'g4': {'talos_options': ['--disable-e10s'], 10:17:31 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 10:17:31 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 10:17:31 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 10:17:31 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 10:17:31 INFO - 'other': {'talos_options': ['--disable-e10s'], 10:17:31 INFO - 'tests': ['a11yr', 10:17:31 INFO - 'ts_paint', 10:17:31 INFO - 'tpaint', 10:17:31 INFO - 'sessionrestore', 10:17:31 INFO - 'sessionrestore_no_auto_restore', 10:17:31 INFO - 'tabpaint']}, 10:17:31 INFO - 'other-e10s': {'tests': ['a11yr', 10:17:31 INFO - 'ts_paint', 10:17:31 INFO - 'tpaint', 10:17:31 INFO - 'sessionrestore', 10:17:31 INFO - 'sessionrestore_no_auto_restore', 10:17:31 INFO - 'tabpaint']}, 10:17:31 INFO - 'other-e10s_l64': {'tests': ['a11yr', 10:17:31 INFO - 'ts_paint', 10:17:31 INFO - 'tpaint', 10:17:31 INFO - 'sessionrestore', 10:17:31 INFO - 'sessionrestore_no_auto_restore', 10:17:31 INFO - 'tabpaint']}, 10:17:31 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 10:17:31 INFO - 'ts_paint', 10:17:31 INFO - 'tpaint', 10:17:31 INFO - 'sessionrestore', 10:17:31 INFO - 'sessionrestore_no_auto_restore', 10:17:31 INFO - 'tabpaint']}, 10:17:31 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 10:17:31 INFO - 'tests': ['a11yr', 10:17:31 INFO - 'ts_paint', 10:17:31 INFO - 'tpaint', 10:17:31 INFO - 'sessionrestore', 10:17:31 INFO - 'sessionrestore_no_auto_restore', 10:17:31 INFO - 'tabpaint']}, 10:17:31 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 10:17:31 INFO - 'tests': ['a11yr', 10:17:31 INFO - 'ts_paint', 10:17:31 INFO - 'tpaint', 10:17:31 INFO - 'sessionrestore', 10:17:31 INFO - 'sessionrestore_no_auto_restore', 10:17:31 INFO - 'tabpaint']}, 10:17:31 INFO - 'perf-reftest': {'tests': ['bloom_basic', 'bloom_basic_ref']}, 10:17:31 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic', 10:17:31 INFO - 'bloom_basic_ref']}, 10:17:31 INFO - 'quantum-pageload-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set.zip', 10:17:31 INFO - 'talos_options': ['--mitmproxy', 10:17:31 INFO - 'mitmproxy-recording-1.mp', 10:17:31 INFO - '--firstNonBlankPaint'], 10:17:31 INFO - 'tests': ['Quantum_1']}, 10:17:31 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 10:17:31 INFO - 'tests': ['tsvgx', 10:17:31 INFO - 'tsvgr_opacity', 10:17:31 INFO - 'tart', 10:17:31 INFO - 'tscrollx', 10:17:31 INFO - 'cart', 10:17:31 INFO - 'tsvg_static']}, 10:17:31 INFO - 'svgr-e10s': {'tests': ['tsvgx', 10:17:31 INFO - 'tsvgr_opacity', 10:17:31 INFO - 'tart', 10:17:31 INFO - 'tscrollx', 10:17:31 INFO - 'cart', 10:17:31 INFO - 'tsvg_static']}, 10:17:31 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 10:17:31 INFO - 'talos_options': ['--disable-e10s'], 10:17:31 INFO - 'tests': ['tp5o']}, 10:17:31 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 10:17:31 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 10:17:31 INFO - 'talos_options': ['--disable-e10s', 10:17:31 INFO - '--xperf_path', 10:17:31 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:17:31 INFO - 'tests': ['tp5n']}, 10:17:31 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 10:17:31 INFO - 'talos_options': ['--xperf_path', 10:17:31 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:17:31 INFO - 'tests': ['tp5n']}}, 10:17:31 INFO - 'talos.zip': {'path': '', 10:17:31 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 10:17:31 INFO - Running post-action listener: _resource_record_post_action 10:17:31 INFO - [mozharness: 2017-05-30 17:17:31.408191Z] Finished populate-webroot step (success) 10:17:31 INFO - [mozharness: 2017-05-30 17:17:31.408284Z] Running create-virtualenv step. 10:17:31 INFO - Running pre-action listener: _resource_record_pre_action 10:17:31 INFO - Running main action method: create_virtualenv 10:17:31 INFO - Creating virtualenv /builds/slave/test/build/venv 10:17: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 10:17:31 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 10:17:31 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 10:17:31 INFO - Using real prefix '/usr' 10:17:31 INFO - New python executable in /builds/slave/test/build/venv/bin/python 10:17:32 INFO - Installing distribute.............................................................................................................................................................................................done. 10:17:33 INFO - Installing pip.................done. 10:17:33 INFO - Return code: 0 10:17:33 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 10:17:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 10:17:34 INFO - Reading from file tmpfile_stdout 10:17:34 INFO - Output received: 10:17: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) 10:17:34 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 10:17: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')]} 10:17:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:17: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')]} 10:17:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:17: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 0x255b3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2735a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28d8ef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28d5e40>, '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 0x28d6fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28d7440>, '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': '17051fcd5208b27b50bedfeb000001dd-1496163639.7311-460824820', '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 10:17: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 10:17: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 10:17:34 INFO - Using env: {'DISPLAY': ':0', 10:17:34 INFO - 'HOME': '/home/cltbld', 10:17:34 INFO - 'LANG': 'en_US.UTF-8', 10:17:34 INFO - 'LANGUAGE': 'en_US:en', 10:17:34 INFO - 'LOGNAME': 'cltbld', 10:17:34 INFO - 'MAIL': '/var/mail/cltbld', 10:17:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:17:34 INFO - 'MOZ_NO_REMOTE': '1', 10:17:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:17:34 INFO - 'NO_EM_RESTART': '1', 10:17:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:17:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:17:34 INFO - 'PWD': '/builds/slave/test', 10:17:34 INFO - 'SHELL': '/bin/bash', 10:17:34 INFO - 'SHLVL': '1', 10:17:34 INFO - 'TERM': 'linux', 10:17:34 INFO - 'TMOUT': '86400', 10:17:34 INFO - 'USER': 'cltbld', 10:17:34 INFO - 'XDG_SESSION_COOKIE': '17051fcd5208b27b50bedfeb000001dd-1496163639.7311-460824820', 10:17:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:17:34 INFO - '_': '/tools/buildbot/bin/python'} 10:17:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:17: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 10:17:34 INFO - Cleaning up... 10:17:34 INFO - Return code: 0 10:17:34 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 10:17: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')]} 10:17:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:17: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')]} 10:17:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:17: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 0x255b3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2735a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28d8ef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28d5e40>, '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 0x28d6fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28d7440>, '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': '17051fcd5208b27b50bedfeb000001dd-1496163639.7311-460824820', '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 10:17: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 10:17: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 10:17:34 INFO - Using env: {'DISPLAY': ':0', 10:17:34 INFO - 'HOME': '/home/cltbld', 10:17:34 INFO - 'LANG': 'en_US.UTF-8', 10:17:34 INFO - 'LANGUAGE': 'en_US:en', 10:17:34 INFO - 'LOGNAME': 'cltbld', 10:17:34 INFO - 'MAIL': '/var/mail/cltbld', 10:17:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:17:34 INFO - 'MOZ_NO_REMOTE': '1', 10:17:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:17:34 INFO - 'NO_EM_RESTART': '1', 10:17:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:17:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:17:34 INFO - 'PWD': '/builds/slave/test', 10:17:34 INFO - 'SHELL': '/bin/bash', 10:17:34 INFO - 'SHLVL': '1', 10:17:34 INFO - 'TERM': 'linux', 10:17:34 INFO - 'TMOUT': '86400', 10:17:34 INFO - 'USER': 'cltbld', 10:17:34 INFO - 'XDG_SESSION_COOKIE': '17051fcd5208b27b50bedfeb000001dd-1496163639.7311-460824820', 10:17:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:17:34 INFO - '_': '/tools/buildbot/bin/python'} 10:17:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:17:34 INFO - Downloading/unpacking psutil>=3.1.1 10:17: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 10:17: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 10:17: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 10:17: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 10:17:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 10:17:35 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:17:35 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:17:35 INFO - Installing collected packages: psutil 10:17:35 INFO - Running setup.py install for psutil 10:17:35 INFO - building 'psutil._psutil_linux' extension 10:17: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 10:17: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_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 10:17:36 INFO - building 'psutil._psutil_posix' extension 10:17:36 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 10:17: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 10:17:36 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:17:36 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:17:36 INFO - Successfully installed psutil 10:17:36 INFO - Cleaning up... 10:17:36 INFO - Return code: 0 10:17:36 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 10:17: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')]} 10:17:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:17: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')]} 10:17:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:17: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 0x255b3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2735a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28d8ef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28d5e40>, '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 0x28d6fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28d7440>, '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': '17051fcd5208b27b50bedfeb000001dd-1496163639.7311-460824820', '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 10:17: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 10:17: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 10:17:36 INFO - Using env: {'DISPLAY': ':0', 10:17:36 INFO - 'HOME': '/home/cltbld', 10:17:36 INFO - 'LANG': 'en_US.UTF-8', 10:17:36 INFO - 'LANGUAGE': 'en_US:en', 10:17:36 INFO - 'LOGNAME': 'cltbld', 10:17:36 INFO - 'MAIL': '/var/mail/cltbld', 10:17:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:17:36 INFO - 'MOZ_NO_REMOTE': '1', 10:17:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:17:36 INFO - 'NO_EM_RESTART': '1', 10:17:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:17:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:17:36 INFO - 'PWD': '/builds/slave/test', 10:17:36 INFO - 'SHELL': '/bin/bash', 10:17:36 INFO - 'SHLVL': '1', 10:17:36 INFO - 'TERM': 'linux', 10:17:36 INFO - 'TMOUT': '86400', 10:17:36 INFO - 'USER': 'cltbld', 10:17:36 INFO - 'XDG_SESSION_COOKIE': '17051fcd5208b27b50bedfeb000001dd-1496163639.7311-460824820', 10:17:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:17:36 INFO - '_': '/tools/buildbot/bin/python'} 10:17:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:17:36 INFO - Downloading/unpacking mozsystemmonitor==0.3 10:17: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 10:17: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 10:17: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 10:17: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 10:17:37 INFO - Downloading mozsystemmonitor-0.3.tar.gz 10:17:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 10:17:37 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 10:17:37 INFO - Installing collected packages: mozsystemmonitor 10:17:37 INFO - Running setup.py install for mozsystemmonitor 10:17:37 INFO - Successfully installed mozsystemmonitor 10:17:37 INFO - Cleaning up... 10:17:37 INFO - Return code: 0 10:17:37 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 10:17: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')]} 10:17:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:17: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')]} 10:17:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:17: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 0x255b3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2735a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28d8ef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28d5e40>, '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 0x28d6fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28d7440>, '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': '17051fcd5208b27b50bedfeb000001dd-1496163639.7311-460824820', '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 10:17: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 10:17: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 10:17:37 INFO - Using env: {'DISPLAY': ':0', 10:17:37 INFO - 'HOME': '/home/cltbld', 10:17:37 INFO - 'LANG': 'en_US.UTF-8', 10:17:37 INFO - 'LANGUAGE': 'en_US:en', 10:17:37 INFO - 'LOGNAME': 'cltbld', 10:17:37 INFO - 'MAIL': '/var/mail/cltbld', 10:17:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:17:37 INFO - 'MOZ_NO_REMOTE': '1', 10:17:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:17:37 INFO - 'NO_EM_RESTART': '1', 10:17:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:17:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:17:37 INFO - 'PWD': '/builds/slave/test', 10:17:37 INFO - 'SHELL': '/bin/bash', 10:17:37 INFO - 'SHLVL': '1', 10:17:37 INFO - 'TERM': 'linux', 10:17:37 INFO - 'TMOUT': '86400', 10:17:37 INFO - 'USER': 'cltbld', 10:17:37 INFO - 'XDG_SESSION_COOKIE': '17051fcd5208b27b50bedfeb000001dd-1496163639.7311-460824820', 10:17:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:17:37 INFO - '_': '/tools/buildbot/bin/python'} 10:17:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:17:38 INFO - Downloading/unpacking jsonschema==2.5.1 10:17:38 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 10:17:38 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 10:17:38 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 10:17:38 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 10:17:39 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 10:17:39 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 10:17: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 10:17: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 10:17: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 10:17: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 10:17:39 INFO - Downloading functools32-3.2.3-2.tar.gz 10:17:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 10:17:39 INFO - warning: no files found matching '*.txt' 10:17:39 INFO - no previously-included directories found matching 'build' 10:17:39 INFO - no previously-included directories found matching 'dist' 10:17:39 INFO - no previously-included directories found matching '.git*' 10:17:39 INFO - Installing collected packages: jsonschema, functools32 10:17:39 INFO - Running setup.py install for functools32 10:17:39 INFO - warning: no files found matching '*.txt' 10:17:39 INFO - no previously-included directories found matching 'build' 10:17:39 INFO - no previously-included directories found matching 'dist' 10:17:39 INFO - no previously-included directories found matching '.git*' 10:17:39 INFO - Successfully installed jsonschema functools32 10:17:39 INFO - Cleaning up... 10:17:39 INFO - Return code: 0 10:17:39 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 10:17: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')]} 10:17:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:17: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')]} 10:17:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:17: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 0x255b3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2735a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28d8ef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28d5e40>, '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 0x28d6fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28d7440>, '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': '17051fcd5208b27b50bedfeb000001dd-1496163639.7311-460824820', '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 10:17: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 10:17: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 10:17:39 INFO - Using env: {'DISPLAY': ':0', 10:17:39 INFO - 'HOME': '/home/cltbld', 10:17:39 INFO - 'LANG': 'en_US.UTF-8', 10:17:39 INFO - 'LANGUAGE': 'en_US:en', 10:17:39 INFO - 'LOGNAME': 'cltbld', 10:17:39 INFO - 'MAIL': '/var/mail/cltbld', 10:17:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:17:39 INFO - 'MOZ_NO_REMOTE': '1', 10:17:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:17:39 INFO - 'NO_EM_RESTART': '1', 10:17:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:17:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:17:39 INFO - 'PWD': '/builds/slave/test', 10:17:39 INFO - 'SHELL': '/bin/bash', 10:17:39 INFO - 'SHLVL': '1', 10:17:39 INFO - 'TERM': 'linux', 10:17:39 INFO - 'TMOUT': '86400', 10:17:39 INFO - 'USER': 'cltbld', 10:17:39 INFO - 'XDG_SESSION_COOKIE': '17051fcd5208b27b50bedfeb000001dd-1496163639.7311-460824820', 10:17:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:17:39 INFO - '_': '/tools/buildbot/bin/python'} 10:17:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:17:39 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 10:17:39 INFO - Cleaning up... 10:17:39 INFO - Return code: 0 10:17:39 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 10:17: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')]} 10:17:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:17: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')]} 10:17:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:17: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 0x255b3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2735a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28d8ef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28d5e40>, '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 0x28d6fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28d7440>, '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': '17051fcd5208b27b50bedfeb000001dd-1496163639.7311-460824820', '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 10:17: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 10:17: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 10:17:39 INFO - Using env: {'DISPLAY': ':0', 10:17:39 INFO - 'HOME': '/home/cltbld', 10:17:39 INFO - 'LANG': 'en_US.UTF-8', 10:17:39 INFO - 'LANGUAGE': 'en_US:en', 10:17:39 INFO - 'LOGNAME': 'cltbld', 10:17:39 INFO - 'MAIL': '/var/mail/cltbld', 10:17:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:17:39 INFO - 'MOZ_NO_REMOTE': '1', 10:17:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:17:39 INFO - 'NO_EM_RESTART': '1', 10:17:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:17:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:17:39 INFO - 'PWD': '/builds/slave/test', 10:17:39 INFO - 'SHELL': '/bin/bash', 10:17:39 INFO - 'SHLVL': '1', 10:17:39 INFO - 'TERM': 'linux', 10:17:39 INFO - 'TMOUT': '86400', 10:17:39 INFO - 'USER': 'cltbld', 10:17:39 INFO - 'XDG_SESSION_COOKIE': '17051fcd5208b27b50bedfeb000001dd-1496163639.7311-460824820', 10:17:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:17:39 INFO - '_': '/tools/buildbot/bin/python'} 10:17:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:17:39 INFO - Downloading/unpacking blobuploader==1.2.4 10:17: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 10:17: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 10:17: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 10:17: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 10:17:41 INFO - Downloading blobuploader-1.2.4.tar.gz 10:17:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 10:17:41 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 10:17: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 10:17: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 10:17: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 10:17: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 10:17:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 10:17:41 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 10:17: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 10:17: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 10:17: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 10:17: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 10:17:41 INFO - Downloading docopt-0.6.1.tar.gz 10:17:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 10:17:41 INFO - Installing collected packages: blobuploader, requests, docopt 10:17:41 INFO - Running setup.py install for blobuploader 10:17:41 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 10:17:41 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 10:17:41 INFO - Running setup.py install for requests 10:17:42 INFO - Running setup.py install for docopt 10:17:42 INFO - Successfully installed blobuploader requests docopt 10:17:42 INFO - Cleaning up... 10:17:42 INFO - Return code: 0 10:17:42 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:17: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')]} 10:17:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:17: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')]} 10:17:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:17: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 0x255b3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2735a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28d8ef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28d5e40>, '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 0x28d6fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28d7440>, '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': '17051fcd5208b27b50bedfeb000001dd-1496163639.7311-460824820', '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 10:17: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 10:17: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 10:17:42 INFO - Using env: {'DISPLAY': ':0', 10:17:42 INFO - 'HOME': '/home/cltbld', 10:17:42 INFO - 'LANG': 'en_US.UTF-8', 10:17:42 INFO - 'LANGUAGE': 'en_US:en', 10:17:42 INFO - 'LOGNAME': 'cltbld', 10:17:42 INFO - 'MAIL': '/var/mail/cltbld', 10:17:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:17:42 INFO - 'MOZ_NO_REMOTE': '1', 10:17:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:17:42 INFO - 'NO_EM_RESTART': '1', 10:17:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:17:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:17:42 INFO - 'PWD': '/builds/slave/test', 10:17:42 INFO - 'SHELL': '/bin/bash', 10:17:42 INFO - 'SHLVL': '1', 10:17:42 INFO - 'TERM': 'linux', 10:17:42 INFO - 'TMOUT': '86400', 10:17:42 INFO - 'USER': 'cltbld', 10:17:42 INFO - 'XDG_SESSION_COOKIE': '17051fcd5208b27b50bedfeb000001dd-1496163639.7311-460824820', 10:17:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:17:42 INFO - '_': '/tools/buildbot/bin/python'} 10:17:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:17:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:17:42 INFO - Running setup.py (path:/tmp/pip-1fbhrQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:17:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:17:42 INFO - Running setup.py (path:/tmp/pip-c2isvA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:17:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:17:42 INFO - Running setup.py (path:/tmp/pip-ZzBwvz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:17:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:17:42 INFO - Running setup.py (path:/tmp/pip-1bG3hQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:17:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:17:42 INFO - Running setup.py (path:/tmp/pip-j6JWO7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:17:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:17:42 INFO - Running setup.py (path:/tmp/pip-942SUi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:17:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:17:42 INFO - Running setup.py (path:/tmp/pip-mUDbCt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:17:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:17:42 INFO - Running setup.py (path:/tmp/pip-VsM_KF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:17:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:17:43 INFO - Running setup.py (path:/tmp/pip-dtAZvs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:17:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:17:43 INFO - Running setup.py (path:/tmp/pip-JE7yHu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:17:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:17:43 INFO - Running setup.py (path:/tmp/pip-iLG383-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:17:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:17:43 INFO - Running setup.py (path:/tmp/pip-5eGMQZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:17:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:17:43 INFO - Running setup.py (path:/tmp/pip-MEveQh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:17:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:17:43 INFO - Running setup.py (path:/tmp/pip-n6vxmA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:17:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:17:43 INFO - Running setup.py (path:/tmp/pip-JYM5Oe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:17:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:17:43 INFO - Running setup.py (path:/tmp/pip-mBqj_B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:17:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:17:43 INFO - Running setup.py (path:/tmp/pip-LWUsgo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:17:43 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 10:17:43 INFO - Running setup.py install for manifestparser 10:17:43 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 10:17:43 INFO - Running setup.py install for mozcrash 10:17:43 INFO - Running setup.py install for mozdebug 10:17:43 INFO - Running setup.py install for mozdevice 10:17:44 INFO - Installing dm script to /builds/slave/test/build/venv/bin 10:17:44 INFO - Running setup.py install for mozfile 10:17:44 INFO - Running setup.py install for mozhttpd 10:17:44 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 10:17:44 INFO - Running setup.py install for mozinfo 10:17:44 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 10:17:44 INFO - Running setup.py install for mozInstall 10:17:44 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 10:17:44 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 10:17:44 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 10:17:44 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 10:17:44 INFO - Running setup.py install for mozleak 10:17:44 INFO - Running setup.py install for mozlog 10:17:44 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 10:17:44 INFO - Running setup.py install for moznetwork 10:17:44 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 10:17:44 INFO - Running setup.py install for mozprocess 10:17:44 INFO - Running setup.py install for mozprofile 10:17:44 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 10:17:44 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 10:17:44 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 10:17:45 INFO - Running setup.py install for mozrunner 10:17:45 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 10:17:45 INFO - Running setup.py install for mozscreenshot 10:17:45 INFO - Running setup.py install for moztest 10:17:45 INFO - Running setup.py install for mozversion 10:17:45 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 10:17:45 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 10:17:45 INFO - Cleaning up... 10:17:45 INFO - Return code: 0 10:17:45 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:17: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')]} 10:17:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:17: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')]} 10:17:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:17: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 0x255b3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2735a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28d8ef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28d5e40>, '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 0x28d6fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28d7440>, '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': '17051fcd5208b27b50bedfeb000001dd-1496163639.7311-460824820', '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 10:17: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 10:17: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 10:17:45 INFO - Using env: {'DISPLAY': ':0', 10:17:45 INFO - 'HOME': '/home/cltbld', 10:17:45 INFO - 'LANG': 'en_US.UTF-8', 10:17:45 INFO - 'LANGUAGE': 'en_US:en', 10:17:45 INFO - 'LOGNAME': 'cltbld', 10:17:45 INFO - 'MAIL': '/var/mail/cltbld', 10:17:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:17:45 INFO - 'MOZ_NO_REMOTE': '1', 10:17:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:17:45 INFO - 'NO_EM_RESTART': '1', 10:17:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:17:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:17:45 INFO - 'PWD': '/builds/slave/test', 10:17:45 INFO - 'SHELL': '/bin/bash', 10:17:45 INFO - 'SHLVL': '1', 10:17:45 INFO - 'TERM': 'linux', 10:17:45 INFO - 'TMOUT': '86400', 10:17:45 INFO - 'USER': 'cltbld', 10:17:45 INFO - 'XDG_SESSION_COOKIE': '17051fcd5208b27b50bedfeb000001dd-1496163639.7311-460824820', 10:17:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:17:45 INFO - '_': '/tools/buildbot/bin/python'} 10:17:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:17:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:17:45 INFO - Running setup.py (path:/tmp/pip-sCVFfe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:17: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)) 10:17:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:17:45 INFO - Running setup.py (path:/tmp/pip-jxHQ5c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:17: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)) 10:17:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:17:45 INFO - Running setup.py (path:/tmp/pip-ujhDRW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:17: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)) 10:17:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:17:45 INFO - Running setup.py (path:/tmp/pip-tDmm_T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:17: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)) 10:17:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:17:45 INFO - Running setup.py (path:/tmp/pip-2gQUmS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:17:46 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)) 10:17:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:17:46 INFO - Running setup.py (path:/tmp/pip-6VuWVD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:17:46 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)) 10:17:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:17:46 INFO - Running setup.py (path:/tmp/pip-3tEW6b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:17:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 10:17:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:17:46 INFO - Running setup.py (path:/tmp/pip-bmJvXt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:17: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)) 10:17:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:17:46 INFO - Running setup.py (path:/tmp/pip-lm_9oK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:17: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)) 10:17:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:17:46 INFO - Running setup.py (path:/tmp/pip-aHM8IM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:17: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)) 10:17:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:17:46 INFO - Running setup.py (path:/tmp/pip-U1EogB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:17: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)) 10:17:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:17:46 INFO - Running setup.py (path:/tmp/pip-U6lJTn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:17: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)) 10:17:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:17:46 INFO - Running setup.py (path:/tmp/pip-IkD29O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:17: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)) 10:17:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:17:46 INFO - Running setup.py (path:/tmp/pip-TNl7aL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:17: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)) 10:17:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:17:46 INFO - Running setup.py (path:/tmp/pip-ZmuCE2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:17: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)) 10:17:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:17:46 INFO - Running setup.py (path:/tmp/pip-PRJEEP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:17: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)) 10:17:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:17:46 INFO - Running setup.py (path:/tmp/pip-D7AThF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:17: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)) 10:17: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)) 10:17: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)) 10:17: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)) 10:17: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)) 10:17: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)) 10:17:46 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 10:17: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 10:17: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 10:17: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 10:17: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 10:17:48 INFO - Downloading blessings-1.6.tar.gz 10:17:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 10:17:48 INFO - Installing collected packages: blessings 10:17:48 INFO - Running setup.py install for blessings 10:17:48 INFO - Successfully installed blessings 10:17:48 INFO - Cleaning up... 10:17:48 INFO - Return code: 0 10:17:48 INFO - Done creating virtualenv /builds/slave/test/build/venv. 10:17:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:17:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:17:48 INFO - Reading from file tmpfile_stdout 10:17:48 INFO - Current package versions: 10:17:48 INFO - argparse == 1.2.1 10:17:48 INFO - blessings == 1.6 10:17:48 INFO - blobuploader == 1.2.4 10:17:48 INFO - docopt == 0.6.1 10:17:48 INFO - functools32 == 3.2.3-2 10:17:48 INFO - jsonschema == 2.5.1 10:17:48 INFO - manifestparser == 1.1 10:17:48 INFO - mozInstall == 1.12 10:17:48 INFO - mozcrash == 1.0 10:17:48 INFO - mozdebug == 0.1 10:17:48 INFO - mozdevice == 0.51 10:17:48 INFO - mozfile == 1.2 10:17:48 INFO - mozhttpd == 0.7 10:17:48 INFO - mozinfo == 0.9 10:17:48 INFO - mozleak == 0.1 10:17:48 INFO - mozlog == 3.4 10:17:48 INFO - moznetwork == 0.27 10:17:48 INFO - mozprocess == 0.25 10:17:48 INFO - mozprofile == 0.28 10:17:48 INFO - mozrunner == 6.13 10:17:48 INFO - mozscreenshot == 0.1 10:17:48 INFO - mozsystemmonitor == 0.3 10:17:48 INFO - moztest == 0.8 10:17:48 INFO - mozversion == 1.4 10:17:48 INFO - psutil == 3.1.1 10:17:48 INFO - requests == 1.2.3 10:17:48 INFO - wsgiref == 0.1.2 10:17:48 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:17: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')]} 10:17:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:17: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')]} 10:17:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:17: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 0x255b3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2735a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28d8ef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28d5e40>, '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 0x28d6fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28d7440>, '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': '17051fcd5208b27b50bedfeb000001dd-1496163639.7311-460824820', '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 10:17: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 10:17: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 10:17:48 INFO - Using env: {'DISPLAY': ':0', 10:17:48 INFO - 'HOME': '/home/cltbld', 10:17:48 INFO - 'LANG': 'en_US.UTF-8', 10:17:48 INFO - 'LANGUAGE': 'en_US:en', 10:17:48 INFO - 'LOGNAME': 'cltbld', 10:17:48 INFO - 'MAIL': '/var/mail/cltbld', 10:17:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:17:48 INFO - 'MOZ_NO_REMOTE': '1', 10:17:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:17:48 INFO - 'NO_EM_RESTART': '1', 10:17:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:17:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:17:48 INFO - 'PWD': '/builds/slave/test', 10:17:48 INFO - 'SHELL': '/bin/bash', 10:17:48 INFO - 'SHLVL': '1', 10:17:48 INFO - 'TERM': 'linux', 10:17:48 INFO - 'TMOUT': '86400', 10:17:48 INFO - 'USER': 'cltbld', 10:17:48 INFO - 'XDG_SESSION_COOKIE': '17051fcd5208b27b50bedfeb000001dd-1496163639.7311-460824820', 10:17:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:17:48 INFO - '_': '/tools/buildbot/bin/python'} 10:17:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:17: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)) 10:17: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)) 10:17: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)) 10:17: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)) 10:17: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)) 10:17: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)) 10:17: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)) 10:17: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)) 10:17: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)) 10:17:48 INFO - Downloading/unpacking marionette-driver>=1.4.0 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 10:17: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 10:17: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 10:17: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 10:17: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 10:17:49 INFO - Downloading marionette_driver-1.4.0.tar.gz 10:17:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/marionette-driver/setup.py) egg_info for package marionette-driver 10:17: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)) 10:17: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)) 10:17: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)) 10:17: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)) 10:17:49 INFO - Installing collected packages: marionette-driver 10:17:49 INFO - Running setup.py install for marionette-driver 10:17:49 INFO - Successfully installed marionette-driver 10:17:49 INFO - Cleaning up... 10:17:50 INFO - Return code: 0 10:17:50 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 10:17:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:17:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:17:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:17:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:17:50 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x255b3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2735a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28d8ef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28d5e40>, '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 0x28d6fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28d7440>, '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': '17051fcd5208b27b50bedfeb000001dd-1496163639.7311-460824820', '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 10:17:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 10:17:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 10:17:50 INFO - Using env: {'DISPLAY': ':0', 10:17:50 INFO - 'HOME': '/home/cltbld', 10:17:50 INFO - 'LANG': 'en_US.UTF-8', 10:17:50 INFO - 'LANGUAGE': 'en_US:en', 10:17:50 INFO - 'LOGNAME': 'cltbld', 10:17:50 INFO - 'MAIL': '/var/mail/cltbld', 10:17:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:17:50 INFO - 'MOZ_NO_REMOTE': '1', 10:17:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:17:50 INFO - 'NO_EM_RESTART': '1', 10:17:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:17:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:17:50 INFO - 'PWD': '/builds/slave/test', 10:17:50 INFO - 'SHELL': '/bin/bash', 10:17:50 INFO - 'SHLVL': '1', 10:17:50 INFO - 'TERM': 'linux', 10:17:50 INFO - 'TMOUT': '86400', 10:17:50 INFO - 'USER': 'cltbld', 10:17:50 INFO - 'XDG_SESSION_COOKIE': '17051fcd5208b27b50bedfeb000001dd-1496163639.7311-460824820', 10:17:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:17:50 INFO - '_': '/tools/buildbot/bin/python'} 10:17:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:17:50 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 10:17:50 INFO - Cleaning up... 10:17:50 INFO - Return code: 0 10:17:50 INFO - Running post-action listener: _resource_record_post_action 10:17:50 INFO - Running post-action listener: _start_resource_monitoring 10:17:50 INFO - Starting resource monitoring. 10:17:50 INFO - [mozharness: 2017-05-30 17:17:50.268431Z] Finished create-virtualenv step (success) 10:17:50 INFO - [mozharness: 2017-05-30 17:17:50.269123Z] Running install step. 10:17:50 INFO - Running pre-action listener: _resource_record_pre_action 10:17:50 INFO - Running main action method: install 10:17:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:17:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:17:50 INFO - Reading from file tmpfile_stdout 10:17:50 INFO - Detecting whether we're running mozinstall >=1.0... 10:17:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 10:17:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 10:17:50 INFO - Reading from file tmpfile_stdout 10:17:50 INFO - Output received: 10:17:50 INFO - Usage: mozinstall [options] installer 10:17:50 INFO - Options: 10:17:50 INFO - -h, --help show this help message and exit 10:17:50 INFO - -d DEST, --destination=DEST 10:17:50 INFO - Directory to install application into. [default: 10:17:50 INFO - "/builds/slave/test"] 10:17:50 INFO - --app=APP Application being installed. [default: firefox] 10:17:50 INFO - mkdir: /builds/slave/test/build/application 10:17: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'] 10:17:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 10:18:06 INFO - Reading from file tmpfile_stdout 10:18:06 INFO - Output received: 10:18:06 INFO - /builds/slave/test/build/application/firefox/firefox 10:18:06 INFO - Running post-action listener: _resource_record_post_action 10:18:06 INFO - [mozharness: 2017-05-30 17:18:06.769582Z] Finished install step (success) 10:18:06 INFO - [mozharness: 2017-05-30 17:18:06.769927Z] Running setup-mitmproxy step. 10:18:06 INFO - Running pre-action listener: _resource_record_pre_action 10:18:06 INFO - Running main action method: setup_mitmproxy 10:18:06 INFO - Skipping: mitmproxy is not required 10:18:06 INFO - Running post-action listener: _resource_record_post_action 10:18:06 INFO - [mozharness: 2017-05-30 17:18:06.771547Z] Finished setup-mitmproxy step (success) 10:18:06 INFO - [mozharness: 2017-05-30 17:18:06.771858Z] Running run-tests step. 10:18:06 INFO - Running pre-action listener: _resource_record_pre_action 10:18:06 INFO - Running main action method: run_tests 10:18:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 10:18:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 10:18:06 INFO - Python 2.7.3 10:18:06 INFO - Return code: 0 10:18:06 INFO - grabbing minidump binary from tooltool 10:18:06 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')]} 10:18:06 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 0x28d5e40>, '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 0x28d6fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28d7440>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 10:18:06 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 10:18:06 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 10:18:06 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 10:18:06 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 10:18:06 INFO - Return code: 0 10:18:06 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 10:18:06 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 10:18:06 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 10:18:06 INFO - ENV: RUST_BACKTRACE is now 1 10:18:06 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 10:18:06 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 10:18:06 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/HBqQiDo4QyKrkFlGz4wrrQ/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-009', '--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 10:18:06 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/HBqQiDo4QyKrkFlGz4wrrQ/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-009 --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 10:18:06 INFO - Using env: {'DISPLAY': ':0', 10:18:06 INFO - 'HOME': '/home/cltbld', 10:18:06 INFO - 'LANG': 'en_US.UTF-8', 10:18:06 INFO - 'LANGUAGE': 'en_US:en', 10:18:06 INFO - 'LOGNAME': 'cltbld', 10:18:06 INFO - 'MAIL': '/var/mail/cltbld', 10:18:06 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 10:18:06 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 10:18:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:18:06 INFO - 'MOZ_NO_REMOTE': '1', 10:18:06 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 10:18:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:18:06 INFO - 'NO_EM_RESTART': '1', 10:18:06 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:18:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:18:06 INFO - 'PWD': '/builds/slave/test', 10:18:06 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 10:18:06 INFO - 'RUST_BACKTRACE': '1', 10:18:06 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 10:18:06 INFO - 'SHELL': '/bin/bash', 10:18:06 INFO - 'SHLVL': '1', 10:18:06 INFO - 'TERM': 'linux', 10:18:06 INFO - 'TMOUT': '86400', 10:18:06 INFO - 'USER': 'cltbld', 10:18:06 INFO - 'XDG_SESSION_COOKIE': '17051fcd5208b27b50bedfeb000001dd-1496163639.7311-460824820', 10:18:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:18:06 INFO - '_': '/tools/buildbot/bin/python'} 10:18:06 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/HBqQiDo4QyKrkFlGz4wrrQ/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-009', '--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 10:18:07 INFO - mozversion application_buildid: 20170530163814 10:18:07 INFO - mozversion application_changeset: ae492e1619671ca2b5f55369b70d97c7da67dd72 10:18:07 INFO - mozversion application_display_name: Nightly 10:18:07 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 10:18:07 INFO - mozversion application_name: Firefox 10:18:07 INFO - mozversion application_remotingname: firefox 10:18:07 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 10:18:07 INFO - mozversion application_vendor: Mozilla 10:18:07 INFO - mozversion application_version: 55.0a1 10:18:07 INFO - mozversion platform_buildid: 20170530163814 10:18:07 INFO - mozversion platform_changeset: ae492e1619671ca2b5f55369b70d97c7da67dd72 10:18:07 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 10:18:07 INFO - mozversion platform_version: 55.0a1 10:18:07 INFO - using testdate: 1496164687 10:18:07 INFO - actual date: 1496164687 10:18:07 INFO - starting webserver on 'localhost:44434' 10:18:07 INFO - SUITE-START | Running 2 tests 10:18:07 INFO - TEST-START | dromaeo_css 10:18:07 INFO - operating with platform_type : linux_ 10:18:07 INFO - Initialising browser for dromaeo_css test... 10:18:07 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:44434/getInfo.html -profile /tmp/tmpukhgy5/profile 10:18:07 INFO - TEST-INFO | started process 27631 (/builds/slave/test/build/application/firefox/firefox http://localhost:44434/getInfo.html) 10:18:41 INFO - TEST-INFO | 27631: killed by SIGTERM 10:18:42 INFO - Browser initialized. 10:18:42 INFO - Running cycle 1/1 for dromaeo_css test... 10:18:42 INFO - TEST-INFO | started process 27852 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpukhgy5/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:18:54 INFO - PID 27852 | RSS: Main: 186138624 10:18:54 INFO - PID 27852 | 10:22:00 INFO - PID 27852 | Cycle 1(1): loaded http://localhost:44434/tests/dromaeo/cssquery-dojo.html (next: http://localhost:44434/tests/dromaeo/cssquery-ext.html) 10:22:01 INFO - PID 27852 | RSS: Main: 183816192 10:22:01 INFO - PID 27852 | 10:25:03 INFO - PID 27852 | Cycle 1(1): loaded http://localhost:44434/tests/dromaeo/cssquery-ext.html (next: http://localhost:44434/tests/dromaeo/cssquery-jquery.html) 10:25:04 INFO - PID 27852 | RSS: Main: 187678720 10:25:04 INFO - PID 27852 | 10:28:06 INFO - PID 27852 | Cycle 1(1): loaded http://localhost:44434/tests/dromaeo/cssquery-jquery.html (next: http://localhost:44434/tests/dromaeo/cssquery-mootools.html) 10:28:07 INFO - PID 27852 | RSS: Main: 185024512 10:28:07 INFO - PID 27852 | 10:31:08 INFO - PID 27852 | Cycle 1(1): loaded http://localhost:44434/tests/dromaeo/cssquery-mootools.html (next: http://localhost:44434/tests/dromaeo/cssquery-prototype.html) 10:31:09 INFO - PID 27852 | RSS: Main: 188964864 10:31:09 INFO - PID 27852 | 10:34:12 INFO - PID 27852 | Cycle 1(1): loaded http://localhost:44434/tests/dromaeo/cssquery-prototype.html (next: http://localhost:44434/tests/dromaeo/cssquery-yui.html) 10:34:13 INFO - PID 27852 | RSS: Main: 187715584 10:34:13 INFO - PID 27852 | 10:37:15 INFO - PID 27852 | Cycle 1(1): loaded http://localhost:44434/tests/dromaeo/cssquery-yui.html (next: http://localhost:44434/tests/dromaeo/cssquery-dojo.html) 10:37:15 INFO - PID 27852 | RSS: Main: 184987648 10:37:15 INFO - PID 27852 | 10:37:15 INFO - PID 27852 | __start_tp_report 10:37:15 INFO - PID 27852 | _x_x_mozilla_page_load 10:37:15 INFO - PID 27852 | _x_x_mozilla_page_load_details 10:37:15 INFO - PID 27852 | |i|pagename|runs| 10:37:15 INFO - PID 27852 | |0;dojo.html;2732.0847516082113;2736.0697362896613;2758.6275852759873;2785.874635641396;2788.3308006078532;5239.240310155025;5241.161414173733;5324.680519168848;5341.786328546854;5360.892782144359;5321.36143662761;5324.733763311839;5327.520523152915;5405.675659460435;5415.864603384917;4684.906301873969;4711.835085771999;4753.572178503934;4777.18787806072;4784.808607655689;4600.792964316597;4755.809767609308;4784.40194975628;4821.566059054684;4828.589569886564;4654.138984287883;4769.809207631691;4778.187708089598;4823.155947709154;4877.02459508098;4711.081339138869;4714.269288260325;4722.83470078549;4761.023990082025;4808.567228949411;4692.8122875084955;4714.740689262089;4720.622350211975;4739.099571081483;4758.809647614091;5318.7074710891275;5322.600804939645;5341.679499230058;5347.4919882611475;5348.973255133738;5667.0366037773265;5690.089585666274;5748.051571490699;5749.798757043525;5767.826965191051;5826.854328641775;5828.737706803204;5834.387389324144;5854.97072514639;5881.3530511643685;5370.248165256867;5372.91940620891;5393.83818485446;5396.4873337033705;5396.9730151348995;5770.16332631766;5880.705964701748;5914.142449344821;5969.73136208863;5970.671613061323;5738.2540269765495;5743;5744.827655170351;5746.655200687972;5783.826485205366;5796.739146738407;5808.925348810483;5810.564207684441;5810.983077961424;5838.38696936824;5569.498745112959;5784.1034639630925;5801.767929282866;5809.099589563624;5813.6221145625395;5686.431356864363;5697.344805347355;5714.828555143353;5781.132830075522;5782.826515204551;4763.237881938873;4768.690035147704;4781.760911954458;4795.232762757942;4809.927851082237;4086.2440448516527;4095.0990782027907;4103;4117.197146556453;4142.565030671796;4754.904901901942;4775.283707443842;4809.687370320918;4809.9418128011785;4845.854624361275;5817.563682723812;5849.093390524476;5855.473007429352;5876.382979787147;5878.647281163144;4825.95174048255;4849.393825771778;4850.151223535867;4853.665242058462;4877.878053048702;4924;5066.695998240118;5071.670341427795;5094.363204599425;5106.974465127651;5323.840284791462;5349.812756553502;5381.892362152813;5413.945860541502;5431.402545719889;5562.944370556243;5635.098384258499;5644.491995720405;5807.448292412214;5823.679697616672;5372.059889519397;5415.5938304626525;5451.936872310021;5455.263539422127;5473.151661492316;5646.096624540054;5769.740361683818;5773.24947756789;5774.3648198697265;5785;5657.858553536194;5717.42825717425;5735.311762588516;5743.483086522233;5799.536037116936;5562.249096371938;5569.275994120739;5588.6646801192055;5592;5607.046802043581;5479.315085614298;5551.306086739158;5562.638428502134;5566;5566.165075238585;5408.378036525693;5486.2394485790555;5488.725563721878;5496.4503549646315;5499.780008799603;5568.526675232489;5606.327240731139;5649.406812284651;5709.115087161496;5712.428757124254;5499.340079190362;5504.669719816824;5512.09050506678;5526.281583394133;5553.139263414178 10:37:15 INFO - PID 27852 | |1;ext.html;678.575890068707;742.4728442805608;757.1103952855395;1094.228568858954;1094.9835752463719;33272.66727332726;34478.48282275768;34487.48268775964;34495.31009379811;34593;35879.2824143517;36326.81836590813;36390.8180459098;36403.27193456129;36422;6651.467882569407;6838.521303508756;6870.759523416681;6992.650367481631;6995;6874.175098988104;6957.7216911323485;6973.198082220559;6973.6513174341335;6977.476689248301;6875.484338674594;6966.477514186431;6967.233604303523;6970.128733908262;7007.82480437988;6948.478864085188;6970.825729356756;6980.336867997532;6980.895286570655;6982.057422248033;6798.592084474947;6843.3840954314355;6848.486363522756;6865.27914568968;6865.5537390069985;32360;32531.83734081338;32545;32640.673593264;32689.83655081733;3038.346755447589;3069.2480342316053;3075.9231019224476;3079.276370053036;3089.6137982752157;25000.49999000028;25191;25205.36986575332;25232.873835630704;25320.873395633087;2903.404802015603;2914.7813913956325;2915.1400336900665;2918.1829087855435;2919.9562006569918;123755;124436;137044.31477842646;149219;149417;40684.59315406867;40837.89526309211;40910.79544602258;40939.7953010233;41048;41832.05191013698;41974;41999.58000419957;42037.78981105075;42052.36921446181;13294.401751921187;13397.598072057659;13398.598042058753;13405.262710550818;13405.932970335281;10768.515416806262;10834.295770774874;10855.945720271506;10861.511231994578;10880.836787448194;12703.428345724464;12716.872831271754;12735.681607959876;12735.936320318338;12952.222866628032;5213.139831927765;5246.422893481714;5299.682019078868;5315.069862773999;5357.285588681935;861.4486728493769;877.7191298784455;904.0913881549001;909.7589138878203;922.2207234886511;20813.004878829273;21248.17532844103;21677.78322216789;21690;21891.890540547513;974.1768205866032;991.3902949686036;1004.0511716428051;1004.3020101029714;1011.939283642969;10960.890391096147;11037.779244415227;11379.829302560469;11406.543738250542;11416.657500275005;168766;170353.14823425803;171169;171237;171598.14200929165;41509.1698166035;41520.792396037825;41584.12871420793;41605.791971040555;41615.58384416117;1202.2220790612203;1220.597202923051;1223.1499108119772;1238.0219626494968;1238.3436778507405;20259.29092481815;20616.175352986313;21085;21198.682019769407;21325.573488530452;29249.561256580742;29439.705602944552;29481.410371792874;29662.258443539085;29667.406651867273;151552;152120;152266;152919;153097;28009.299767505974;28048.85975570109;28457;28485.43029139447;28501.144965651063;34593.48109778405;34677.82661086678;35616.287674245854;35735.46396804102;36280.63719362773;26782.59826102649;27301.590476142475;27490.725092748817;27750.861245693643;28030.2992425191;26884.32789180208;27163.592546111428;27750.72249277562;28529;28874.711252888043;30479.390412192075;30811.691883080883;30964;30974.690253097182;31136.844315778275;25710.100146494784;26429.471410572067;26816.731832681424;27079.1876243713;27083.1875043749;19892.70160947616;21959.670604941257;22019;22073.889630551745;22246.88876555607 10:37:15 INFO - PID 27852 | |2;jquery.html;401.33378591538053;417.8942508603005;429.33453147621196;438.09751911063233;440.9625181859542;17076.487705368843;17651.382201622946;17828.55428614285;19403.805961940376;19923.70114448281;18852.717209241837;19135.617287654237;19416.126274317656;19573.608527829434;19582.314618988337;5431.185322201662;5545.445455454463;5584.5811564132755;5608.831735047955;5757.280339957505;5457.426970168135;5550.972245138769;5556.305461817273;5565.6104072714725;5565.9443405566035;5385.380681221671;5498.285222921035;5514.91727624086;5544.805931792388;5545.944540554603;5487.478689524509;5516.972415137919;5530.032244357261;5534.806281780158;5545.4731800478685;4650.813967441299;4796.760161991887;4842.539958703953;4994.87512812179;5016.197408414636;22440.77559224403;22596.54806903869;22773.658395124086;22847.88576057109;22873.542529149323;1571.552107649326;1592.800899887514;1639.5245378840123;1642.531878414658;1647.184643601413;14406.351714172888;14543.490977815725;15072.773908391382;15180.468683596022;15193.316300766492;1996.950076248091;2027.5742094160244;2053.301877361689;2059.1969132038516;2070.4306315763133;88340.55829720874;92691;95048;98463.50768246184;99068.50465747625;10728.517216725266;10736.08743256832;10748.355098693946;11099.278546894588;11304.886951130547;14417.495387661382;14420.42318307256;14449.34977925996;14502.637434064232;14516.564503064925;7104.467164962649;7499.775006749806;7567.432442566829;7741.303282704584;7794.649240784065;6911.5853048817235;6954.930450695429;7124.857502850017;7147.964260178665;7178.497505174588;6606.141201643755;6614.107095542136;6659.2008958925235;6703.430208432338;6782.559133656297;2017.6872584749387;2060.9278675246296;2061.8762874227596;2076.927307544229;2236;833.8332333533197;864.1358641358642;875.3216257400566;896.2605850173503;897.0625696147541;16894.324227030782;16967.575810604834;16996.23516941716;17554.824451755318;17555.385561505285;865.7013330401002;872.8647059705755;881.5019513974584;881.8985816631041;901.5492253873064;9225.630974761069;9362.578683959238;9714.979927107694;9727.805443891082;9893.208543316518;347033;348992;350834;352817;356401;71389.2861071393;72269;75784;80369.59815201003;81054.594727026;884.3014018925235;904.9728508144766;929.4516235420999;938.6198589571235;940.1256831146962;16145.838541614434;16298.755518667467;16813;16822.495325140266;17074.2316595756;37487;38534;39124;39297.410538841366;39710.602893971845;47490;47587.762061189474;47588.2861757067;48262.75868620635;49623.25565116454;8234;8310.83378332442;8465.576721163794;8477.152284771473;8755.824883502168;11546.826797597874;12418.75162496727;12912.870871291167;13151.671208219872;13496;10598.661421652156;11191.944040279746;11368.147388945697;11613.593524226611;11966.940165299466;11109.277896936997;11190.384528850665;11201.66395008151;11305.830412543653;11465.770684586429;11046.502907369028;11156.832647510131;11222.607208747655;11732.12009099304;12024.398780061138;7986.281234688906;8183.263506284463;8187.1403502631365;8201.712940047308;8498.065212826461;10814.134869210602;11001.61494347694;11005.61480348216;11074.446277686244;11156.944215278872 10:37:15 INFO - PID 27852 | |3;mootools.html;1237.4988129807427;1305.4125643460438;1307.797291419829;1316.203696763458;1318.426484479251;10062.597496100156;10509.264351495398;10567.577296908134;10620.575176992921;10804.13566914645;9811.166050885666;9961.103500684936;9962.402255864654;9973.650922217725;9997.50012499374;2172.2614311134253;2232.174095584636;2232.520008198237;2233.184887516053;2238.7649296823843;2076.3667081540125;2116.8941552922292;2118.7669356370866;2120.2579097315893;2124.2565102214257;2095.2038225474375;2124.330835786722;2132.8080472757447;2135.9252426165085;2140.422086036777;2027.2397850805949;2028.482736902088;2033.83729301657;2048.6005228980357;2049.149602914796;1697.295622316737;1761.7621621081119;1991.9203231870708;1992.930247441347;2048.6926960955825;9628.71113866585;9811.90188098117;9865.90134098657;9877.357971731815;9881.407115573016;5472.945270547283;5717.685527295997;5718.285214348207;5726.656400615935;5730.455606717355;3146.166265939528;3286.3263031078573;3344.0302312329395;3349.514320423549;3370.7471939604384;1027.3733022856052;1037.2946396450411;1051.437480947697;1056.7675111475462;1078.9730256743567;14066.367013484418;14301.642458938506;14331.42674293027;14362.85637143636;14393.640158996004;4691.108689349013;4889.193283108248;5069.670471419346;5073.365829271341;5102.540771330598;12749.617511474671;12785;12812;12816;12854.485820567259;5550.583706221969;5631.71841407928;5653.321601407857;5653.858653533613;5669.6314739541795;5019.598432125421;5060.240963855377;5082.1360368737405;5083.644144909895;5090.745462726849;4150.792460376969;4165.540158579573;4206.47419072616;4228.725132866354;4278.893027674333;1255.0963306419364;1293.7218498022971;1296.5591698822445;1303.270168705509;1307.4378017452586;622.390057743414;636.3096040795789;647.666451777335;663.6283681138482;690.8031211104811;6099.573029887954;6240.469560087444;6267.185265915493;6325.367463253638;6449.645269510222;841.7306461932122;857.9399442038997;858.5578427110044;877.7103555826562;892.0588778838388;3737.4580685800406;3761.2101458693433;3832.463455116286;3876.089119057019;4120.134771697917;13050.216986980811;13122.212667239995;13216.405261763244;13491.460341586228;13507;12841.678958025937;13370.130941488773;13387.866121338857;13406.128601640861;13559.25424101664;6848.212455567674;6948.965255173692;6953.79138625842;7018.192907815666;7022.262662420372;5578.553715702815;6027.909581356195;6046.3046749624355;6060.333363329942;6270.717817698306;12007.459664314953;12114.636560903187;12275.386230688251;12330.75338493243;12395.93802030984;12334.568290109803;12487.875121249035;12580.30808305552;12682;12704.237745735285;8006.95996520037;8176.959115204386;8207.015158181057;8232.053313868983;8234.300084492885;8854.335924805537;8954.462732236087;8979.640814367353;9004.41471304363;9010.954945225232;7648.23517648253;7876.763697089096;7926.801829954066;7936.880946785918;8152.83694326122;7629.847403052019;7686.3850891927395;7736.303732664087;7854.293113619573;7928.7621371358955;7026.613536255555;7060.752873649398;7095;7098.574085554883;7129.429645628234;4611.723296602215;5353.705546194997;5457.672539647634;5462.562994960473;5481.397046324981;5056.974715126401;5152.149895267239;5168.664036837594;5265.736713164403;5274.551663108526 10:37:15 INFO - PID 27852 | |4;prototype.html;362.74426529296846;363.95632524097107;364.34054361605496;365.8408592262366;368.6571488515679;5617.623682197857;5618.438156184379;5619.887602247958;5665.773369065243;5666.603337766358;5183.948160518394;5480.123180291154;5507.339119305689;5512.145617429295;5522.751476183581;4063.5326937402133;4103.692223083273;4109.835606575748;4123.092919557693;4125.051238215212;4109;4115.991582062399;4117.114820313632;4119.546849846514;4134.669226461876;4085.3667681509414;4085.897852553695;4086.346184610463;4094.4472496213075;4113.958860411402;4029.2344454553686;4074.5721699221453;4087.4686290782306;4098.098418347959;4106.466159399274;3559.181388280684;3567.3935430976535;3573.6426357364057;3578.2306804037;3581.3374525712825;5318.547923426513;5332.986862422718;5354.9196762048605;5356.250124982505;5379.38137114233;4727.952720472786;4813.759312034419;4841.7579121044155;4842.273658951185;4842.903141937177;5779.971100144515;5785.322256545597;5788.942110578882;5804.926088673609;5805.970970145165;3964.8215830287418;3982.820773065219;3988.142549351874;3990.660793832528;3990.700697447703;5896.882062358772;6080.513558915321;6105.358937311607;6167.229096362955;6176.3514830943;4043.211573743092;4075.3886916962692;4075.918481630351;4081.551029386765;4089.1208390196252;4109.178164367078;4113.239050775616;4118.75287482752;4121.649659778893;4133.379993001014;4645.558671926162;4735.905281894412;4778.378810754649;4787;4790.760461976887;5769.278840144982;5790.160426738099;5799.8550036249435;5800.680962547016;5808.128780682847;1415.3206460898825;1436.5187662133094;1438.3311760031427;1439.5321520505877;1440.683049729058;926.7358802741186;950.8668786369914;958.4776296918196;964.9807003859884;965.5751469353462;4962.684888504549;4980;4991.301217829507;4992.775325110379;5011.57401620859;6003.339632640406;6021.5182785377065;6025.427584379477;6025.879482410415;6036.456718895321;4804.663673542818;4962.578180854595;4964.553190212898;4994.875128121826;5019.0965626187635;3165.525171224289;3217.2117831131523;3219.114743445571;3220.5169224616025;3240.481522956363;5466.961277357289;5595.272614560163;5600.243967064394;5618.634788738719;5658.811649553558;6028.487578555784;6191.721372538246;6225.750969961241;6234.643121117126;6262.780802671885;5576.888462230732;5585.357683866408;5598.188262701886;5607.66354018752;5610.1584762285165;6015.849603759941;6055.424734650202;6060.424259695322;6088.665123418077;6101.359357267423;5677.545796336366;5908.438698323653;5935;5959.135925290895;5965.403459654173;5568.248286481273;5578.995780759502;5580.190872323409;5606.103023516218;5607.243022191952;3924.313245182139;4031.576684448091;4068.5995262795095;4093.7748423836974;4123.731957422758;6096.177016102769;6100.908486372797;6102.755889764359;6126.356732543197;6127.290616774625;5896.518645829115;5926.2295901532525;5927.7036148191555;5931.822045338647;5945.940540594539;5784.479396854135;5835.6790376528;5872.647641141545;5899.911501327398;5911.556633252438;5789.507891829242;5831.1544826000845;5833.445822646841;5837.620554663933;5846.1815345852465;5873.119032145212;5943.7028148591535;5948.643081415129;5950.4644581986095;5998.310194327708;5674.432556744293;5709.400512946247;5737.053386191398;5759.568032397503;5772.826815195551 10:37:15 INFO - PID 27852 | |5;yui.html;633.37612451735;649.8667773106514;723.4971694672201;760.3574979142625;772.9922700772994;12888.42002109905;13291.401886915088;13405.664858378545;13885.86114138857;13902.860971390282;15118.848811511882;16185.676286474263;16275.348986040544;16290.592735181626;16309;887.6316328723572;901.0808974845653;904.3579058868212;907.7639813648466;909.636145541782;887.8934527856634;889.4485419040204;889.9332550058739;893.2184338703635;898.0435835834814;902.1294450854924;912.4114945859916;928.9163975242227;931.74842792446;933.6872147830485;910.5902343945218;913.4245425382034;916.812053529025;919.1819280840058;921.7511271956602;671.6574546981026;672.9562578432386;673.1417442760519;674.7874419557824;678.1929503890404;13845.584632461043;13851.099678520864;13864.514741983981;13888.375023123983;13925.721485570231;15504.224788760517;16163.272652730655;16278.918605406898;16298.592535186597;16311.102889341082;11973.700657483545;11982.58060967862;12055.879441205563;12100.878991210064;12117.575884843987;2983.3287510310224;3000.6699263081046;3023.818570885754;3025.1529571719734;3033.1810411188853;83191.58404208001;84045;84113.15886841176;84608.57695711544;85360.57319713486;12540.310282934344;12660.113792034654;12786;12920.741585168244;12946;23881.283561493183;24382.146624868044;24567.38581535476;24578.262652120466;24629.753702463106;5888.970555147197;5953.255843019622;6002.879942401128;6007.609505382136;6017.939820601826;2809.35384861483;2906.2007947814095;2906.244376462093;2909.2435966648823;2910.6798252192243;3431.0907609483506;3477.3914564951033;3481.5029537298697;3502.824858757103;3507.316073365669;744.5495475237511;805.923437273458;806.8709006558922;808.8422757562219;813.8982627171604;601.1073555769678;614.6619359352338;615.689077016113;618.5577312221783;629.3643420145686;8923.107689231025;9228.676996305097;9462.29032822541;9698.46658433793;9859.161971232526;550.8622844288927;554.8945700317007;563.5829486180279;567.3163837575711;571.8627529392999;4209.537420608917;4352.912941741148;4439.977800110979;4499.1451624191295;4539.977300113478;83899;84244.57877710694;84350.15649843546;87256.56371718101;87531;74452;75938;79620;79721.60139199383;79738.60130699309;67449;69403.30596693969;69578;70227.64886175537;71405.64297178481;8604.311655067704;8940.240079593308;9018.594163262538;9072.364934454525;9213.309001824757;29278;29320.413591727618;29568.112956611338;29906.252343691584;29953;37388.626113738515;37845.62154378531;37996.81001594974;38335.233295334496;38561;12319.322437266037;12459.501619935101;12519.123661343983;12645.557405490763;12647.620571382873;13184.077114601885;13651.249181295125;13684;13721.794173087212;15564.533064008097;13533.255670938193;13686.31568421555;13860.168389896638;14824.332905019084;15034.32345544475;13788.103773254707;13966.4413423466;13982.650433739238;14113.576592702235;14295.785563216352;13488.988325875795;13844.30778461093;13986.790198147239;14050.086744361584;14543.563693089225;8834.381593288408;9062.275017998676;9183.862242066241;10426;10509.579616815548;11431;12309.384530773605;12377.381130943237;12388.132830701765;12500.37498125072 10:37:15 INFO - PID 27852 | __end_tp_report 10:37:15 INFO - PID 27852 | __start_cc_report 10:37:15 INFO - PID 27852 | _x_x_mozilla_cycle_collect,381 10:37:15 INFO - PID 27852 | __end_cc_report 10:37:15 INFO - PID 27852 | __startTimestamp1496165835323__endTimestamp 10:37:15 INFO - PID 27852 | 10:37:15 INFO - PID 27852 | ------- Summary: start ------- 10:37:15 INFO - PID 27852 | Number of tests: 6 10:37:15 INFO - PID 27852 | 10:37:15 INFO - PID 27852 | [#0] dojo.html Cycles:165 Average:5261.50 Median:5431.40 stddev:632.35 (11.6%) stddev-sans-first:602.35 10:37:15 INFO - PID 27852 | Values: 2732.1 2736.1 2758.6 2785.9 2788.3 5239.2 5241.2 5324.7 5341.8 5360.9 5321.4 5324.7 5327.5 5405.7 5415.9 4684.9 4711.8 4753.6 4777.2 4784.8 4600.8 4755.8 4784.4 4821.6 4828.6 4654.1 4769.8 4778.2 4823.2 4877.0 4711.1 4714.3 4722.8 4761.0 4808.6 4692.8 4714.7 4720.6 4739.1 4758.8 5318.7 5322.6 5341.7 5347.5 5349.0 5667.0 5690.1 5748.1 5749.8 5767.8 5826.9 5828.7 5834.4 5855.0 5881.4 5370.2 5372.9 5393.8 5396.5 5397.0 5770.2 5880.7 5914.1 5969.7 5970.7 5738.3 5743.0 5744.8 5746.7 5783.8 5796.7 5808.9 5810.6 5811.0 5838.4 5569.5 5784.1 5801.8 5809.1 5813.6 5686.4 5697.3 5714.8 5781.1 5782.8 4763.2 4768.7 4781.8 4795.2 4809.9 4086.2 4095.1 4103.0 4117.2 4142.6 4754.9 4775.3 4809.7 4809.9 4845.9 5817.6 5849.1 5855.5 5876.4 5878.6 4826.0 4849.4 4850.2 4853.7 4877.9 4924.0 5066.7 5071.7 5094.4 5107.0 5323.8 5349.8 5381.9 5413.9 5431.4 5562.9 5635.1 5644.5 5807.4 5823.7 5372.1 5415.6 5451.9 5455.3 5473.2 5646.1 5769.7 5773.2 5774.4 5785.0 5657.9 5717.4 5735.3 5743.5 5799.5 5562.2 5569.3 5588.7 5592.0 5607.0 5479.3 5551.3 5562.6 5566.0 5566.2 5408.4 5486.2 5488.7 5496.5 5499.8 5568.5 5606.3 5649.4 5709.1 5712.4 5499.3 5504.7 5512.1 5526.3 5553.1 10:37:15 INFO - PID 27852 | 10:37:15 INFO - PID 27852 | [#1] ext.html Cycles:180 Average:30016.37 Median:29344.63 stddev:39706.12 (135.3%) stddev-sans-first:39756.39 10:37:15 INFO - PID 27852 | Values: 678.6 742.5 757.1 1094.2 1095.0 33272.7 34478.5 34487.5 34495.3 34593.0 35879.3 36326.8 36390.8 36403.3 36422.0 6651.5 6838.5 6870.8 6992.7 6995.0 6874.2 6957.7 6973.2 6973.7 6977.5 6875.5 6966.5 6967.2 6970.1 7007.8 6948.5 6970.8 6980.3 6980.9 6982.1 6798.6 6843.4 6848.5 6865.3 6865.6 32360.0 32531.8 32545.0 32640.7 32689.8 3038.3 3069.2 3075.9 3079.3 3089.6 25000.5 25191.0 25205.4 25232.9 25320.9 2903.4 2914.8 2915.1 2918.2 2920.0 123755.0 124436.0 137044.3 149219.0 149417.0 40684.6 40837.9 40910.8 40939.8 41048.0 41832.1 41974.0 41999.6 42037.8 42052.4 13294.4 13397.6 13398.6 13405.3 13405.9 10768.5 10834.3 10855.9 10861.5 10880.8 12703.4 12716.9 12735.7 12735.9 12952.2 5213.1 5246.4 5299.7 5315.1 5357.3 861.4 877.7 904.1 909.8 922.2 20813.0 21248.2 21677.8 21690.0 21891.9 974.2 991.4 1004.1 1004.3 1011.9 10960.9 11037.8 11379.8 11406.5 11416.7 168766.0 170353.1 171169.0 171237.0 171598.1 41509.2 41520.8 41584.1 41605.8 41615.6 1202.2 1220.6 1223.1 1238.0 1238.3 20259.3 20616.2 21085.0 21198.7 21325.6 29249.6 29439.7 29481.4 29662.3 29667.4 151552.0 152120.0 152266.0 152919.0 153097.0 28009.3 28048.9 28457.0 28485.4 28501.1 34593.5 34677.8 35616.3 35735.5 36280.6 26782.6 27301.6 27490.7 27750.9 28030.3 26884.3 27163.6 27750.7 28529.0 28874.7 30479.4 30811.7 30964.0 30974.7 31136.8 25710.1 26429.5 26816.7 27079.2 27083.2 19892.7 21959.7 22019.0 22073.9 22246.9 10:37:15 INFO - PID 27852 | 10:37:15 INFO - PID 27852 | [#2] jquery.html Cycles:180 Average:24574.15 Median:409.61 stddev:58809.04 (14357.2%) stddev-sans-first:58946.01 10:37:15 INFO - PID 27852 | Values: 401.3 417.9 429.3 438.1 441.0 17076.5 17651.4 17828.6 19403.8 19923.7 18852.7 19135.6 19416.1 19573.6 19582.3 5431.2 5545.4 5584.6 5608.8 5757.3 5457.4 5551.0 5556.3 5565.6 5565.9 5385.4 5498.3 5514.9 5544.8 5545.9 5487.5 5517.0 5530.0 5534.8 5545.5 4650.8 4796.8 4842.5 4994.9 5016.2 22440.8 22596.5 22773.7 22847.9 22873.5 1571.6 1592.8 1639.5 1642.5 1647.2 14406.4 14543.5 15072.8 15180.5 15193.3 1997.0 2027.6 2053.3 2059.2 2070.4 88340.6 92691.0 95048.0 98463.5 99068.5 10728.5 10736.1 10748.4 11099.3 11304.9 14417.5 14420.4 14449.3 14502.6 14516.6 7104.5 7499.8 7567.4 7741.3 7794.6 6911.6 6954.9 7124.9 7148.0 7178.5 6606.1 6614.1 6659.2 6703.4 6782.6 2017.7 2060.9 2061.9 2076.9 2236.0 833.8 864.1 875.3 896.3 897.1 16894.3 16967.6 16996.2 17554.8 17555.4 865.7 872.9 881.5 881.9 901.5 9225.6 9362.6 9715.0 9727.8 9893.2 347033.0 348992.0 350834.0 352817.0 356401.0 71389.3 72269.0 75784.0 80369.6 81054.6 884.3 905.0 929.5 938.6 940.1 16145.8 16298.8 16813.0 16822.5 17074.2 37487.0 38534.0 39124.0 39297.4 39710.6 47490.0 47587.8 47588.3 48262.8 49623.3 8234.0 8310.8 8465.6 8477.2 8755.8 11546.8 12418.8 12912.9 13151.7 13496.0 10598.7 11191.9 11368.1 11613.6 11966.9 11109.3 11190.4 11201.7 11305.8 11465.8 11046.5 11156.8 11222.6 11732.1 12024.4 7986.3 8183.3 8187.1 8201.7 8498.1 10814.1 11001.6 11005.6 11074.4 11156.9 10:37:15 INFO - PID 27852 | 10:37:15 INFO - PID 27852 | [#3] mootools.html Cycles:180 Average:6293.68 Median:4651.42 stddev:4068.69 (87.5%) stddev-sans-first:4062.37 10:37:15 INFO - PID 27852 | Values: 1237.5 1305.4 1307.8 1316.2 1318.4 10062.6 10509.3 10567.6 10620.6 10804.1 9811.2 9961.1 9962.4 9973.7 9997.5 2172.3 2232.2 2232.5 2233.2 2238.8 2076.4 2116.9 2118.8 2120.3 2124.3 2095.2 2124.3 2132.8 2135.9 2140.4 2027.2 2028.5 2033.8 2048.6 2049.1 1697.3 1761.8 1991.9 1992.9 2048.7 9628.7 9811.9 9865.9 9877.4 9881.4 5472.9 5717.7 5718.3 5726.7 5730.5 3146.2 3286.3 3344.0 3349.5 3370.7 1027.4 1037.3 1051.4 1056.8 1079.0 14066.4 14301.6 14331.4 14362.9 14393.6 4691.1 4889.2 5069.7 5073.4 5102.5 12749.6 12785.0 12812.0 12816.0 12854.5 5550.6 5631.7 5653.3 5653.9 5669.6 5019.6 5060.2 5082.1 5083.6 5090.7 4150.8 4165.5 4206.5 4228.7 4278.9 1255.1 1293.7 1296.6 1303.3 1307.4 622.4 636.3 647.7 663.6 690.8 6099.6 6240.5 6267.2 6325.4 6449.6 841.7 857.9 858.6 877.7 892.1 3737.5 3761.2 3832.5 3876.1 4120.1 13050.2 13122.2 13216.4 13491.5 13507.0 12841.7 13370.1 13387.9 13406.1 13559.3 6848.2 6949.0 6953.8 7018.2 7022.3 5578.6 6027.9 6046.3 6060.3 6270.7 12007.5 12114.6 12275.4 12330.8 12395.9 12334.6 12487.9 12580.3 12682.0 12704.2 8007.0 8177.0 8207.0 8232.1 8234.3 8854.3 8954.5 8979.6 9004.4 9011.0 7648.2 7876.8 7926.8 7936.9 8152.8 7629.8 7686.4 7736.3 7854.3 7928.8 7026.6 7060.8 7095.0 7098.6 7129.4 4611.7 5353.7 5457.7 5462.6 5481.4 5057.0 5152.1 5168.7 5265.7 5274.6 10:37:15 INFO - PID 27852 | 10:37:15 INFO - PID 27852 | [#4] prototype.html Cycles:180 Average:4780.27 Median:5545.50 stddev:1443.49 (26.0%) stddev-sans-first:1408.94 10:37:15 INFO - PID 27852 | Values: 362.7 364.0 364.3 365.8 368.7 5617.6 5618.4 5619.9 5665.8 5666.6 5183.9 5480.1 5507.3 5512.1 5522.8 4063.5 4103.7 4109.8 4123.1 4125.1 4109.0 4116.0 4117.1 4119.5 4134.7 4085.4 4085.9 4086.3 4094.4 4114.0 4029.2 4074.6 4087.5 4098.1 4106.5 3559.2 3567.4 3573.6 3578.2 3581.3 5318.5 5333.0 5354.9 5356.3 5379.4 4728.0 4813.8 4841.8 4842.3 4842.9 5780.0 5785.3 5788.9 5804.9 5806.0 3964.8 3982.8 3988.1 3990.7 3990.7 5896.9 6080.5 6105.4 6167.2 6176.4 4043.2 4075.4 4075.9 4081.6 4089.1 4109.2 4113.2 4118.8 4121.6 4133.4 4645.6 4735.9 4778.4 4787.0 4790.8 5769.3 5790.2 5799.9 5800.7 5808.1 1415.3 1436.5 1438.3 1439.5 1440.7 926.7 950.9 958.5 965.0 965.6 4962.7 4980.0 4991.3 4992.8 5011.6 6003.3 6021.5 6025.4 6025.9 6036.5 4804.7 4962.6 4964.6 4994.9 5019.1 3165.5 3217.2 3219.1 3220.5 3240.5 5467.0 5595.3 5600.2 5618.6 5658.8 6028.5 6191.7 6225.8 6234.6 6262.8 5576.9 5585.4 5598.2 5607.7 5610.2 6015.8 6055.4 6060.4 6088.7 6101.4 5677.5 5908.4 5935.0 5959.1 5965.4 5568.2 5579.0 5580.2 5606.1 5607.2 3924.3 4031.6 4068.6 4093.8 4123.7 6096.2 6100.9 6102.8 6126.4 6127.3 5896.5 5926.2 5927.7 5931.8 5945.9 5784.5 5835.7 5872.6 5899.9 5911.6 5789.5 5831.2 5833.4 5837.6 5846.2 5873.1 5943.7 5948.6 5950.5 5998.3 5674.4 5709.4 5737.1 5759.6 5772.8 10:37:15 INFO - PID 27852 | 10:37:15 INFO - PID 27852 | [#5] yui.html Cycles:180 Average:17478.29 Median:38448.12 stddev:23573.70 (61.3%) stddev-sans-first:23605.89 10:37:15 INFO - PID 27852 | Values: 633.4 649.9 723.5 760.4 773.0 12888.4 13291.4 13405.7 13885.9 13902.9 15118.8 16185.7 16275.3 16290.6 16309.0 887.6 901.1 904.4 907.8 909.6 887.9 889.4 889.9 893.2 898.0 902.1 912.4 928.9 931.7 933.7 910.6 913.4 916.8 919.2 921.8 671.7 673.0 673.1 674.8 678.2 13845.6 13851.1 13864.5 13888.4 13925.7 15504.2 16163.3 16278.9 16298.6 16311.1 11973.7 11982.6 12055.9 12100.9 12117.6 2983.3 3000.7 3023.8 3025.2 3033.2 83191.6 84045.0 84113.2 84608.6 85360.6 12540.3 12660.1 12786.0 12920.7 12946.0 23881.3 24382.1 24567.4 24578.3 24629.8 5889.0 5953.3 6002.9 6007.6 6017.9 2809.4 2906.2 2906.2 2909.2 2910.7 3431.1 3477.4 3481.5 3502.8 3507.3 744.5 805.9 806.9 808.8 813.9 601.1 614.7 615.7 618.6 629.4 8923.1 9228.7 9462.3 9698.5 9859.2 550.9 554.9 563.6 567.3 571.9 4209.5 4352.9 4440.0 4499.1 4540.0 83899.0 84244.6 84350.2 87256.6 87531.0 74452.0 75938.0 79620.0 79721.6 79738.6 67449.0 69403.3 69578.0 70227.6 71405.6 8604.3 8940.2 9018.6 9072.4 9213.3 29278.0 29320.4 29568.1 29906.3 29953.0 37388.6 37845.6 37996.8 38335.2 38561.0 12319.3 12459.5 12519.1 12645.6 12647.6 13184.1 13651.2 13684.0 13721.8 15564.5 13533.3 13686.3 13860.2 14824.3 15034.3 13788.1 13966.4 13982.7 14113.6 14295.8 13489.0 13844.3 13986.8 14050.1 14543.6 8834.4 9062.3 9183.9 10426.0 10509.6 11431.0 12309.4 12377.4 12388.1 12500.4 10:37:15 INFO - PID 27852 | -------- Summary: end -------- 10:37:15 INFO - PID 27852 | 10:37:16 INFO - TEST-INFO | 27852: exit 0 10:37:16 INFO - TEST-OK | dromaeo_css | took 1149165ms 10:37:16 INFO - TEST-START | kraken 10:37:16 INFO - operating with platform_type : linux_ 10:37:16 INFO - Initialising browser for kraken test... 10:37:16 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:44434/getInfo.html -profile /tmp/tmpQg_2QG/profile 10:37:16 INFO - TEST-INFO | started process 28278 (/builds/slave/test/build/application/firefox/firefox http://localhost:44434/getInfo.html) 10:37:51 INFO - TEST-INFO | 28278: killed by SIGTERM 10:37:51 INFO - Browser initialized. 10:37:51 INFO - Running cycle 1/1 for kraken test... 10:37:51 INFO - TEST-INFO | started process 28503 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpQg_2QG/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:38:03 INFO - PID 28503 | RSS: Main: 186331136 10:38:03 INFO - PID 28503 | 10:38:06 INFO - PID 28503 | Cycle 1(1): loaded http://localhost:44434/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:44434/tests/kraken/driver.html?testName=audio-beat-detection) 10:38:07 INFO - PID 28503 | RSS: Main: 189308928 10:38:07 INFO - PID 28503 | 10:38:09 INFO - PID 28503 | Cycle 1(1): loaded http://localhost:44434/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:44434/tests/kraken/driver.html?testName=audio-dft) 10:38:10 INFO - PID 28503 | RSS: Main: 189145088 10:38:10 INFO - PID 28503 | 10:38:13 INFO - PID 28503 | Cycle 1(1): loaded http://localhost:44434/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:44434/tests/kraken/driver.html?testName=audio-fft) 10:38:14 INFO - PID 28503 | RSS: Main: 185581568 10:38:14 INFO - PID 28503 | 10:38:16 INFO - PID 28503 | Cycle 1(1): loaded http://localhost:44434/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:44434/tests/kraken/driver.html?testName=audio-oscillator) 10:38:16 INFO - PID 28503 | RSS: Main: 185581568 10:38:16 INFO - PID 28503 | 10:38:19 INFO - PID 28503 | Cycle 1(1): loaded http://localhost:44434/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:44434/tests/kraken/driver.html?testName=imaging-gaussian-blur) 10:38:19 INFO - PID 28503 | RSS: Main: 185835520 10:38:19 INFO - PID 28503 | 10:38:22 INFO - PID 28503 | Cycle 1(1): loaded http://localhost:44434/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:44434/tests/kraken/driver.html?testName=imaging-darkroom) 10:38:23 INFO - PID 28503 | RSS: Main: 190185472 10:38:23 INFO - PID 28503 | 10:38:26 INFO - PID 28503 | Cycle 1(1): loaded http://localhost:44434/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:44434/tests/kraken/driver.html?testName=imaging-desaturate) 10:38:27 INFO - PID 28503 | RSS: Main: 186478592 10:38:27 INFO - PID 28503 | 10:38:30 INFO - PID 28503 | Cycle 1(1): loaded http://localhost:44434/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:44434/tests/kraken/driver.html?testName=json-parse-financial) 10:38:31 INFO - PID 28503 | RSS: Main: 186523648 10:38:31 INFO - PID 28503 | 10:38:32 INFO - PID 28503 | Cycle 1(1): loaded http://localhost:44434/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:44434/tests/kraken/driver.html?testName=json-stringify-tinderbox) 10:38:33 INFO - PID 28503 | RSS: Main: 186728448 10:38:33 INFO - PID 28503 | 10:38:35 INFO - PID 28503 | Cycle 1(1): loaded http://localhost:44434/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:44434/tests/kraken/driver.html?testName=stanford-crypto-aes) 10:38:35 INFO - PID 28503 | RSS: Main: 187076608 10:38:35 INFO - PID 28503 | 10:38:38 INFO - PID 28503 | Cycle 1(1): loaded http://localhost:44434/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:44434/tests/kraken/driver.html?testName=stanford-crypto-ccm) 10:38:38 INFO - PID 28503 | RSS: Main: 186761216 10:38:38 INFO - PID 28503 | 10:38:41 INFO - PID 28503 | Cycle 1(1): loaded http://localhost:44434/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:44434/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 10:38:42 INFO - PID 28503 | RSS: Main: 186658816 10:38:42 INFO - PID 28503 | 10:38:45 INFO - PID 28503 | Cycle 1(1): loaded http://localhost:44434/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:44434/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 10:38:46 INFO - PID 28503 | RSS: Main: 186642432 10:38:46 INFO - PID 28503 | 10:38:48 INFO - PID 28503 | Cycle 1(1): loaded http://localhost:44434/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:44434/tests/kraken/driver.html?testName=ai-astar) 10:38:48 INFO - PID 28503 | RSS: Main: 187904000 10:38:48 INFO - PID 28503 | 10:38:48 INFO - PID 28503 | __start_tp_report 10:38:48 INFO - PID 28503 | _x_x_mozilla_page_load 10:38:48 INFO - PID 28503 | _x_x_mozilla_page_load_details 10:38:48 INFO - PID 28503 | |i|pagename|runs| 10:38:48 INFO - PID 28503 | |0;ai-astar;103;112;111;110;111;113;111;111;112;111 10:38:48 INFO - PID 28503 | |1;audio-beat-detection;149;126;126;180;123;122;122;125;147;128 10:38:48 INFO - PID 28503 | |2;audio-dft;163;165;166;168;168;181;167;167;162;165 10:38:48 INFO - PID 28503 | |3;audio-fft;74;77;74;115;74;75;78;74;104;74 10:38:48 INFO - PID 28503 | |4;audio-oscillator;84;84;114;84;85;84;98;84;84;116 10:38:48 INFO - PID 28503 | |5;imaging-gaussian-blur;114;116;114;114;114;115;119;115;114;114 10:38:48 INFO - PID 28503 | |6;imaging-darkroom;151;150;151;151;150;150;151;149;152;151 10:38:48 INFO - PID 28503 | |7;imaging-desaturate;95;97;95;94;95;94;95;95;95;94 10:38:48 INFO - PID 28503 | |8;json-parse-financial;54;55;57;58;57;57;63;59;60;57 10:38:48 INFO - PID 28503 | |9;json-stringify-tinderbox;57;56;59;59;60;58;56;56;59;57 10:38:48 INFO - PID 28503 | |10;stanford-crypto-aes;89;89;88;88;87;89;89;89;140;88 10:38:48 INFO - PID 28503 | |11;stanford-crypto-ccm;144;139;136;145;135;140;132;135;136;141 10:38:48 INFO - PID 28503 | |12;stanford-crypto-pbkdf2;188;214;202;199;186;192;191;195;193;192 10:38:48 INFO - PID 28503 | |13;stanford-crypto-sha256-iterative;74;78;75;76;73;76;75;75;72;74 10:38:48 INFO - PID 28503 | __end_tp_report 10:38:48 INFO - PID 28503 | __start_cc_report 10:38:48 INFO - PID 28503 | _x_x_mozilla_cycle_collect,1033 10:38:48 INFO - PID 28503 | __end_cc_report 10:38:48 INFO - PID 28503 | __startTimestamp1496165928292__endTimestamp 10:38:48 INFO - PID 28503 | 10:38:48 INFO - PID 28503 | ------- Summary: start ------- 10:38:48 INFO - PID 28503 | Number of tests: 14 10:38:48 INFO - PID 28503 | 10:38:48 INFO - PID 28503 | [#0] ai-astar Cycles:10 Average:110.50 Median:111.00 stddev:2.76 (2.5%) stddev-sans-first:0.87 10:38:48 INFO - PID 28503 | Values: 103.0 112.0 111.0 110.0 111.0 113.0 111.0 111.0 112.0 111.0 10:38:48 INFO - PID 28503 | 10:38:48 INFO - PID 28503 | [#1] audio-beat-detection Cycles:10 Average:134.80 Median:127.00 stddev:18.73 (14.7%) stddev-sans-first:19.15 10:38:48 INFO - PID 28503 | Values: 149.0 126.0 126.0 180.0 123.0 122.0 122.0 125.0 147.0 128.0 10:38:48 INFO - PID 28503 | 10:38:48 INFO - PID 28503 | [#2] audio-dft Cycles:10 Average:167.20 Median:167.00 stddev:5.25 (3.1%) stddev-sans-first:5.34 10:38:48 INFO - PID 28503 | Values: 163.0 165.0 166.0 168.0 168.0 181.0 167.0 167.0 162.0 165.0 10:38:48 INFO - PID 28503 | 10:38:48 INFO - PID 28503 | [#3] audio-fft Cycles:10 Average:81.90 Median:74.00 stddev:14.84 (20.1%) stddev-sans-first:15.47 10:38:48 INFO - PID 28503 | Values: 74.0 77.0 74.0 115.0 74.0 75.0 78.0 74.0 104.0 74.0 10:38:48 INFO - PID 28503 | 10:38:48 INFO - PID 28503 | [#4] audio-oscillator Cycles:10 Average:91.70 Median:84.00 stddev:13.03 (15.5%) stddev-sans-first:13.52 10:38:48 INFO - PID 28503 | Values: 84.0 84.0 114.0 84.0 85.0 84.0 98.0 84.0 84.0 116.0 10:38:48 INFO - PID 28503 | 10:38:48 INFO - PID 28503 | [#5] imaging-gaussian-blur Cycles:10 Average:114.90 Median:114.50 stddev:1.60 (1.4%) stddev-sans-first:1.66 10:38:48 INFO - PID 28503 | Values: 114.0 116.0 114.0 114.0 114.0 115.0 119.0 115.0 114.0 114.0 10:38:48 INFO - PID 28503 | 10:38:48 INFO - PID 28503 | [#6] imaging-darkroom Cycles:10 Average:150.60 Median:151.00 stddev:0.84 (0.6%) stddev-sans-first:0.88 10:38:48 INFO - PID 28503 | Values: 151.0 150.0 151.0 151.0 150.0 150.0 151.0 149.0 152.0 151.0 10:38:48 INFO - PID 28503 | 10:38:48 INFO - PID 28503 | [#7] imaging-desaturate Cycles:10 Average:94.90 Median:95.00 stddev:0.88 (0.9%) stddev-sans-first:0.93 10:38:48 INFO - PID 28503 | Values: 95.0 97.0 95.0 94.0 95.0 94.0 95.0 95.0 95.0 94.0 10:38:48 INFO - PID 28503 | 10:38:48 INFO - PID 28503 | [#8] json-parse-financial Cycles:10 Average:57.70 Median:57.50 stddev:2.54 (4.4%) stddev-sans-first:2.32 10:38:48 INFO - PID 28503 | Values: 54.0 55.0 57.0 58.0 57.0 57.0 63.0 59.0 60.0 57.0 10:38:48 INFO - PID 28503 | 10:38:48 INFO - PID 28503 | [#9] json-stringify-tinderbox Cycles:10 Average:57.70 Median:58.50 stddev:1.49 (2.6%) stddev-sans-first:1.56 10:38:48 INFO - PID 28503 | Values: 57.0 56.0 59.0 59.0 60.0 58.0 56.0 56.0 59.0 57.0 10:38:48 INFO - PID 28503 | 10:38:48 INFO - PID 28503 | [#10] stanford-crypto-aes Cycles:10 Average:93.60 Median:89.00 stddev:16.32 (18.3%) stddev-sans-first:17.22 10:38:48 INFO - PID 28503 | Values: 89.0 89.0 88.0 88.0 87.0 89.0 89.0 89.0 140.0 88.0 10:38:48 INFO - PID 28503 | 10:38:48 INFO - PID 28503 | [#11] stanford-crypto-ccm Cycles:10 Average:138.30 Median:139.50 stddev:4.22 (3.0%) stddev-sans-first:3.94 10:38:48 INFO - PID 28503 | Values: 144.0 139.0 136.0 145.0 135.0 140.0 132.0 135.0 136.0 141.0 10:38:48 INFO - PID 28503 | 10:38:48 INFO - PID 28503 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:195.20 Median:194.00 stddev:8.12 (4.2%) stddev-sans-first:8.19 10:38:48 INFO - PID 28503 | Values: 188.0 214.0 202.0 199.0 186.0 192.0 191.0 195.0 193.0 192.0 10:38:48 INFO - PID 28503 | 10:38:48 INFO - PID 28503 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:74.80 Median:75.00 stddev:1.69 (2.2%) stddev-sans-first:1.76 10:38:48 INFO - PID 28503 | Values: 74.0 78.0 75.0 76.0 73.0 76.0 75.0 75.0 72.0 74.0 10:38:48 INFO - PID 28503 | -------- Summary: end -------- 10:38:48 INFO - PID 28503 | 10:38:49 INFO - TEST-INFO | 28503: exit 0 10:38:49 INFO - TEST-OK | kraken | took 93270ms 10:38:49 INFO - SUITE-END | took 1242s 10:38:49 INFO - Completed test suite (00:20:42) 10:38:49 INFO - javascript benchmark 10:38:50 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6767.595407623676, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2732.0847516082113, 2736.0697362896613, 2758.6275852759873, 2785.874635641396, 2788.3308006078532, 5239.240310155025, 5241.161414173733, 5324.680519168848, 5341.786328546854, 5360.892782144359, 5321.36143662761, 5324.733763311839, 5327.520523152915, 5405.675659460435, 5415.864603384917, 4684.906301873969, 4711.835085771999, 4753.572178503934, 4777.18787806072, 4784.808607655689, 4600.792964316597, 4755.809767609308, 4784.40194975628, 4821.566059054684, 4828.589569886564, 4654.138984287883, 4769.809207631691, 4778.187708089598, 4823.155947709154, 4877.02459508098, 4711.081339138869, 4714.269288260325, 4722.83470078549, 4761.023990082025, 4808.567228949411, 4692.8122875084955, 4714.740689262089, 4720.622350211975, 4739.099571081483, 4758.809647614091, 5318.7074710891275, 5322.600804939645, 5341.679499230058, 5347.4919882611475, 5348.973255133738, 5667.0366037773265, 5690.089585666274, 5748.051571490699, 5749.798757043525, 5767.826965191051, 5826.854328641775, 5828.737706803204, 5834.387389324144, 5854.97072514639, 5881.3530511643685, 5370.248165256867, 5372.91940620891, 5393.83818485446, 5396.4873337033705, 5396.9730151348995, 5770.16332631766, 5880.705964701748, 5914.142449344821, 5969.73136208863, 5970.671613061323, 5738.2540269765495, 5743.0, 5744.827655170351, 5746.655200687972, 5783.826485205366, 5796.739146738407, 5808.925348810483, 5810.564207684441, 5810.983077961424, 5838.38696936824, 5569.498745112959, 5784.1034639630925, 5801.767929282866, 5809.099589563624, 5813.6221145625395, 5686.431356864363, 5697.344805347355, 5714.828555143353, 5781.132830075522, 5782.826515204551, 4763.237881938873, 4768.690035147704, 4781.760911954458, 4795.232762757942, 4809.927851082237, 4086.2440448516527, 4095.0990782027907, 4103.0, 4117.197146556453, 4142.565030671796, 4754.904901901942, 4775.283707443842, 4809.687370320918, 4809.9418128011785, 4845.854624361275, 5817.563682723812, 5849.093390524476, 5855.473007429352, 5876.382979787147, 5878.647281163144, 4825.95174048255, 4849.393825771778, 4850.151223535867, 4853.665242058462, 4877.878053048702, 4924.0, 5066.695998240118, 5071.670341427795, 5094.363204599425, 5106.974465127651, 5323.840284791462, 5349.812756553502, 5381.892362152813, 5413.945860541502, 5431.402545719889, 5562.944370556243, 5635.098384258499, 5644.491995720405, 5807.448292412214, 5823.679697616672, 5372.059889519397, 5415.5938304626525, 5451.936872310021, 5455.263539422127, 5473.151661492316, 5646.096624540054, 5769.740361683818, 5773.24947756789, 5774.3648198697265, 5785.0, 5657.858553536194, 5717.42825717425, 5735.311762588516, 5743.483086522233, 5799.536037116936, 5562.249096371938, 5569.275994120739, 5588.6646801192055, 5592.0, 5607.046802043581, 5479.315085614298, 5551.306086739158, 5562.638428502134, 5566.0, 5566.165075238585, 5408.378036525693, 5486.2394485790555, 5488.725563721878, 5496.4503549646315, 5499.780008799603, 5568.526675232489, 5606.327240731139, 5649.406812284651, 5709.115087161496, 5712.428757124254, 5499.340079190362, 5504.669719816824, 5512.09050506678, 5526.281583394133, 5553.139263414178], "value": 5214.655477016228, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [678.575890068707, 742.4728442805608, 757.1103952855395, 1094.228568858954, 1094.9835752463719, 33272.66727332726, 34478.48282275768, 34487.48268775964, 34495.31009379811, 34593.0, 35879.2824143517, 36326.81836590813, 36390.8180459098, 36403.27193456129, 36422.0, 6651.467882569407, 6838.521303508756, 6870.759523416681, 6992.650367481631, 6995.0, 6874.175098988104, 6957.7216911323485, 6973.198082220559, 6973.6513174341335, 6977.476689248301, 6875.484338674594, 6966.477514186431, 6967.233604303523, 6970.128733908262, 7007.82480437988, 6948.478864085188, 6970.825729356756, 6980.336867997532, 6980.895286570655, 6982.057422248033, 6798.592084474947, 6843.3840954314355, 6848.486363522756, 6865.27914568968, 6865.5537390069985, 32360.0, 32531.83734081338, 32545.0, 32640.673593264, 32689.83655081733, 3038.346755447589, 3069.2480342316053, 3075.9231019224476, 3079.276370053036, 3089.6137982752157, 25000.49999000028, 25191.0, 25205.36986575332, 25232.873835630704, 25320.873395633087, 2903.404802015603, 2914.7813913956325, 2915.1400336900665, 2918.1829087855435, 2919.9562006569918, 123755.0, 124436.0, 137044.31477842646, 149219.0, 149417.0, 40684.59315406867, 40837.89526309211, 40910.79544602258, 40939.7953010233, 41048.0, 41832.05191013698, 41974.0, 41999.58000419957, 42037.78981105075, 42052.36921446181, 13294.401751921187, 13397.598072057659, 13398.598042058753, 13405.262710550818, 13405.932970335281, 10768.515416806262, 10834.295770774874, 10855.945720271506, 10861.511231994578, 10880.836787448194, 12703.428345724464, 12716.872831271754, 12735.681607959876, 12735.936320318338, 12952.222866628032, 5213.139831927765, 5246.422893481714, 5299.682019078868, 5315.069862773999, 5357.285588681935, 861.4486728493769, 877.7191298784455, 904.0913881549001, 909.7589138878203, 922.2207234886511, 20813.004878829273, 21248.17532844103, 21677.78322216789, 21690.0, 21891.890540547513, 974.1768205866032, 991.3902949686036, 1004.0511716428051, 1004.3020101029714, 1011.939283642969, 10960.890391096147, 11037.779244415227, 11379.829302560469, 11406.543738250542, 11416.657500275005, 168766.0, 170353.14823425803, 171169.0, 171237.0, 171598.14200929165, 41509.1698166035, 41520.792396037825, 41584.12871420793, 41605.791971040555, 41615.58384416117, 1202.2220790612203, 1220.597202923051, 1223.1499108119772, 1238.0219626494968, 1238.3436778507405, 20259.29092481815, 20616.175352986313, 21085.0, 21198.682019769407, 21325.573488530452, 29249.561256580742, 29439.705602944552, 29481.410371792874, 29662.258443539085, 29667.406651867273, 151552.0, 152120.0, 152266.0, 152919.0, 153097.0, 28009.299767505974, 28048.85975570109, 28457.0, 28485.43029139447, 28501.144965651063, 34593.48109778405, 34677.82661086678, 35616.287674245854, 35735.46396804102, 36280.63719362773, 26782.59826102649, 27301.590476142475, 27490.725092748817, 27750.861245693643, 28030.2992425191, 26884.32789180208, 27163.592546111428, 27750.72249277562, 28529.0, 28874.711252888043, 30479.390412192075, 30811.691883080883, 30964.0, 30974.690253097182, 31136.844315778275, 25710.100146494784, 26429.471410572067, 26816.731832681424, 27079.1876243713, 27083.1875043749, 19892.70160947616, 21959.670604941257, 22019.0, 22073.889630551745, 22246.88876555607], "value": 14531.943914412794, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [401.33378591538053, 417.8942508603005, 429.33453147621196, 438.09751911063233, 440.9625181859542, 17076.487705368843, 17651.382201622946, 17828.55428614285, 19403.805961940376, 19923.70114448281, 18852.717209241837, 19135.617287654237, 19416.126274317656, 19573.608527829434, 19582.314618988337, 5431.185322201662, 5545.445455454463, 5584.5811564132755, 5608.831735047955, 5757.280339957505, 5457.426970168135, 5550.972245138769, 5556.305461817273, 5565.6104072714725, 5565.9443405566035, 5385.380681221671, 5498.285222921035, 5514.91727624086, 5544.805931792388, 5545.944540554603, 5487.478689524509, 5516.972415137919, 5530.032244357261, 5534.806281780158, 5545.4731800478685, 4650.813967441299, 4796.760161991887, 4842.539958703953, 4994.87512812179, 5016.197408414636, 22440.77559224403, 22596.54806903869, 22773.658395124086, 22847.88576057109, 22873.542529149323, 1571.552107649326, 1592.800899887514, 1639.5245378840123, 1642.531878414658, 1647.184643601413, 14406.351714172888, 14543.490977815725, 15072.773908391382, 15180.468683596022, 15193.316300766492, 1996.950076248091, 2027.5742094160244, 2053.301877361689, 2059.1969132038516, 2070.4306315763133, 88340.55829720874, 92691.0, 95048.0, 98463.50768246184, 99068.50465747625, 10728.517216725266, 10736.08743256832, 10748.355098693946, 11099.278546894588, 11304.886951130547, 14417.495387661382, 14420.42318307256, 14449.34977925996, 14502.637434064232, 14516.564503064925, 7104.467164962649, 7499.775006749806, 7567.432442566829, 7741.303282704584, 7794.649240784065, 6911.5853048817235, 6954.930450695429, 7124.857502850017, 7147.964260178665, 7178.497505174588, 6606.141201643755, 6614.107095542136, 6659.2008958925235, 6703.430208432338, 6782.559133656297, 2017.6872584749387, 2060.9278675246296, 2061.8762874227596, 2076.927307544229, 2236.0, 833.8332333533197, 864.1358641358642, 875.3216257400566, 896.2605850173503, 897.0625696147541, 16894.324227030782, 16967.575810604834, 16996.23516941716, 17554.824451755318, 17555.385561505285, 865.7013330401002, 872.8647059705755, 881.5019513974584, 881.8985816631041, 901.5492253873064, 9225.630974761069, 9362.578683959238, 9714.979927107694, 9727.805443891082, 9893.208543316518, 347033.0, 348992.0, 350834.0, 352817.0, 356401.0, 71389.2861071393, 72269.0, 75784.0, 80369.59815201003, 81054.594727026, 884.3014018925235, 904.9728508144766, 929.4516235420999, 938.6198589571235, 940.1256831146962, 16145.838541614434, 16298.755518667467, 16813.0, 16822.495325140266, 17074.2316595756, 37487.0, 38534.0, 39124.0, 39297.410538841366, 39710.602893971845, 47490.0, 47587.762061189474, 47588.2861757067, 48262.75868620635, 49623.25565116454, 8234.0, 8310.83378332442, 8465.576721163794, 8477.152284771473, 8755.824883502168, 11546.826797597874, 12418.75162496727, 12912.870871291167, 13151.671208219872, 13496.0, 10598.661421652156, 11191.944040279746, 11368.147388945697, 11613.593524226611, 11966.940165299466, 11109.277896936997, 11190.384528850665, 11201.66395008151, 11305.830412543653, 11465.770684586429, 11046.502907369028, 11156.832647510131, 11222.607208747655, 11732.12009099304, 12024.398780061138, 7986.281234688906, 8183.263506284463, 8187.1403502631365, 8201.712940047308, 8498.065212826461, 10814.134869210602, 11001.61494347694, 11005.61480348216, 11074.446277686244, 11156.944215278872], "value": 8840.314063108966, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1237.4988129807427, 1305.4125643460438, 1307.797291419829, 1316.203696763458, 1318.426484479251, 10062.597496100156, 10509.264351495398, 10567.577296908134, 10620.575176992921, 10804.13566914645, 9811.166050885666, 9961.103500684936, 9962.402255864654, 9973.650922217725, 9997.50012499374, 2172.2614311134253, 2232.174095584636, 2232.520008198237, 2233.184887516053, 2238.7649296823843, 2076.3667081540125, 2116.8941552922292, 2118.7669356370866, 2120.2579097315893, 2124.2565102214257, 2095.2038225474375, 2124.330835786722, 2132.8080472757447, 2135.9252426165085, 2140.422086036777, 2027.2397850805949, 2028.482736902088, 2033.83729301657, 2048.6005228980357, 2049.149602914796, 1697.295622316737, 1761.7621621081119, 1991.9203231870708, 1992.930247441347, 2048.6926960955825, 9628.71113866585, 9811.90188098117, 9865.90134098657, 9877.357971731815, 9881.407115573016, 5472.945270547283, 5717.685527295997, 5718.285214348207, 5726.656400615935, 5730.455606717355, 3146.166265939528, 3286.3263031078573, 3344.0302312329395, 3349.514320423549, 3370.7471939604384, 1027.3733022856052, 1037.2946396450411, 1051.437480947697, 1056.7675111475462, 1078.9730256743567, 14066.367013484418, 14301.642458938506, 14331.42674293027, 14362.85637143636, 14393.640158996004, 4691.108689349013, 4889.193283108248, 5069.670471419346, 5073.365829271341, 5102.540771330598, 12749.617511474671, 12785.0, 12812.0, 12816.0, 12854.485820567259, 5550.583706221969, 5631.71841407928, 5653.321601407857, 5653.858653533613, 5669.6314739541795, 5019.598432125421, 5060.240963855377, 5082.1360368737405, 5083.644144909895, 5090.745462726849, 4150.792460376969, 4165.540158579573, 4206.47419072616, 4228.725132866354, 4278.893027674333, 1255.0963306419364, 1293.7218498022971, 1296.5591698822445, 1303.270168705509, 1307.4378017452586, 622.390057743414, 636.3096040795789, 647.666451777335, 663.6283681138482, 690.8031211104811, 6099.573029887954, 6240.469560087444, 6267.185265915493, 6325.367463253638, 6449.645269510222, 841.7306461932122, 857.9399442038997, 858.5578427110044, 877.7103555826562, 892.0588778838388, 3737.4580685800406, 3761.2101458693433, 3832.463455116286, 3876.089119057019, 4120.134771697917, 13050.216986980811, 13122.212667239995, 13216.405261763244, 13491.460341586228, 13507.0, 12841.678958025937, 13370.130941488773, 13387.866121338857, 13406.128601640861, 13559.25424101664, 6848.212455567674, 6948.965255173692, 6953.79138625842, 7018.192907815666, 7022.262662420372, 5578.553715702815, 6027.909581356195, 6046.3046749624355, 6060.333363329942, 6270.717817698306, 12007.459664314953, 12114.636560903187, 12275.386230688251, 12330.75338493243, 12395.93802030984, 12334.568290109803, 12487.875121249035, 12580.30808305552, 12682.0, 12704.237745735285, 8006.95996520037, 8176.959115204386, 8207.015158181057, 8232.053313868983, 8234.300084492885, 8854.335924805537, 8954.462732236087, 8979.640814367353, 9004.41471304363, 9010.954945225232, 7648.23517648253, 7876.763697089096, 7926.801829954066, 7936.880946785918, 8152.83694326122, 7629.847403052019, 7686.3850891927395, 7736.303732664087, 7854.293113619573, 7928.7621371358955, 7026.613536255555, 7060.752873649398, 7095.0, 7098.574085554883, 7129.429645628234, 4611.723296602215, 5353.705546194997, 5457.672539647634, 5462.562994960473, 5481.397046324981, 5056.974715126401, 5152.149895267239, 5168.664036837594, 5265.736713164403, 5274.551663108526], "value": 4726.819654056101, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [362.74426529296846, 363.95632524097107, 364.34054361605496, 365.8408592262366, 368.6571488515679, 5617.623682197857, 5618.438156184379, 5619.887602247958, 5665.773369065243, 5666.603337766358, 5183.948160518394, 5480.123180291154, 5507.339119305689, 5512.145617429295, 5522.751476183581, 4063.5326937402133, 4103.692223083273, 4109.835606575748, 4123.092919557693, 4125.051238215212, 4109.0, 4115.991582062399, 4117.114820313632, 4119.546849846514, 4134.669226461876, 4085.3667681509414, 4085.897852553695, 4086.346184610463, 4094.4472496213075, 4113.958860411402, 4029.2344454553686, 4074.5721699221453, 4087.4686290782306, 4098.098418347959, 4106.466159399274, 3559.181388280684, 3567.3935430976535, 3573.6426357364057, 3578.2306804037, 3581.3374525712825, 5318.547923426513, 5332.986862422718, 5354.9196762048605, 5356.250124982505, 5379.38137114233, 4727.952720472786, 4813.759312034419, 4841.7579121044155, 4842.273658951185, 4842.903141937177, 5779.971100144515, 5785.322256545597, 5788.942110578882, 5804.926088673609, 5805.970970145165, 3964.8215830287418, 3982.820773065219, 3988.142549351874, 3990.660793832528, 3990.700697447703, 5896.882062358772, 6080.513558915321, 6105.358937311607, 6167.229096362955, 6176.3514830943, 4043.211573743092, 4075.3886916962692, 4075.918481630351, 4081.551029386765, 4089.1208390196252, 4109.178164367078, 4113.239050775616, 4118.75287482752, 4121.649659778893, 4133.379993001014, 4645.558671926162, 4735.905281894412, 4778.378810754649, 4787.0, 4790.760461976887, 5769.278840144982, 5790.160426738099, 5799.8550036249435, 5800.680962547016, 5808.128780682847, 1415.3206460898825, 1436.5187662133094, 1438.3311760031427, 1439.5321520505877, 1440.683049729058, 926.7358802741186, 950.8668786369914, 958.4776296918196, 964.9807003859884, 965.5751469353462, 4962.684888504549, 4980.0, 4991.301217829507, 4992.775325110379, 5011.57401620859, 6003.339632640406, 6021.5182785377065, 6025.427584379477, 6025.879482410415, 6036.456718895321, 4804.663673542818, 4962.578180854595, 4964.553190212898, 4994.875128121826, 5019.0965626187635, 3165.525171224289, 3217.2117831131523, 3219.114743445571, 3220.5169224616025, 3240.481522956363, 5466.961277357289, 5595.272614560163, 5600.243967064394, 5618.634788738719, 5658.811649553558, 6028.487578555784, 6191.721372538246, 6225.750969961241, 6234.643121117126, 6262.780802671885, 5576.888462230732, 5585.357683866408, 5598.188262701886, 5607.66354018752, 5610.1584762285165, 6015.849603759941, 6055.424734650202, 6060.424259695322, 6088.665123418077, 6101.359357267423, 5677.545796336366, 5908.438698323653, 5935.0, 5959.135925290895, 5965.403459654173, 5568.248286481273, 5578.995780759502, 5580.190872323409, 5606.103023516218, 5607.243022191952, 3924.313245182139, 4031.576684448091, 4068.5995262795095, 4093.7748423836974, 4123.731957422758, 6096.177016102769, 6100.908486372797, 6102.755889764359, 6126.356732543197, 6127.290616774625, 5896.518645829115, 5926.2295901532525, 5927.7036148191555, 5931.822045338647, 5945.940540594539, 5784.479396854135, 5835.6790376528, 5872.647641141545, 5899.911501327398, 5911.556633252438, 5789.507891829242, 5831.1544826000845, 5833.445822646841, 5837.620554663933, 5846.1815345852465, 5873.119032145212, 5943.7028148591535, 5948.643081415129, 5950.4644581986095, 5998.310194327708, 5674.432556744293, 5709.400512946247, 5737.053386191398, 5759.568032397503, 5772.826815195551], "value": 4328.973997665648, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [633.37612451735, 649.8667773106514, 723.4971694672201, 760.3574979142625, 772.9922700772994, 12888.42002109905, 13291.401886915088, 13405.664858378545, 13885.86114138857, 13902.860971390282, 15118.848811511882, 16185.676286474263, 16275.348986040544, 16290.592735181626, 16309.0, 887.6316328723572, 901.0808974845653, 904.3579058868212, 907.7639813648466, 909.636145541782, 887.8934527856634, 889.4485419040204, 889.9332550058739, 893.2184338703635, 898.0435835834814, 902.1294450854924, 912.4114945859916, 928.9163975242227, 931.74842792446, 933.6872147830485, 910.5902343945218, 913.4245425382034, 916.812053529025, 919.1819280840058, 921.7511271956602, 671.6574546981026, 672.9562578432386, 673.1417442760519, 674.7874419557824, 678.1929503890404, 13845.584632461043, 13851.099678520864, 13864.514741983981, 13888.375023123983, 13925.721485570231, 15504.224788760517, 16163.272652730655, 16278.918605406898, 16298.592535186597, 16311.102889341082, 11973.700657483545, 11982.58060967862, 12055.879441205563, 12100.878991210064, 12117.575884843987, 2983.3287510310224, 3000.6699263081046, 3023.818570885754, 3025.1529571719734, 3033.1810411188853, 83191.58404208001, 84045.0, 84113.15886841176, 84608.57695711544, 85360.57319713486, 12540.310282934344, 12660.113792034654, 12786.0, 12920.741585168244, 12946.0, 23881.283561493183, 24382.146624868044, 24567.38581535476, 24578.262652120466, 24629.753702463106, 5888.970555147197, 5953.255843019622, 6002.879942401128, 6007.609505382136, 6017.939820601826, 2809.35384861483, 2906.2007947814095, 2906.244376462093, 2909.2435966648823, 2910.6798252192243, 3431.0907609483506, 3477.3914564951033, 3481.5029537298697, 3502.824858757103, 3507.316073365669, 744.5495475237511, 805.923437273458, 806.8709006558922, 808.8422757562219, 813.8982627171604, 601.1073555769678, 614.6619359352338, 615.689077016113, 618.5577312221783, 629.3643420145686, 8923.107689231025, 9228.676996305097, 9462.29032822541, 9698.46658433793, 9859.161971232526, 550.8622844288927, 554.8945700317007, 563.5829486180279, 567.3163837575711, 571.8627529392999, 4209.537420608917, 4352.912941741148, 4439.977800110979, 4499.1451624191295, 4539.977300113478, 83899.0, 84244.57877710694, 84350.15649843546, 87256.56371718101, 87531.0, 74452.0, 75938.0, 79620.0, 79721.60139199383, 79738.60130699309, 67449.0, 69403.30596693969, 69578.0, 70227.64886175537, 71405.64297178481, 8604.311655067704, 8940.240079593308, 9018.594163262538, 9072.364934454525, 9213.309001824757, 29278.0, 29320.413591727618, 29568.112956611338, 29906.252343691584, 29953.0, 37388.626113738515, 37845.62154378531, 37996.81001594974, 38335.233295334496, 38561.0, 12319.322437266037, 12459.501619935101, 12519.123661343983, 12645.557405490763, 12647.620571382873, 13184.077114601885, 13651.249181295125, 13684.0, 13721.794173087212, 15564.533064008097, 13533.255670938193, 13686.31568421555, 13860.168389896638, 14824.332905019084, 15034.32345544475, 13788.103773254707, 13966.4413423466, 13982.650433739238, 14113.576592702235, 14295.785563216352, 13488.988325875795, 13844.30778461093, 13986.790198147239, 14050.086744361584, 14543.563693089225, 8834.381593288408, 9062.275017998676, 9183.862242066241, 10426.0, 10509.579616815548, 11431.0, 12309.384530773605, 12377.381130943237, 12388.132830701765, 12500.37498125072], "value": 7008.157646563727, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1563.8, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [103.0, 112.0, 111.0, 110.0, 111.0, 113.0, 111.0, 111.0, 112.0, 111.0], "value": 110.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 126.0, 126.0, 180.0, 123.0, 122.0, 122.0, 125.0, 147.0, 128.0], "value": 134.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 165.0, 166.0, 168.0, 168.0, 181.0, 167.0, 167.0, 162.0, 165.0], "value": 167.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 77.0, 74.0, 115.0, 74.0, 75.0, 78.0, 74.0, 104.0, 74.0], "value": 81.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 84.0, 114.0, 84.0, 85.0, 84.0, 98.0, 84.0, 84.0, 116.0], "value": 91.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 116.0, 114.0, 114.0, 114.0, 115.0, 119.0, 115.0, 114.0, 114.0], "value": 114.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 150.0, 151.0, 151.0, 150.0, 150.0, 151.0, 149.0, 152.0, 151.0], "value": 150.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 97.0, 95.0, 94.0, 95.0, 94.0, 95.0, 95.0, 95.0, 94.0], "value": 94.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 55.0, 57.0, 58.0, 57.0, 57.0, 63.0, 59.0, 60.0, 57.0], "value": 57.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 56.0, 59.0, 59.0, 60.0, 58.0, 56.0, 56.0, 59.0, 57.0], "value": 57.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 89.0, 88.0, 88.0, 87.0, 89.0, 89.0, 89.0, 140.0, 88.0], "value": 93.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [144.0, 139.0, 136.0, 145.0, 135.0, 140.0, 132.0, 135.0, 136.0, 141.0], "value": 138.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [188.0, 214.0, 202.0, 199.0, 186.0, 192.0, 191.0, 195.0, 193.0, 192.0], "value": 195.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 78.0, 75.0, 76.0, 73.0, 76.0, 75.0, 75.0, 72.0, 74.0], "value": 74.8, "unit": "score"}]}]} 10:38:50 INFO - Return code: 0 10:38:50 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 10:38:50 INFO - # TBPL SUCCESS # 10:38:50 INFO - Running post-action listener: _resource_record_post_action 10:38:50 INFO - [mozharness: 2017-05-30 17:38:50.075791Z] Finished run-tests step (success) 10:38:50 INFO - Running post-run listener: _resource_record_post_run 10:38:50 INFO - Total resource usage - Wall time: 1259s; CPU: 13.0%; Read bytes: 8192; Write bytes: 410873856; Read time: 48; Write time: 377768 10:38:50 INFO - TinderboxPrint: CPU usage
12.7% 10:38:50 INFO - TinderboxPrint: I/O read bytes / time
8,192 / 48 10:38:50 INFO - TinderboxPrint: I/O write bytes / time
410,873,856 / 377,768 10:38:50 INFO - TinderboxPrint: CPU idle
8,770.6 (87.3%) 10:38:50 INFO - TinderboxPrint: CPU user
1,224.8 (12.2%) 10:38:50 INFO - TinderboxPrint: Swap in / out
0 / 0 10:38:50 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 95637504; Read time: 0; Write time: 132624 10:38:50 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 10:38:50 INFO - run-tests - Wall time: 1243s; CPU: 13.0%; Read bytes: 4096; Write bytes: 310841344; Read time: 28; Write time: 244648 10:38:50 INFO - Running post-run listener: _upload_blobber_files 10:38:50 INFO - Blob upload gear active. 10:38:50 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 10:38:50 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 10:38:50 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'] 10:38:50 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 10:38:51 INFO - (blobuploader) - INFO - Open directory for files ... 10:38:51 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 10:38:51 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:38:51 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:38:53 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 10:38:53 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:38:53 INFO - (blobuploader) - INFO - Done attempting. 10:38:53 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 10:38:53 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:38:53 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:39:00 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 10:39:00 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:39:00 INFO - (blobuploader) - INFO - Done attempting. 10:39:00 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 10:39:00 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:39:00 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:39:01 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 10:39:01 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:39:01 INFO - (blobuploader) - INFO - Done attempting. 10:39:01 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 10:39:01 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:39:01 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:39:02 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 10:39:02 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:39:02 INFO - (blobuploader) - INFO - Done attempting. 10:39:02 INFO - (blobuploader) - INFO - Iteration through files over. 10:39:02 INFO - Return code: 0 10:39:02 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 10:39:02 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 10:39:02 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/51b08292db73fa499aa8253c0696c3fe55e9d9add6dd3a3dbe040e5a833c49712f256206a3ec8b32d53b07630e2f91c7a74f0ede839caea79e25b0a8fc483b69", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5da5ccd706b3e903bdf60171feebdc4db1b0f91a3d597e692e7e293a1484f8dbc455feb63415106a0521dbd8bef60901b511fcc16b4129a80d8ef2bcec959c52", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6fd9ccaa2c5166dafb8826e4a7d8b3a2a8600bb0b21bed2955629f2a1dfa3f562b09aa470a1a631c624bfdef896313ba0dacad34fba0973060f188740f2b36c5", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c6616159cf7127a79e015ab96dc3caf9fe4de340e08cc9df16bd2a377b04ebfae1260f2d2ab5e74f2492f81fa147a1f083c63a979b871054c1c32582b4dcd9d7"} 10:39:02 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 10:39:02 INFO - Writing to file /builds/slave/test/properties/blobber_files 10:39:02 INFO - Contents: 10:39:02 INFO - blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/51b08292db73fa499aa8253c0696c3fe55e9d9add6dd3a3dbe040e5a833c49712f256206a3ec8b32d53b07630e2f91c7a74f0ede839caea79e25b0a8fc483b69", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5da5ccd706b3e903bdf60171feebdc4db1b0f91a3d597e692e7e293a1484f8dbc455feb63415106a0521dbd8bef60901b511fcc16b4129a80d8ef2bcec959c52", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6fd9ccaa2c5166dafb8826e4a7d8b3a2a8600bb0b21bed2955629f2a1dfa3f562b09aa470a1a631c624bfdef896313ba0dacad34fba0973060f188740f2b36c5", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c6616159cf7127a79e015ab96dc3caf9fe4de340e08cc9df16bd2a377b04ebfae1260f2d2ab5e74f2492f81fa147a1f083c63a979b871054c1c32582b4dcd9d7"} 10:39:02 INFO - Running post-run listener: copy_logs_to_upload_dir 10:39:02 INFO - Copying logs to upload dir... 10:39:02 INFO - mkdir: /builds/slave/test/build/upload/logs 10:39:02 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1324.565112 ========= master_lag: 0.08 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 22 mins, 4 secs) (at 2017-05-30 10:39:02.333033) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-30 10:39:02.340692) ========= 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=17051fcd5208b27b50bedfeb000001dd-1496163639.7311-460824820 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/51b08292db73fa499aa8253c0696c3fe55e9d9add6dd3a3dbe040e5a833c49712f256206a3ec8b32d53b07630e2f91c7a74f0ede839caea79e25b0a8fc483b69", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5da5ccd706b3e903bdf60171feebdc4db1b0f91a3d597e692e7e293a1484f8dbc455feb63415106a0521dbd8bef60901b511fcc16b4129a80d8ef2bcec959c52", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6fd9ccaa2c5166dafb8826e4a7d8b3a2a8600bb0b21bed2955629f2a1dfa3f562b09aa470a1a631c624bfdef896313ba0dacad34fba0973060f188740f2b36c5", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c6616159cf7127a79e015ab96dc3caf9fe4de340e08cc9df16bd2a377b04ebfae1260f2d2ab5e74f2492f81fa147a1f083c63a979b871054c1c32582b4dcd9d7"} build_url:https://queue.taskcluster.net/v1/task/HBqQiDo4QyKrkFlGz4wrrQ/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011373 build_url: 'https://queue.taskcluster.net/v1/task/HBqQiDo4QyKrkFlGz4wrrQ/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/51b08292db73fa499aa8253c0696c3fe55e9d9add6dd3a3dbe040e5a833c49712f256206a3ec8b32d53b07630e2f91c7a74f0ede839caea79e25b0a8fc483b69", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5da5ccd706b3e903bdf60171feebdc4db1b0f91a3d597e692e7e293a1484f8dbc455feb63415106a0521dbd8bef60901b511fcc16b4129a80d8ef2bcec959c52", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6fd9ccaa2c5166dafb8826e4a7d8b3a2a8600bb0b21bed2955629f2a1dfa3f562b09aa470a1a631c624bfdef896313ba0dacad34fba0973060f188740f2b36c5", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c6616159cf7127a79e015ab96dc3caf9fe4de340e08cc9df16bd2a377b04ebfae1260f2d2ab5e74f2492f81fa147a1f083c63a979b871054c1c32582b4dcd9d7"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-30 10:39:02.367786) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-30 10:39:02.368085) ========= 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=17051fcd5208b27b50bedfeb000001dd-1496163639.7311-460824820 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004597 ========= master_lag: 0.07 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-30 10:39:02.446789) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-30 10:39:02.447076) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-30 10:39:02.450388) ========= ========= Total master_lag: 0.25 =========