builder: mozilla-central_ubuntu64_hw_stylo_test-dromaeojs-e10s slave: talos-linux64-ix-067 starttime: 1496765948.05 results: success (0) revision: c511ad826fe71ba2bb956d2e1c119e86d2266aba ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-06-06 09:19:08.055106) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-06-06 09:19:08.055578) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-06-06 09:19:08.055902) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-06-06 09:19:08.138892) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-06-06 09:19:08.139236) ========= 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=e0e61f6f900f4dc42e3e8956000001ad-1496765643.857840-997882870 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-06-06 09:19:08-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 37.5M=0s 2017-06-06 09:19:08 (37.5 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.174681 ========= master_lag: 0.04 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-06-06 09:19:08.358596) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-06-06 09:19:08.362006) ========= 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=e0e61f6f900f4dc42e3e8956000001ad-1496765643.857840-997882870 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015644 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-06-06 09:19:08.411878) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-06-06 09:19:08.415286) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev c511ad826fe71ba2bb956d2e1c119e86d2266aba --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 c511ad826fe71ba2bb956d2e1c119e86d2266aba --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=e0e61f6f900f4dc42e3e8956000001ad-1496765643.857840-997882870 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-06-06 09:19:08,494 truncating revision to first 12 chars 2017-06-06 09:19:08,494 Setting DEBUG logging. 2017-06-06 09:19:08,494 attempt 1/10 2017-06-06 09:19:08,494 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/c511ad826fe7?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-06-06 09:19:09,780 unpacking tar archive at: mozilla-central-c511ad826fe7/testing/mozharness/ program finished with exit code 0 elapsedTime=1.621246 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-06-06 09:19:10.049998) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-06-06 09:19:10.050380) ========= script_repo_revision: c511ad826fe71ba2bb956d2e1c119e86d2266aba ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-06-06 09:19:10.050836) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-06-06 09:19:10.051169) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-06-06 09:19:10.060166) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 22 mins, 1 secs) (at 2017-06-06 09:19:10.060491) ========= /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=e0e61f6f900f4dc42e3e8956000001ad-1496765643.857840-997882870 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 09:19:10 INFO - MultiFileLogger online at 20170606 09:19:10 in /builds/slave/test 09:19:10 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 09:19:10 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 09:19:10 INFO - {'append_to_log': False, 09:19:10 INFO - 'base_work_dir': '/builds/slave/test', 09:19:10 INFO - 'blob_upload_branch': 'Firefox', 09:19:10 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 09:19:10 INFO - 'branch': 'Firefox', 09:19:10 INFO - 'buildbot_json_path': 'buildprops.json', 09:19:10 INFO - 'config_files': ('talos/linux_config.py',), 09:19:10 INFO - 'default_actions': ('clobber', 09:19:10 INFO - 'read-buildbot-config', 09:19:10 INFO - 'download-and-extract', 09:19:10 INFO - 'populate-webroot', 09:19:10 INFO - 'create-virtualenv', 09:19:10 INFO - 'install', 09:19:10 INFO - 'setup-mitmproxy', 09:19:10 INFO - 'run-tests'), 09:19:10 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:19:10 INFO - 'download_minidump_stackwalk': True, 09:19:10 INFO - 'download_symbols': 'ondemand', 09:19:10 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:19:10 INFO - 'tooltool.py': '/tools/tooltool.py', 09:19:10 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:19:10 INFO - '/tools/misc-python/virtualenv.py')}, 09:19:10 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:19:10 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:19:10 INFO - 'gecko_profile': False, 09:19:10 INFO - 'gecko_profile_interval': 0, 09:19:10 INFO - 'installer_path': 'installer.exe', 09:19:10 INFO - 'log_level': 'info', 09:19:10 INFO - 'log_name': 'talos', 09:19:10 INFO - 'log_to_console': True, 09:19:10 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 09:19:10 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 09:19:10 INFO - 'opt_config_files': (), 09:19:10 INFO - 'pip_index': False, 09:19:10 INFO - 'suite': 'dromaeojs-e10s', 09:19:10 INFO - 'system_bits': '32', 09:19:10 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:19:10 INFO - 'title': 'talos-linux64-ix-067', 09:19:10 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:19:10 INFO - 'use_talos_json': True, 09:19:10 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 09:19:10 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:19:10 INFO - 'work_dir': 'build'} 09:19:10 INFO - [mozharness: 2017-06-06 16:19:10.348550Z] Running clobber step. 09:19:10 INFO - Running pre-action listener: _resource_record_pre_action 09:19:10 INFO - Running main action method: clobber 09:19:10 INFO - rmtree: /builds/slave/test/build 09:19:10 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 09:19:11 INFO - Running post-action listener: _resource_record_post_action 09:19:11 INFO - [mozharness: 2017-06-06 16:19:11.331586Z] Finished clobber step (success) 09:19:11 INFO - [mozharness: 2017-06-06 16:19:11.331687Z] Running read-buildbot-config step. 09:19:11 INFO - Running pre-action listener: _resource_record_pre_action 09:19:11 INFO - Running main action method: read_buildbot_config 09:19:11 INFO - Using buildbot properties: 09:19:11 INFO - { 09:19:11 INFO - "project": "", 09:19:11 INFO - "product": "firefox", 09:19:11 INFO - "who": "ffxbld@noreply.mozilla.org", 09:19:11 INFO - "installer_path": "public/build/target.tar.bz2", 09:19:11 INFO - "builddir": "mozilla-central_ubuntu64_hw_stylo_test-dromaeojs-e10s", 09:19:11 INFO - "repository": "https://hg.mozilla.org/mozilla-central/", 09:19:11 INFO - "buildername": "Ubuntu HW 12.04 x64 stylo mozilla-central talos dromaeojs-e10s", 09:19:11 INFO - "stage_platform": "linux64-stylo", 09:19:11 INFO - "basedir": "/builds/slave/test", 09:19:11 INFO - "buildnumber": 140, 09:19:11 INFO - "platform": "ubuntu64_hw_stylo", 09:19:11 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 09:19:11 INFO - "slavebuilddir": "test", 09:19:11 INFO - "taskId": "SxNWSv3BQdq2RbihLQdW6g", 09:19:11 INFO - "branch": "mozilla-central", 09:19:11 INFO - "script_repo_revision": "production", 09:19:11 INFO - "revision": "c511ad826fe71ba2bb956d2e1c119e86d2266aba", 09:19:11 INFO - "slavename": "talos-linux64-ix-067", 09:19:11 INFO - "repo_path": "mozilla-central" 09:19:11 INFO - } 09:19:11 INFO - Finding installer, test and symbols from parent task. 09:19:11 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/SxNWSv3BQdq2RbihLQdW6g'}, attempt #1 09:19:11 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/SxNWSv3BQdq2RbihLQdW6g'}, attempt #1 09:19:12 INFO - Task dependencies: ECGZ_RQZS4CyP3kbNjdMZw 09:19:12 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ECGZ_RQZS4CyP3kbNjdMZw'}, attempt #1 09:19:12 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/ECGZ_RQZS4CyP3kbNjdMZw/artifacts/public/build/target.tar.bz2 09:19:12 INFO - Set test_url: https://queue.taskcluster.net/v1/task/ECGZ_RQZS4CyP3kbNjdMZw/artifacts/public/build/test_packages.json 09:19:12 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/ECGZ_RQZS4CyP3kbNjdMZw/artifacts/public/build/target.crashreporter-symbols.zip 09:19:12 INFO - Running post-action listener: _resource_record_post_action 09:19:12 INFO - [mozharness: 2017-06-06 16:19:12.717344Z] Finished read-buildbot-config step (success) 09:19:12 INFO - [mozharness: 2017-06-06 16:19:12.717565Z] Running download-and-extract step. 09:19:12 INFO - Running pre-action listener: _resource_record_pre_action 09:19:12 INFO - Running main action method: download_and_extract 09:19:12 INFO - mkdir: /builds/slave/test/build/tests 09:19:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:19:12 INFO - trying https://queue.taskcluster.net/v1/task/ECGZ_RQZS4CyP3kbNjdMZw/artifacts/public/build/target.test_packages.json 09:19:12 INFO - Downloading https://queue.taskcluster.net/v1/task/ECGZ_RQZS4CyP3kbNjdMZw/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 09:19:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ECGZ_RQZS4CyP3kbNjdMZw/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 09:19:13 INFO - Downloaded 989 bytes. 09:19:13 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 09:19:13 INFO - Using the following test package requirements: 09:19:13 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 09:19:13 INFO - u'common': [u'target.common.tests.zip'], 09:19:13 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 09:19:13 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 09:19:13 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 09:19:13 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 09:19:13 INFO - u'mozbase': [u'target.common.tests.zip'], 09:19:13 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 09:19:13 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 09:19:13 INFO - u'web-platform': [u'target.common.tests.zip', 09:19:13 INFO - u'target.web-platform.tests.tar.gz'], 09:19:13 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 09:19:13 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 09:19:13 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ECGZ_RQZS4CyP3kbNjdMZw/artifacts/public/build/target.common.tests.zip 09:19:13 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ECGZ_RQZS4CyP3kbNjdMZw/artifacts/public/build/target.common.tests.zip'}, attempt #1 09:19:13 INFO - Fetch https://queue.taskcluster.net/v1/task/ECGZ_RQZS4CyP3kbNjdMZw/artifacts/public/build/target.common.tests.zip into memory 09:19:15 INFO - Content-Length response header: 65103787 09:19:15 INFO - Bytes received: 65103787 09:19:26 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 09:19:26 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ECGZ_RQZS4CyP3kbNjdMZw/artifacts/public/build/target.common.tests.zip 09:19:26 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ECGZ_RQZS4CyP3kbNjdMZw/artifacts/public/build/target.common.tests.zip'}, attempt #1 09:19:26 INFO - Fetch https://queue.taskcluster.net/v1/task/ECGZ_RQZS4CyP3kbNjdMZw/artifacts/public/build/target.common.tests.zip into memory 09:19:28 INFO - Content-Length response header: 65103787 09:19:28 INFO - Bytes received: 65103787 09:19:40 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ECGZ_RQZS4CyP3kbNjdMZw/artifacts/public/build/target.talos.tests.zip 09:19:40 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ECGZ_RQZS4CyP3kbNjdMZw/artifacts/public/build/target.talos.tests.zip'}, attempt #1 09:19:40 INFO - Fetch https://queue.taskcluster.net/v1/task/ECGZ_RQZS4CyP3kbNjdMZw/artifacts/public/build/target.talos.tests.zip into memory 09:19:41 INFO - Content-Length response header: 14447479 09:19:41 INFO - Bytes received: 14447479 09:19:41 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')]} 09:19:41 INFO - trying https://queue.taskcluster.net/v1/task/ECGZ_RQZS4CyP3kbNjdMZw/artifacts/public/build/target.tar.bz2 09:19:41 INFO - Downloading https://queue.taskcluster.net/v1/task/ECGZ_RQZS4CyP3kbNjdMZw/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 09:19:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ECGZ_RQZS4CyP3kbNjdMZw/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 09:19:49 INFO - Downloaded 60499098 bytes. 09:19:49 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/ECGZ_RQZS4CyP3kbNjdMZw/artifacts/public/build/target.tar.bz2 09:19:49 INFO - mkdir: /builds/slave/test/properties 09:19:49 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 09:19:49 INFO - Writing to file /builds/slave/test/properties/build_url 09:19:49 INFO - Contents: 09:19:49 INFO - build_url:https://queue.taskcluster.net/v1/task/ECGZ_RQZS4CyP3kbNjdMZw/artifacts/public/build/target.tar.bz2 09:19:49 INFO - Running post-action listener: _resource_record_post_action 09:19:49 INFO - Running post-action listener: set_extra_try_arguments 09:19:49 INFO - [mozharness: 2017-06-06 16:19:49.170358Z] Finished download-and-extract step (success) 09:19:49 INFO - [mozharness: 2017-06-06 16:19:49.170585Z] Running populate-webroot step. 09:19:49 INFO - Running pre-action listener: _resource_record_pre_action 09:19:49 INFO - Running main action method: populate_webroot 09:19:49 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 09:19:49 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 09:19:49 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 09:19:49 INFO - '--tppagecycles', 09:19:49 INFO - '7'], 09:19:49 INFO - 'tests': ['tsvgm']}}, 09:19:49 INFO - 'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 09:19:49 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 09:19:49 INFO - 'tests': ['dromaeo_css', 'kraken']}, 09:19:49 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 09:19:49 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 09:19:49 INFO - 'talos_options': ['--disable-e10s'], 09:19:49 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:19:49 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 09:19:49 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:19:49 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 09:19:49 INFO - 'talos_options': ['--disable-e10s'], 09:19:49 INFO - 'tests': ['damp', 'tps']}, 09:19:49 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 09:19:49 INFO - 'tests': ['damp', 'tps']}, 09:19:49 INFO - 'g3': {'talos_options': ['--disable-e10s'], 09:19:49 INFO - 'tests': ['dromaeo_dom']}, 09:19:49 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:19:49 INFO - 'g4': {'talos_options': ['--disable-e10s'], 09:19:49 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 09:19:49 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 09:19:49 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 09:19:49 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 09:19:49 INFO - 'other': {'talos_options': ['--disable-e10s'], 09:19:49 INFO - 'tests': ['a11yr', 09:19:49 INFO - 'ts_paint', 09:19:49 INFO - 'tpaint', 09:19:49 INFO - 'sessionrestore', 09:19:49 INFO - 'sessionrestore_no_auto_restore', 09:19:49 INFO - 'tabpaint']}, 09:19:49 INFO - 'other-e10s': {'tests': ['a11yr', 09:19:49 INFO - 'ts_paint', 09:19:49 INFO - 'tpaint', 09:19:49 INFO - 'sessionrestore', 09:19:49 INFO - 'sessionrestore_no_auto_restore', 09:19:49 INFO - 'tabpaint']}, 09:19:49 INFO - 'other-e10s_l64': {'tests': ['a11yr', 09:19:49 INFO - 'ts_paint', 09:19:49 INFO - 'tpaint', 09:19:49 INFO - 'sessionrestore', 09:19:49 INFO - 'sessionrestore_no_auto_restore', 09:19:49 INFO - 'tabpaint']}, 09:19:49 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 09:19:49 INFO - 'ts_paint', 09:19:49 INFO - 'tpaint', 09:19:49 INFO - 'sessionrestore', 09:19:49 INFO - 'sessionrestore_no_auto_restore', 09:19:49 INFO - 'tabpaint']}, 09:19:49 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 09:19:49 INFO - 'tests': ['a11yr', 09:19:49 INFO - 'ts_paint', 09:19:49 INFO - 'tpaint', 09:19:49 INFO - 'sessionrestore', 09:19:49 INFO - 'sessionrestore_no_auto_restore', 09:19:49 INFO - 'tabpaint']}, 09:19:49 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 09:19:49 INFO - 'tests': ['a11yr', 09:19:49 INFO - 'ts_paint', 09:19:49 INFO - 'tpaint', 09:19:49 INFO - 'sessionrestore', 09:19:49 INFO - 'sessionrestore_no_auto_restore', 09:19:49 INFO - 'tabpaint']}, 09:19:49 INFO - 'perf-reftest': {'tests': ['bloom_basic', 'bloom_basic_ref']}, 09:19:49 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic', 09:19:49 INFO - 'bloom_basic_ref']}, 09:19:49 INFO - 'quantum-pageload-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set.zip', 09:19:49 INFO - 'talos_options': ['--mitmproxy', 09:19:49 INFO - 'mitmproxy-recording-1.mp', 09:19:49 INFO - '--firstNonBlankPaint'], 09:19:49 INFO - 'tests': ['Quantum_1']}, 09:19:49 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 09:19:49 INFO - 'tests': ['tsvgx', 09:19:49 INFO - 'tsvgr_opacity', 09:19:49 INFO - 'tart', 09:19:49 INFO - 'tscrollx', 09:19:49 INFO - 'cart', 09:19:49 INFO - 'tsvg_static']}, 09:19:49 INFO - 'svgr-e10s': {'tests': ['tsvgx', 09:19:49 INFO - 'tsvgr_opacity', 09:19:49 INFO - 'tart', 09:19:49 INFO - 'tscrollx', 09:19:49 INFO - 'cart', 09:19:49 INFO - 'tsvg_static']}, 09:19:49 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 09:19:49 INFO - 'talos_options': ['--disable-e10s'], 09:19:49 INFO - 'tests': ['tp5o']}, 09:19:49 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 09:19:49 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 09:19:49 INFO - 'talos_options': ['--disable-e10s', 09:19:49 INFO - '--xperf_path', 09:19:49 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:19:49 INFO - 'tests': ['tp5n']}, 09:19:49 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 09:19:49 INFO - 'talos_options': ['--xperf_path', 09:19:49 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:19:49 INFO - 'tests': ['tp5n']}}, 09:19:49 INFO - 'talos.zip': {'path': '', 09:19:49 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:19:49 INFO - Running post-action listener: _resource_record_post_action 09:19:49 INFO - [mozharness: 2017-06-06 16:19:49.195782Z] Finished populate-webroot step (success) 09:19:49 INFO - [mozharness: 2017-06-06 16:19:49.195898Z] Running create-virtualenv step. 09:19:49 INFO - Running pre-action listener: _resource_record_pre_action 09:19:49 INFO - Running main action method: create_virtualenv 09:19:49 INFO - Creating virtualenv /builds/slave/test/build/venv 09:19:49 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 09:19:49 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 09:19:49 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 09:19:49 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:19:49 INFO - Using real prefix '/usr' 09:19:49 INFO - New python executable in /builds/slave/test/build/venv/bin/python 09:19:49 INFO - Installing distribute.............................................................................................................................................................................................done. 09:19:51 INFO - Installing pip.................done. 09:19:51 INFO - Return code: 0 09:19:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 09:19:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 09:19:52 INFO - Reading from file tmpfile_stdout 09:19:52 INFO - Output received: 09:19:52 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) 09:19:52 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 09:19:52 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')]} 09:19:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:19:52 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')]} 09:19:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:19:52 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 0xa903b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc6aa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe0edd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe0b840>, '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 0xe0c740>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe0cbd0>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1496765643.857840-997882870', '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 09:19:52 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 09:19:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 09:19:52 INFO - Using env: {'DISPLAY': ':0', 09:19:52 INFO - 'HOME': '/home/cltbld', 09:19:52 INFO - 'LANG': 'en_US.UTF-8', 09:19:52 INFO - 'LANGUAGE': 'en_US:en', 09:19:52 INFO - 'LOGNAME': 'cltbld', 09:19:52 INFO - 'MAIL': '/var/mail/cltbld', 09:19:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:19:52 INFO - 'MOZ_NO_REMOTE': '1', 09:19:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:19:52 INFO - 'NO_EM_RESTART': '1', 09:19:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:19:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:19:52 INFO - 'PWD': '/builds/slave/test', 09:19:52 INFO - 'SHELL': '/bin/bash', 09:19:52 INFO - 'SHLVL': '1', 09:19:52 INFO - 'TERM': 'linux', 09:19:52 INFO - 'TMOUT': '86400', 09:19:52 INFO - 'USER': 'cltbld', 09:19:52 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1496765643.857840-997882870', 09:19:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:19:52 INFO - '_': '/tools/buildbot/bin/python'} 09:19:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:19:52 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 09:19:52 INFO - Cleaning up... 09:19:52 INFO - Return code: 0 09:19:52 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 09:19:52 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')]} 09:19:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:19:52 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')]} 09:19:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:19:52 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 0xa903b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc6aa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe0edd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe0b840>, '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 0xe0c740>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe0cbd0>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1496765643.857840-997882870', '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 09:19:52 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 09:19:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 09:19:52 INFO - Using env: {'DISPLAY': ':0', 09:19:52 INFO - 'HOME': '/home/cltbld', 09:19:52 INFO - 'LANG': 'en_US.UTF-8', 09:19:52 INFO - 'LANGUAGE': 'en_US:en', 09:19:52 INFO - 'LOGNAME': 'cltbld', 09:19:52 INFO - 'MAIL': '/var/mail/cltbld', 09:19:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:19:52 INFO - 'MOZ_NO_REMOTE': '1', 09:19:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:19:52 INFO - 'NO_EM_RESTART': '1', 09:19:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:19:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:19:52 INFO - 'PWD': '/builds/slave/test', 09:19:52 INFO - 'SHELL': '/bin/bash', 09:19:52 INFO - 'SHLVL': '1', 09:19:52 INFO - 'TERM': 'linux', 09:19:52 INFO - 'TMOUT': '86400', 09:19:52 INFO - 'USER': 'cltbld', 09:19:52 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1496765643.857840-997882870', 09:19:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:19:52 INFO - '_': '/tools/buildbot/bin/python'} 09:19:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:19:52 INFO - Downloading/unpacking psutil>=3.1.1 09:19:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:19:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:19:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:19:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:19:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 09:19:53 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:19:53 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:19:53 INFO - Installing collected packages: psutil 09:19:53 INFO - Running setup.py install for psutil 09:19:53 INFO - building 'psutil._psutil_linux' extension 09:19:53 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 09:19:54 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 09:19:55 INFO - building 'psutil._psutil_posix' extension 09:19:55 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 09:19:55 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 09:19:55 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:19:55 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:19:55 INFO - Successfully installed psutil 09:19:55 INFO - Cleaning up... 09:19:55 INFO - Return code: 0 09:19:55 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 09:19:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:19:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:19:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:19:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:19:55 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xa903b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc6aa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe0edd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe0b840>, '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 0xe0c740>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe0cbd0>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1496765643.857840-997882870', '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 09:19:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 09:19:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 09:19:55 INFO - Using env: {'DISPLAY': ':0', 09:19:55 INFO - 'HOME': '/home/cltbld', 09:19:55 INFO - 'LANG': 'en_US.UTF-8', 09:19:55 INFO - 'LANGUAGE': 'en_US:en', 09:19:55 INFO - 'LOGNAME': 'cltbld', 09:19:55 INFO - 'MAIL': '/var/mail/cltbld', 09:19:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:19:55 INFO - 'MOZ_NO_REMOTE': '1', 09:19:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:19:55 INFO - 'NO_EM_RESTART': '1', 09:19:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:19:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:19:55 INFO - 'PWD': '/builds/slave/test', 09:19:55 INFO - 'SHELL': '/bin/bash', 09:19:55 INFO - 'SHLVL': '1', 09:19:55 INFO - 'TERM': 'linux', 09:19:55 INFO - 'TMOUT': '86400', 09:19:55 INFO - 'USER': 'cltbld', 09:19:55 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1496765643.857840-997882870', 09:19:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:19:55 INFO - '_': '/tools/buildbot/bin/python'} 09:19:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:19:55 INFO - Downloading/unpacking mozsystemmonitor==0.3 09:19:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:19:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:19:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:19:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:19:56 INFO - Downloading mozsystemmonitor-0.3.tar.gz 09:19:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:19:56 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 09:19:56 INFO - Installing collected packages: mozsystemmonitor 09:19:56 INFO - Running setup.py install for mozsystemmonitor 09:19:56 INFO - Successfully installed mozsystemmonitor 09:19:56 INFO - Cleaning up... 09:19:56 INFO - Return code: 0 09:19:56 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 09:19:56 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')]} 09:19:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:19:56 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')]} 09:19:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:19:56 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 0xa903b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc6aa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe0edd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe0b840>, '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 0xe0c740>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe0cbd0>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1496765643.857840-997882870', '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 09:19:56 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 09:19:56 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 09:19:56 INFO - Using env: {'DISPLAY': ':0', 09:19:56 INFO - 'HOME': '/home/cltbld', 09:19:56 INFO - 'LANG': 'en_US.UTF-8', 09:19:56 INFO - 'LANGUAGE': 'en_US:en', 09:19:56 INFO - 'LOGNAME': 'cltbld', 09:19:56 INFO - 'MAIL': '/var/mail/cltbld', 09:19:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:19:56 INFO - 'MOZ_NO_REMOTE': '1', 09:19:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:19:56 INFO - 'NO_EM_RESTART': '1', 09:19:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:19:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:19:56 INFO - 'PWD': '/builds/slave/test', 09:19:56 INFO - 'SHELL': '/bin/bash', 09:19:56 INFO - 'SHLVL': '1', 09:19:56 INFO - 'TERM': 'linux', 09:19:56 INFO - 'TMOUT': '86400', 09:19:56 INFO - 'USER': 'cltbld', 09:19:56 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1496765643.857840-997882870', 09:19:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:19:56 INFO - '_': '/tools/buildbot/bin/python'} 09:19:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:19:57 INFO - Downloading/unpacking jsonschema==2.5.1 09:19:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:19:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:19:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:19:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:19:58 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 09:19:58 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 09:19:58 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 09:19:58 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 09:19:58 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 09:19:58 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 09:19:58 INFO - Downloading functools32-3.2.3-2.tar.gz 09:19:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 09:19:58 INFO - warning: no files found matching '*.txt' 09:19:58 INFO - no previously-included directories found matching 'build' 09:19:58 INFO - no previously-included directories found matching 'dist' 09:19:58 INFO - no previously-included directories found matching '.git*' 09:19:58 INFO - Installing collected packages: jsonschema, functools32 09:19:58 INFO - Running setup.py install for functools32 09:19:58 INFO - warning: no files found matching '*.txt' 09:19:58 INFO - no previously-included directories found matching 'build' 09:19:58 INFO - no previously-included directories found matching 'dist' 09:19:58 INFO - no previously-included directories found matching '.git*' 09:19:58 INFO - Successfully installed jsonschema functools32 09:19:58 INFO - Cleaning up... 09:19:58 INFO - Return code: 0 09:19:58 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 09:19:58 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')]} 09:19:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:19:58 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')]} 09:19:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:19:58 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 0xa903b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc6aa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe0edd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe0b840>, '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 0xe0c740>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe0cbd0>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1496765643.857840-997882870', '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 09:19:58 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 09:19:58 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 09:19:58 INFO - Using env: {'DISPLAY': ':0', 09:19:58 INFO - 'HOME': '/home/cltbld', 09:19:58 INFO - 'LANG': 'en_US.UTF-8', 09:19:58 INFO - 'LANGUAGE': 'en_US:en', 09:19:58 INFO - 'LOGNAME': 'cltbld', 09:19:58 INFO - 'MAIL': '/var/mail/cltbld', 09:19:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:19:58 INFO - 'MOZ_NO_REMOTE': '1', 09:19:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:19:58 INFO - 'NO_EM_RESTART': '1', 09:19:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:19:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:19:58 INFO - 'PWD': '/builds/slave/test', 09:19:58 INFO - 'SHELL': '/bin/bash', 09:19:58 INFO - 'SHLVL': '1', 09:19:58 INFO - 'TERM': 'linux', 09:19:58 INFO - 'TMOUT': '86400', 09:19:58 INFO - 'USER': 'cltbld', 09:19:58 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1496765643.857840-997882870', 09:19:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:19:58 INFO - '_': '/tools/buildbot/bin/python'} 09:19:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:19:58 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 09:19:58 INFO - Cleaning up... 09:19:58 INFO - Return code: 0 09:19:58 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 09:19:58 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')]} 09:19:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:19:58 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')]} 09:19:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:19:58 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 0xa903b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc6aa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe0edd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe0b840>, '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 0xe0c740>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe0cbd0>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1496765643.857840-997882870', '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 09:19:58 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 09:19:58 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 09:19:58 INFO - Using env: {'DISPLAY': ':0', 09:19:58 INFO - 'HOME': '/home/cltbld', 09:19:58 INFO - 'LANG': 'en_US.UTF-8', 09:19:58 INFO - 'LANGUAGE': 'en_US:en', 09:19:58 INFO - 'LOGNAME': 'cltbld', 09:19:58 INFO - 'MAIL': '/var/mail/cltbld', 09:19:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:19:58 INFO - 'MOZ_NO_REMOTE': '1', 09:19:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:19:58 INFO - 'NO_EM_RESTART': '1', 09:19:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:19:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:19:58 INFO - 'PWD': '/builds/slave/test', 09:19:58 INFO - 'SHELL': '/bin/bash', 09:19:58 INFO - 'SHLVL': '1', 09:19:58 INFO - 'TERM': 'linux', 09:19:58 INFO - 'TMOUT': '86400', 09:19:58 INFO - 'USER': 'cltbld', 09:19:58 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1496765643.857840-997882870', 09:19:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:19:58 INFO - '_': '/tools/buildbot/bin/python'} 09:19:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:19:58 INFO - Downloading/unpacking blobuploader==1.2.4 09:19:58 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 09:19:58 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 09:19:58 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 09:19:58 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 09:20:00 INFO - Downloading blobuploader-1.2.4.tar.gz 09:20:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:20:00 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:20:00 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 09:20:00 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 09:20:00 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 09:20:00 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 09:20:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 09:20:00 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:20:00 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 09:20:00 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 09:20:00 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 09:20:00 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 09:20:00 INFO - Downloading docopt-0.6.1.tar.gz 09:20:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 09:20:00 INFO - Installing collected packages: blobuploader, requests, docopt 09:20:00 INFO - Running setup.py install for blobuploader 09:20:00 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:20:00 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 09:20:00 INFO - Running setup.py install for requests 09:20:01 INFO - Running setup.py install for docopt 09:20:01 INFO - Successfully installed blobuploader requests docopt 09:20:01 INFO - Cleaning up... 09:20:01 INFO - Return code: 0 09:20:01 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:20:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:20:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:20:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:20:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:20:01 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 0xa903b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc6aa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe0edd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe0b840>, '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 0xe0c740>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe0cbd0>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1496765643.857840-997882870', '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 09:20:01 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 09:20:01 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 09:20:01 INFO - Using env: {'DISPLAY': ':0', 09:20:01 INFO - 'HOME': '/home/cltbld', 09:20:01 INFO - 'LANG': 'en_US.UTF-8', 09:20:01 INFO - 'LANGUAGE': 'en_US:en', 09:20:01 INFO - 'LOGNAME': 'cltbld', 09:20:01 INFO - 'MAIL': '/var/mail/cltbld', 09:20:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:20:01 INFO - 'MOZ_NO_REMOTE': '1', 09:20:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:20:01 INFO - 'NO_EM_RESTART': '1', 09:20:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:20:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:20:01 INFO - 'PWD': '/builds/slave/test', 09:20:01 INFO - 'SHELL': '/bin/bash', 09:20:01 INFO - 'SHLVL': '1', 09:20:01 INFO - 'TERM': 'linux', 09:20:01 INFO - 'TMOUT': '86400', 09:20:01 INFO - 'USER': 'cltbld', 09:20:01 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1496765643.857840-997882870', 09:20:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:20:01 INFO - '_': '/tools/buildbot/bin/python'} 09:20:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:20:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:20:01 INFO - Running setup.py (path:/tmp/pip-M6KXJu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:20:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:20:01 INFO - Running setup.py (path:/tmp/pip-JMMtdh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:20:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:20:01 INFO - Running setup.py (path:/tmp/pip-86ZWxT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:20:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:20:01 INFO - Running setup.py (path:/tmp/pip-gQZhrX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:20:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:20:01 INFO - Running setup.py (path:/tmp/pip-P_atjl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:20:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:20:01 INFO - Running setup.py (path:/tmp/pip-UnpEcQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:20:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:20:01 INFO - Running setup.py (path:/tmp/pip-mRymTZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:20:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:20:01 INFO - Running setup.py (path:/tmp/pip-CPlyRC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:20:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:20:02 INFO - Running setup.py (path:/tmp/pip-GsUzlR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:20:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:20:02 INFO - Running setup.py (path:/tmp/pip-H2pQAn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:20:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:20:02 INFO - Running setup.py (path:/tmp/pip-Q6jaSH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:20:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:20:02 INFO - Running setup.py (path:/tmp/pip-aGrFd8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:20:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:20:02 INFO - Running setup.py (path:/tmp/pip-7QzHoQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:20:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:20:02 INFO - Running setup.py (path:/tmp/pip-RwpnR8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:20:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:20:02 INFO - Running setup.py (path:/tmp/pip-M0PIHG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:20:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:20:02 INFO - Running setup.py (path:/tmp/pip-Tm6CWB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:20:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:20:02 INFO - Running setup.py (path:/tmp/pip-mYUJcS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:20:02 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:20:02 INFO - Running setup.py install for manifestparser 09:20:02 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 09:20:02 INFO - Running setup.py install for mozcrash 09:20:02 INFO - Running setup.py install for mozdebug 09:20:02 INFO - Running setup.py install for mozdevice 09:20:03 INFO - Installing dm script to /builds/slave/test/build/venv/bin 09:20:03 INFO - Running setup.py install for mozfile 09:20:03 INFO - Running setup.py install for mozhttpd 09:20:03 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 09:20:03 INFO - Running setup.py install for mozinfo 09:20:03 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 09:20:03 INFO - Running setup.py install for mozInstall 09:20:03 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 09:20:03 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 09:20:03 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 09:20:03 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 09:20:03 INFO - Running setup.py install for mozleak 09:20:03 INFO - Running setup.py install for mozlog 09:20:03 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 09:20:03 INFO - Running setup.py install for moznetwork 09:20:03 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 09:20:03 INFO - Running setup.py install for mozprocess 09:20:03 INFO - Running setup.py install for mozprofile 09:20:03 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 09:20:03 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 09:20:03 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 09:20:03 INFO - Running setup.py install for mozrunner 09:20:04 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 09:20:04 INFO - Running setup.py install for mozscreenshot 09:20:04 INFO - Running setup.py install for moztest 09:20:04 INFO - Running setup.py install for mozversion 09:20:04 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 09:20:04 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:20:04 INFO - Cleaning up... 09:20:04 INFO - Return code: 0 09:20:04 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:20:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:20:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:20:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:20:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:20:04 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 0xa903b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc6aa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe0edd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe0b840>, '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 0xe0c740>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe0cbd0>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1496765643.857840-997882870', '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 09:20:04 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 09:20:04 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 09:20:04 INFO - Using env: {'DISPLAY': ':0', 09:20:04 INFO - 'HOME': '/home/cltbld', 09:20:04 INFO - 'LANG': 'en_US.UTF-8', 09:20:04 INFO - 'LANGUAGE': 'en_US:en', 09:20:04 INFO - 'LOGNAME': 'cltbld', 09:20:04 INFO - 'MAIL': '/var/mail/cltbld', 09:20:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:20:04 INFO - 'MOZ_NO_REMOTE': '1', 09:20:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:20:04 INFO - 'NO_EM_RESTART': '1', 09:20:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:20:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:20:04 INFO - 'PWD': '/builds/slave/test', 09:20:04 INFO - 'SHELL': '/bin/bash', 09:20:04 INFO - 'SHLVL': '1', 09:20:04 INFO - 'TERM': 'linux', 09:20:04 INFO - 'TMOUT': '86400', 09:20:04 INFO - 'USER': 'cltbld', 09:20:04 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1496765643.857840-997882870', 09:20:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:20:04 INFO - '_': '/tools/buildbot/bin/python'} 09:20:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:20:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:20:04 INFO - Running setup.py (path:/tmp/pip-kSSifA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:20:04 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)) 09:20:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:20:04 INFO - Running setup.py (path:/tmp/pip-Bez9Wk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:20:04 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)) 09:20:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:20:04 INFO - Running setup.py (path:/tmp/pip-VLD7Om-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:20:04 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)) 09:20:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:20:04 INFO - Running setup.py (path:/tmp/pip-wbfMjB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:20:04 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)) 09:20:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:20:04 INFO - Running setup.py (path:/tmp/pip-ygpHTw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:20:05 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)) 09:20:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:20:05 INFO - Running setup.py (path:/tmp/pip-CL1oAi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:20:05 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)) 09:20:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:20:05 INFO - Running setup.py (path:/tmp/pip-wpDRQx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:20:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.10 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 09:20:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:20:05 INFO - Running setup.py (path:/tmp/pip-Spt3QQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:20:05 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)) 09:20:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:20:05 INFO - Running setup.py (path:/tmp/pip-mwb79S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:20:05 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)) 09:20:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:20:05 INFO - Running setup.py (path:/tmp/pip-1jW3mV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:20:05 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)) 09:20:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:20:05 INFO - Running setup.py (path:/tmp/pip-lT7Hz6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:20:05 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)) 09:20:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:20:05 INFO - Running setup.py (path:/tmp/pip-lzJAOL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:20:05 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)) 09:20:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:20:05 INFO - Running setup.py (path:/tmp/pip-FAH10F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:20:05 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)) 09:20:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:20:05 INFO - Running setup.py (path:/tmp/pip-EVqzGN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:20:05 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)) 09:20:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:20:05 INFO - Running setup.py (path:/tmp/pip-jWjDtS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:20:05 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)) 09:20:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:20:05 INFO - Running setup.py (path:/tmp/pip-28sJN9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:20:05 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)) 09:20:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:20:05 INFO - Running setup.py (path:/tmp/pip-vezN5i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:20:05 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)) 09:20:05 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)) 09:20:05 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)) 09:20:05 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)) 09:20:05 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)) 09:20:05 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)) 09:20:05 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:20:05 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 09:20:05 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 09:20:05 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 09:20:05 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 09:20:06 INFO - Downloading blessings-1.6.tar.gz 09:20:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 09:20:07 INFO - Installing collected packages: blessings 09:20:07 INFO - Running setup.py install for blessings 09:20:07 INFO - Successfully installed blessings 09:20:07 INFO - Cleaning up... 09:20:07 INFO - Return code: 0 09:20:07 INFO - Done creating virtualenv /builds/slave/test/build/venv. 09:20:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:20:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:20:07 INFO - Reading from file tmpfile_stdout 09:20:07 INFO - Current package versions: 09:20:07 INFO - argparse == 1.2.1 09:20:07 INFO - blessings == 1.6 09:20:07 INFO - blobuploader == 1.2.4 09:20:07 INFO - docopt == 0.6.1 09:20:07 INFO - functools32 == 3.2.3-2 09:20:07 INFO - jsonschema == 2.5.1 09:20:07 INFO - manifestparser == 1.1 09:20:07 INFO - mozInstall == 1.12 09:20:07 INFO - mozcrash == 1.0 09:20:07 INFO - mozdebug == 0.1 09:20:07 INFO - mozdevice == 0.51 09:20:07 INFO - mozfile == 1.2 09:20:07 INFO - mozhttpd == 0.7 09:20:07 INFO - mozinfo == 0.10 09:20:07 INFO - mozleak == 0.1 09:20:07 INFO - mozlog == 3.4 09:20:07 INFO - moznetwork == 0.27 09:20:07 INFO - mozprocess == 0.25 09:20:07 INFO - mozprofile == 0.28 09:20:07 INFO - mozrunner == 6.13 09:20:07 INFO - mozscreenshot == 0.1 09:20:07 INFO - mozsystemmonitor == 0.3 09:20:07 INFO - moztest == 0.8 09:20:07 INFO - mozversion == 1.4 09:20:07 INFO - psutil == 3.1.1 09:20:07 INFO - requests == 1.2.3 09:20:07 INFO - wsgiref == 0.1.2 09:20:07 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:20:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:20:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:20:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:20:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:20:07 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 0xa903b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc6aa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe0edd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe0b840>, '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 0xe0c740>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe0cbd0>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1496765643.857840-997882870', '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 09:20:07 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 09:20:07 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 09:20:07 INFO - Using env: {'DISPLAY': ':0', 09:20:07 INFO - 'HOME': '/home/cltbld', 09:20:07 INFO - 'LANG': 'en_US.UTF-8', 09:20:07 INFO - 'LANGUAGE': 'en_US:en', 09:20:07 INFO - 'LOGNAME': 'cltbld', 09:20:07 INFO - 'MAIL': '/var/mail/cltbld', 09:20:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:20:07 INFO - 'MOZ_NO_REMOTE': '1', 09:20:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:20:07 INFO - 'NO_EM_RESTART': '1', 09:20:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:20:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:20:07 INFO - 'PWD': '/builds/slave/test', 09:20:07 INFO - 'SHELL': '/bin/bash', 09:20:07 INFO - 'SHLVL': '1', 09:20:07 INFO - 'TERM': 'linux', 09:20:07 INFO - 'TMOUT': '86400', 09:20:07 INFO - 'USER': 'cltbld', 09:20:07 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1496765643.857840-997882870', 09:20:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:20:07 INFO - '_': '/tools/buildbot/bin/python'} 09:20:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:20:07 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)) 09:20:07 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)) 09:20:07 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)) 09:20:07 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)) 09:20:07 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)) 09:20:07 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)) 09:20:07 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)) 09:20:07 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)) 09:20:07 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)) 09:20:07 INFO - Downloading/unpacking marionette-driver>=1.4.0 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 09:20:07 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 09:20:07 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 09:20:07 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 09:20:07 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 09:20:08 INFO - Downloading marionette_driver-1.4.0.tar.gz 09:20:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/marionette-driver/setup.py) egg_info for package marionette-driver 09:20:08 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)) 09:20:08 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)) 09:20:08 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)) 09:20:08 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)) 09:20:08 INFO - Installing collected packages: marionette-driver 09:20:08 INFO - Running setup.py install for marionette-driver 09:20:08 INFO - Successfully installed marionette-driver 09:20:08 INFO - Cleaning up... 09:20:09 INFO - Return code: 0 09:20:09 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 09:20:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:20:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:20:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:20:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:20:09 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xa903b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc6aa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe0edd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe0b840>, '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 0xe0c740>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe0cbd0>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1496765643.857840-997882870', '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 09:20:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 09:20:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 09:20:09 INFO - Using env: {'DISPLAY': ':0', 09:20:09 INFO - 'HOME': '/home/cltbld', 09:20:09 INFO - 'LANG': 'en_US.UTF-8', 09:20:09 INFO - 'LANGUAGE': 'en_US:en', 09:20:09 INFO - 'LOGNAME': 'cltbld', 09:20:09 INFO - 'MAIL': '/var/mail/cltbld', 09:20:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:20:09 INFO - 'MOZ_NO_REMOTE': '1', 09:20:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:20:09 INFO - 'NO_EM_RESTART': '1', 09:20:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:20:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:20:09 INFO - 'PWD': '/builds/slave/test', 09:20:09 INFO - 'SHELL': '/bin/bash', 09:20:09 INFO - 'SHLVL': '1', 09:20:09 INFO - 'TERM': 'linux', 09:20:09 INFO - 'TMOUT': '86400', 09:20:09 INFO - 'USER': 'cltbld', 09:20:09 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1496765643.857840-997882870', 09:20:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:20:09 INFO - '_': '/tools/buildbot/bin/python'} 09:20:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:20:09 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 09:20:09 INFO - Cleaning up... 09:20:09 INFO - Return code: 0 09:20:09 INFO - Running post-action listener: _resource_record_post_action 09:20:09 INFO - Running post-action listener: _start_resource_monitoring 09:20:09 INFO - Starting resource monitoring. 09:20:09 INFO - [mozharness: 2017-06-06 16:20:09.278687Z] Finished create-virtualenv step (success) 09:20:09 INFO - [mozharness: 2017-06-06 16:20:09.279149Z] Running install step. 09:20:09 INFO - Running pre-action listener: _resource_record_pre_action 09:20:09 INFO - Running main action method: install 09:20:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:20:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:20:09 INFO - Reading from file tmpfile_stdout 09:20:09 INFO - Detecting whether we're running mozinstall >=1.0... 09:20:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 09:20:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 09:20:09 INFO - Reading from file tmpfile_stdout 09:20:09 INFO - Output received: 09:20:09 INFO - Usage: mozinstall [options] installer 09:20:09 INFO - Options: 09:20:09 INFO - -h, --help show this help message and exit 09:20:09 INFO - -d DEST, --destination=DEST 09:20:09 INFO - Directory to install application into. [default: 09:20:09 INFO - "/builds/slave/test"] 09:20:09 INFO - --app=APP Application being installed. [default: firefox] 09:20:09 INFO - mkdir: /builds/slave/test/build/application 09:20:09 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'] 09:20:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 09:20:27 INFO - Reading from file tmpfile_stdout 09:20:27 INFO - Output received: 09:20:27 INFO - /builds/slave/test/build/application/firefox/firefox 09:20:27 INFO - Running post-action listener: _resource_record_post_action 09:20:27 INFO - [mozharness: 2017-06-06 16:20:27.047207Z] Finished install step (success) 09:20:27 INFO - [mozharness: 2017-06-06 16:20:27.047485Z] Running setup-mitmproxy step. 09:20:27 INFO - Running pre-action listener: _resource_record_pre_action 09:20:27 INFO - Running main action method: setup_mitmproxy 09:20:27 INFO - Skipping: mitmproxy is not required 09:20:27 INFO - Running post-action listener: _resource_record_post_action 09:20:27 INFO - [mozharness: 2017-06-06 16:20:27.048708Z] Finished setup-mitmproxy step (success) 09:20:27 INFO - [mozharness: 2017-06-06 16:20:27.048931Z] Running run-tests step. 09:20:27 INFO - Running pre-action listener: _resource_record_pre_action 09:20:27 INFO - Running main action method: run_tests 09:20:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 09:20:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 09:20:27 INFO - Python 2.7.3 09:20:27 INFO - Return code: 0 09:20:27 INFO - grabbing minidump binary from tooltool 09:20:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:20:27 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 0xe0b840>, '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 0xe0c740>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe0cbd0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 09:20:27 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 09:20:27 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 09:20:27 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 09:20:27 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:20:27 INFO - Return code: 0 09:20:27 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 09:20:27 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 09:20:27 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 09:20:27 INFO - ENV: RUST_BACKTRACE is now 1 09:20:27 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 09:20:27 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 09:20:27 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/ECGZ_RQZS4CyP3kbNjdMZw/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-067', '--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 09:20:27 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/ECGZ_RQZS4CyP3kbNjdMZw/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-067 --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 09:20:27 INFO - Using env: {'DISPLAY': ':0', 09:20:27 INFO - 'HOME': '/home/cltbld', 09:20:27 INFO - 'LANG': 'en_US.UTF-8', 09:20:27 INFO - 'LANGUAGE': 'en_US:en', 09:20:27 INFO - 'LOGNAME': 'cltbld', 09:20:27 INFO - 'MAIL': '/var/mail/cltbld', 09:20:27 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 09:20:27 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 09:20:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:20:27 INFO - 'MOZ_NO_REMOTE': '1', 09:20:27 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 09:20:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:20:27 INFO - 'NO_EM_RESTART': '1', 09:20:27 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:20:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:20:27 INFO - 'PWD': '/builds/slave/test', 09:20:27 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 09:20:27 INFO - 'RUST_BACKTRACE': '1', 09:20:27 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 09:20:27 INFO - 'SHELL': '/bin/bash', 09:20:27 INFO - 'SHLVL': '1', 09:20:27 INFO - 'TERM': 'linux', 09:20:27 INFO - 'TMOUT': '86400', 09:20:27 INFO - 'USER': 'cltbld', 09:20:27 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1496765643.857840-997882870', 09:20:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:20:27 INFO - '_': '/tools/buildbot/bin/python'} 09:20:27 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/ECGZ_RQZS4CyP3kbNjdMZw/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-067', '--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 09:20:27 INFO - mozversion application_buildid: 20170606153929 09:20:27 INFO - mozversion application_changeset: c511ad826fe71ba2bb956d2e1c119e86d2266aba 09:20:27 INFO - mozversion application_display_name: Nightly 09:20:27 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:20:27 INFO - mozversion application_name: Firefox 09:20:27 INFO - mozversion application_remotingname: firefox 09:20:27 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 09:20:27 INFO - mozversion application_vendor: Mozilla 09:20:27 INFO - mozversion application_version: 55.0a1 09:20:27 INFO - mozversion platform_buildid: 20170606153929 09:20:27 INFO - mozversion platform_changeset: c511ad826fe71ba2bb956d2e1c119e86d2266aba 09:20:27 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 09:20:27 INFO - mozversion platform_version: 55.0a1 09:20:27 INFO - using testdate: 1496766027 09:20:27 INFO - actual date: 1496766027 09:20:27 INFO - starting webserver on 'localhost:35378' 09:20:27 INFO - SUITE-START | Running 2 tests 09:20:27 INFO - TEST-START | dromaeo_css 09:20:27 INFO - operating with platform_type : linux_ 09:20:27 INFO - Initialising browser for dromaeo_css test... 09:20:27 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:35378/getInfo.html -profile /tmp/tmpDb_ZDH/profile 09:20:27 INFO - TEST-INFO | started process 3318 (/builds/slave/test/build/application/firefox/firefox http://localhost:35378/getInfo.html) 09:21:03 INFO - TEST-INFO | 3318: killed by SIGTERM 09:21:03 INFO - Browser initialized. 09:21:03 INFO - Running cycle 1/1 for dromaeo_css test... 09:21:03 INFO - TEST-INFO | started process 3548 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpDb_ZDH/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:21:15 INFO - PID 3548 | RSS: Main: 191627264 09:21:15 INFO - PID 3548 | 09:24:16 INFO - PID 3548 | Cycle 1(1): loaded http://localhost:35378/tests/dromaeo/cssquery-dojo.html (next: http://localhost:35378/tests/dromaeo/cssquery-ext.html) 09:24:18 INFO - PID 3548 | RSS: Main: 187392000 09:24:18 INFO - PID 3548 | 09:27:19 INFO - PID 3548 | Cycle 1(1): loaded http://localhost:35378/tests/dromaeo/cssquery-ext.html (next: http://localhost:35378/tests/dromaeo/cssquery-jquery.html) 09:27:20 INFO - PID 3548 | RSS: Main: 193945600 09:27:20 INFO - PID 3548 | 09:30:22 INFO - PID 3548 | Cycle 1(1): loaded http://localhost:35378/tests/dromaeo/cssquery-jquery.html (next: http://localhost:35378/tests/dromaeo/cssquery-mootools.html) 09:30:23 INFO - PID 3548 | RSS: Main: 190910464 09:30:23 INFO - PID 3548 | 09:33:25 INFO - PID 3548 | Cycle 1(1): loaded http://localhost:35378/tests/dromaeo/cssquery-mootools.html (next: http://localhost:35378/tests/dromaeo/cssquery-prototype.html) 09:33:25 INFO - PID 3548 | RSS: Main: 195665920 09:33:25 INFO - PID 3548 | 09:36:28 INFO - PID 3548 | Cycle 1(1): loaded http://localhost:35378/tests/dromaeo/cssquery-prototype.html (next: http://localhost:35378/tests/dromaeo/cssquery-yui.html) 09:36:29 INFO - PID 3548 | RSS: Main: 194166784 09:36:29 INFO - PID 3548 | 09:39:30 INFO - PID 3548 | Cycle 1(1): loaded http://localhost:35378/tests/dromaeo/cssquery-yui.html (next: http://localhost:35378/tests/dromaeo/cssquery-dojo.html) 09:39:31 INFO - PID 3548 | RSS: Main: 191799296 09:39:31 INFO - PID 3548 | 09:39:31 INFO - PID 3548 | __start_tp_report 09:39:31 INFO - PID 3548 | _x_x_mozilla_page_load 09:39:31 INFO - PID 3548 | _x_x_mozilla_page_load_details 09:39:31 INFO - PID 3548 | |i|pagename|runs| 09:39:31 INFO - PID 3548 | |0;dojo.html;3094.4739394302965;3100.7054329838666;3120.469520181569;3132.8120312781234;3135.5139953307244;5935.525157987361;5963.194968679227;5972.970135149329;5974.4622983931495;6000.099985002252;5972.313183983843;5998.040313549822;6008.579399442041;6009.849753756158;6049.727762250698;5574.442555744414;5607.355154157273;5676.716164191774;5681.034224181899;5691.459311365435;5449.782008719647;5636.436356364351;5642.689652069134;5661.264035675356;5725.971370143144;5613.07384281593;5632.04255276604;5696.544276457874;5705.229793977802;5717.456841600062;5475.698836563987;5527.944720552823;5535;5562.527185189264;5661.179129026309;5556.91664625031;5563.193336966157;5595.832125036255;5629.043062679354;5648.124540696199;6038.57729958903;6041.6375017499095;6057.697115144225;6099.756009759604;6103.572749907508;6206.162168107293;6310.684465776739;6485;6531.314212007718;6554.737810487575;6462.838429039265;6590.242122155918;6593.703283352261;6600;6605.636689982049;6042.335343112254;6090.969545152246;6097.847553811146;6108.08378743192;6111;6463;6554.901676474857;6691.130153080068;6697.665116744143;6707.731690732414;6271;6316.968415157895;6381.329960354189;6385.5210859185745;6390.8721825563225;6234.220722409699;6317.652529110943;6392.584482008655;6487.091807147003;6488.837779055561;6452.032195170762;6494.350564943468;6505.447037001908;6524.771632992823;6532.052852336385;6480.189976252968;6527.510436717265;6554.147960765165;6572.211334639874;6572.375624315778;5083.135866902636;5129.12804823181;5210.843674689765;5264.368275806928;5301;4536.455625324982;4567.931481027787;4584.862454126382;4587.610053145453;4627.213373726408;5613.775448982076;5624.325080990226;5657.4059723728415;5676.772929082873;5691.772329106872;6355.396237357444;6394.912864812993;6488.870222595521;6577.736890524421;6592.17597800275;5669.234653321749;5697.202391665171;5711.228984087178;5750.6262092963825;5754.827355179351;5763.827085187451;5773.797917072882;5779.942200577941;5799.82600521985;5802.593818432669;6121.7578389577775;6191.442770150708;6372.490200784019;6381.968090159519;6405.807825765234;6459.192600924885;6551.21385433751;6562.573432726857;6569.178852643419;6583.967080164569;6283.151774510383;6319.368063193828;6342.587731797418;6354.078658594571;6379.840503987438;6183;6380.744770209325;6413;6429.292777794345;6441.066045423481;6408.455281300955;6445.065465507381;6477.4170324671;6513.967430162819;6530.640814755234;6382.138411314413;6384.3934826191435;6393.104965304954;6399.424051835357;6401.77593784234;6164.7842325518395;6217.129601855653;6276.089966954857;6369.7452101915405;6411.551191416743;6318.336574659778;6323.177986861862;6336.17629708135;6353.777617783356;6367.840803979938;6458.289588145394;6464.773732919325;6471.902921456088;6475.255345635123;6483.708233129426;6069.514438844793;6218.720157593009;6256.687165641791;6278.780242691667;6290.150829637941 09:39:31 INFO - PID 3548 | |1;ext.html;654.8788474132286;700.7722490190688;719.399301583178;1227.3249712658037;1273.0261350067194;37221.62778372216;37382.43926341107;37441.81279093604;37665.62334376655;37700.622993770055;35297.82351088241;35441.82279088607;35604.10989725258;35615.4657680135;35662.64337356626;6900.96549517253;7041.753538626123;7053.224145344008;7216.603086830222;7221.31397517235;7132;7245.311695388929;7254.782356529313;7277.526960747535;7283.490155689104;7255.927440725578;7357;7363.2268611795525;7364.705411783522;7380;7224.927750722478;7282.635868206595;7289.271072892721;7290.526115802456;7316.56100633961;7183.173934997438;7202.387797037258;7241.8551628967125;7245.311695388929;7259.60072196029;33618.1595460113;33678.32643347119;33902.1524461888;33924.83037584796;33956.320873582634;3450.8102054387;3482.5472688550326;3487.877924272638;3496.108492334464;3497.8425970831117;27449.725502744917;27506.724932750618;27509;27535.44929101407;27543.724562754316;3579.6420357964257;3592.119930616989;3607.621199774012;3613.765105268149;3621.3662609043313;163284;164023.1798840998;164637;170513;176759.99999999872;41278.79360603178;41571.376429353586;41655.7917210412;41684.37473437901;41754;43675.12649746987;43834.342484862755;43849.56150438455;44868.55131448709;45218.77390613026;14400.639984000274;14427;14532.854671453362;14613.92693036528;14651.633709157357;11899.940500297444;11959.820602690967;11966.350263169817;11995.880041199476;12003.879961200277;13486.190828550318;13558.593242202749;13633.727325453436;13681.452741890413;13872.907492289798;5636.605437619327;5711.543076553866;5728.1694154348215;5817.476427121579;5838.153467747153;982.3761911186448;988.7972965542046;991.8809742830762;996.725900377402;1006.0945149365483;21408;22188.445288867908;22529.11614550085;22578.54842903133;22666.320010399715;1049.1134990932649;1069.978600427987;1070.0525044419082;1082.9241953063367;1128.1651577832508;11688.590899318484;12181;12605.432755526022;12619.36903154857;12650.620481385573;202014;203301;203342;203477;203888;46994;47130.5286947133;47351;47496.52503474921;47531.28703069457;1342.1276170489066;1418.971620567583;1419.1697856753915;1422.7225690990158;1427.9357428915723;20868.68696969577;21384.78615213828;23011.88494057519;23189.652155217347;23492.882535587214;34933.95198143958;34938.82530587331;35034;35142.12144696403;35145.297094058486;164321;165599.1720041392;165722;165828.17085914494;165932;31920.840395797873;32236;32491.350172995935;32573.18567035843;32608.51087233646;37805.05487362838;38970.6102938967;39058.6094139055;39127.413088804264;39199;27908.58137127985;28669.476519439857;29122.12633620995;29565.85217073901;30395.734632645563;28506.85746571337;29023.709762902945;29175;30578;30723.846380767955;32510.83744581262;32572.83713581417;32943;33015;33306.167345816546;27055.594166087918;27094.1871743848;28481.873676342344;29167.85416072906;29780.255493611967;20682.276120335715;23158.536829262983;23532.176373826835;23598.646020310054;23752.168674096323 09:39:31 INFO - PID 3548 | |2;jquery.html;417.92477354076254;420.03322510005285;424.97237679550835;439.43093693666697;443.42797790849824;19999.400017999447;20616.278430254944;20756.16975320989;20860.478488037807;22789.202377916776;22870.313890583308;23453.76546234537;23557.41106472339;23566.175183868567;23595.764042359573;6016.27804663441;6168.599041062316;6177.320494745574;6177.783777567786;6186.536009799283;5234.298852872813;5608;5696.174054762057;6001.639901605896;6052.061930400795;5630.071038278699;5655.5475561954945;5669.574781891354;5675.290588676416;5677.659340439587;5625.859353516174;5672.9432705672825;5676.574256930747;5678.34699009613;5688.232088668018;5138.409082955471;5139.665921715076;5141.74291285438;5144.151215049513;5145.125328694131;25572;25828.74171258282;26031.21906342813;26033.609495857578;26138.215853524423;1747.5106970048407;1770.1326350088364;1787.8390944815028;1789.2306308287432;1798.2537247042462;17128.057956812372;17323.65352692939;17413.042282674447;17430.041347725997;17442.040687762168;2157.8165855902266;2160.146742036902;2215.6344203206613;2224.810891074261;2245.607018771708;111626.44186779096;116138.41930790292;116408.41795791051;116453.99999999916;116465.41767291194;11283.717907052225;11905.761884762256;11914.46384912681;12061.155719099754;12176.452059657337;16837.41069062577;16991.91504042472;16994.745078823827;16998.91500542514;17099.572510687332;8525.786855328666;9017.729468115967;9050.387117520573;9074.45553266806;9113.498757568397;8717;8779.429337093068;8794.560271986375;8819.382643215042;8871.379003469825;7382.114146302478;7660.2722741339485;7727.420443466763;7891.408144389194;7909.378577391621;2217.2018073493527;2231.1187081102876;2239.1043582567104;2247.6516139998325;2402.3633737059695;913.1097180249336;924.473050361301;930.9581068851783;974.2157563161722;981.72866138351;18492;18832.022637623126;19296.22815087409;20539;21331;940.9623615055322;957.5451660461365;962.932594718377;976.799756050008;1019.2050200843354;9879.555420006118;10186.745331366626;10574.735631609272;10604.787904241872;10653.84019239712;426295;430859;432425;437420;441383;95819;99770;99887.00564971722;100012;105804.47097764463;1128.4865386249237;1163.26714170074;1198.4966314147905;1200.903927685783;1211.0311750599485;18651.720224196375;19987.66500542106;20963.475913102295;20990.895045524674;21009.57980840405;49031.754841225564;50094.74952625213;51496;51858.74070629623;51931;62466.375336246056;62720;62893.936970084564;63134.36865631285;64013.35986640074;9728.659496917573;9867.506624668882;10116.393016419039;10700.785984280426;10841.349519028883;16606.50180494587;16721.91639041797;16813.327466901676;16860.156992150587;18189.818101819343;13108.541201057917;13460.125091868997;13639.863601363859;13701.246431445967;13782.379792909143;13112.803307950198;13800.171989680652;14274.072185307921;14338.56984290473;14403.207823569384;14122.43510259578;14165.929170354082;14197.361118749888;14601.488947886774;14626.926865365605;10014;10513.211509136692;10596.31123976939;10665.733356666145;10673.679789606324;14109.506167284097;14175.503857365355;14232.359543820347;14318.785218221943;14403.207823569384 09:39:31 INFO - PID 3548 | |3;mootools.html;1324.5231716582032;1378.9862101378983;1389.0554422992361;1392.5891861900745;1419.0634181440253;10636.361818290909;10946.39794811285;11106.055985241264;11131.443427828606;11552;11079.446027698623;11248.662540123789;11254.437278136102;11290.09679225662;11318.943405282962;2180.672899065141;2211.502411957305;2213.181122984498;2214.0811563201332;2229.420350708819;1858.135966775449;1925.5089952062206;2268.410213344534;2308.365199570115;2357.681712968753;2370.6562548430466;2384.9284521464297;2390.4143484846236;2398.136670798511;2403.0748161957686;2230.0856648774006;2264.7169103862016;2270.909163633453;2285.2001799370337;2305.5158416732424;2266.7053283073096;2284.6116160252795;2285.771422857701;2296.666983287414;2300.18343488061;10887.510062047228;11073;11108.500117494652;11108.61119860801;11132.827144263927;6009.669468179249;6186.536009799283;6209.937900620981;6247.875042499125;6262.749490020394;3618.3125206211;3750.5686846012786;3823.2926908521736;3829.8276577554075;3844.192719528902;1183.8993685536739;1218.8415505984253;1236.4003458322707;1245.8255844181822;1247.7691627049026;15749.370025199092;15849.52451426459;16012.919935400365;16084.517464476085;16146.434874779443;5073.822416215415;5136.306598609214;5146.202338637517;5259.868503287372;5272.446393128743;11896.345700986356;11907.761844763056;11911.10666700001;11917.22538035025;12070.69823254408;5998.340182579913;6204.7828326008375;6214.471769899609;6215.720292586844;6245.781397651061;5757.510611598061;5834.591578589458;5841.744025034553;5852.765889364463;5864.70676466175;3945.684345252373;3989.740666856645;4055.2903241932545;4084.223997440477;4086.2644723949975;1135.7614900870744;1148.1915982327866;1169.0180248591055;1173.677238759348;1174.2543484886987;839.9916000840036;841.1672444280118;862.9137086291321;863.6804382378434;891.6968230801558;6078.270607527125;6495.487355852825;6637.336266373324;6800.727970881208;7021.438284937193;953.7696371680593;975.2100798353357;977.0571398600384;984.8128855517429;985.1281615769952;4041.8989525261513;4136.21411931732;4356.390105385249;4413.1394378095965;4477.126960242721;13408.865911340958;14029.228392438514;14080.084794488326;14157.787633185304;14184;13899.583012509642;14093.15441073539;14104.435822567188;14106.929465352812;14116.576502704935;8561.101084386175;8727.258183054511;8856.690015849543;8888.955555222312;8915.42049766763;6237.4074462927765;6291.307956124914;6472.676366181766;6496.870062598627;6673;12734.299613520974;12887.42006609686;12895.484180633044;12938.482460701467;13083.607491775261;13018.479260829461;13036.543720969721;13038.47846086184;13140.60578182656;13212;8777.561121944005;8985.011648718504;8990.370674052754;9017.233535149586;9018.909810902069;9460.858087128561;9477.905220947703;9509.239260859253;9558;9582.472963987047;8101.270885620323;8154.469959452616;8257.669693212205;8328.250457458858;8370.87443688333;8041.437099402986;8375.748727538183;8659.263962563253;8833.823323533365;8911.019787823463;7139.571625702474;7328.926710732824;7350;7373.18894921569;7379.077615298088;5425.593080518898;5650;5787.218725472176;5788;5955.076963070731;5643.209950606836;5824.242848429677;5925.496332811759;5954.46409823118;6176.042713379434 09:39:31 INFO - PID 3548 | |4;prototype.html;400.6414259237982;405.63898130663694;409.1510116508246;411.4794784597483;411.48975270664386;6361.236651601808;6368.235811702591;6411.070394792752;6424.453921416679;6443.774467893625;6152.876942461148;6168.4448399644025;6171.352008039158;6200.224971878515;6244.344343843888;4669.789859456333;4774.928376074345;4801.135795556798;4806.663533552653;4942.517244826547;4833.154198015351;4845.2247640377545;4856.805727770885;4876.731779752112;4878.536539028786;4791.149266186613;4791.401074865642;4794.616430685537;4799.760011999403;4803.135435621587;4796.97601511992;4811.855644330676;4825.227963525819;4831.806727730886;4846.515348465161;4233.682473814445;4235.767032813194;4239.236937351276;4240.830366785356;4246.193223287565;6085.2393450818645;6129.1725617041575;6138.14066030756;6152.600080994765;6174.84562885927;5506.476884695948;5518.806841760559;5523.613347065667;5524.33707955048;5526.917096243559;6505.251896031969;6537.836554086139;6554.901676474857;6568.835779105513;6571.408573228385;4583.770811459413;4595.2188128018315;4598.655100867449;4613.76931153441;4617.3304870793545;6521.771737989195;6884.827879303058;6921.619310937896;6945.930540694579;6952.721891124349;4596.034832685174;4635.513271106553;4694.178518759271;4704.270838020112;4704.364910737075;4699.107169637758;4713.740744259098;4753.809847606126;4764.737939413296;4782.736949467743;5300.628955973045;5431.8098866539485;5444.5916556258435;5466.234727138204;5479.150731636602;6540.640264785387;6581.2102547694585;6598.208215014133;6612.173478315211;6622.668866556653;1643.2851709506403;1652.0830938829065;1652.4299116804684;1655.2385902484991;1658.6931417687767;1073.3881687438086;1084.5173897615484;1110.722319420145;1120.456578559398;1120.9271397359146;5802.448767367094;5845.678487683218;5880.588358814842;5881.882362352729;5892.646441213541;6755.3582409671;6761.830954226184;6774.3225677431865;6780.559263647847;6801.285864984205;5789.218455508537;5812.94187058124;5819.883602328015;5823.446772556685;5829.271341082364;3599.94600080999;3634.1823089804584;3647.106458917582;3658.4146536554554;3670.247599242149;6620.668966551653;6623.271440141581;6623.933760662332;6638.800835974928;6649.867002660017;6892.655367231619;6965.651717414109;6978.546394484342;6989.650517474106;7016.158061032709;6533.281339052701;6560.835979100465;6607.636579988147;6617.43751781104;6636.137302150786;6750.831229219309;6794.796156115324;6795.456363491007;6806.897896531457;6825.249222585412;6745.595264283962;6761.3238676132;6770.695318710571;6771.255161932085;6771.322867713189;6217.916997805785;6581.6709164540625;6587.901181482377;6612.140421745143;6617.470602351704;4707.764611769329;4708.5997690195345;4722.622190224705;4723.267893476516;4723.669343145947;6726.495512836655;6828.556143850634;6852.2933441289415;6883.346082122191;6884.552504087218;6413.294537600954;6633.900491492535;6667.699953502201;6676.866462670622;6678.265390806911;6620.3710647488415;6622.63575503352;6626;6640.933590664032;6667.766628167991;6506.934930650633;6535.248446428532;6560.539797575909;6563.162314551933;6599.5050371223315;6647.933520664925;6652.600843949379;6683.4319082876555;6684.364985326386;6700.631465269457;6475.546711730133;6491.383318584727;6499.6750162492635;6543.5419520633095;6564.372117657136 09:39:31 INFO - PID 3548 | |5;yui.html;810.7486679129466;833.2417500074934;837.1210229259278;838.5639467476913;848.7199224255996;16712.74930876036;17052.23264953077;17074;18845.15196816143;19887.40337789865;18592.814071859277;18686.25254989802;18726.71909921349;18811;18896.71654925177;977.9608815647366;997.6907158780765;998.9200863930904;1000.5347513406265;1003.413003393016;924.3760461688368;990.7671697151163;993.8260804359244;1003.1272792670387;1005.1807776662033;1044.0551301072542;1062.4687656171914;1062.5643486170634;1064.350746044912;1064.930779499334;1040.6513817870984;1050.5745173204864;1054.96307629233;1057.5822550092748;1059.0098258128673;764.9579273139975;772.1892013385923;775.2402645407532;776.1074764021364;777.5218240781935;16846.157692115346;17381.652366952716;17437.21532531039;17439.73840392395;17705.557361066076;19149.80850191494;19159.808401915943;19431.4170574883;19454.319098831475;19593.118309676098;15102.697946041128;15268.618284542865;15298.694026119416;15302.158381289024;15325.770113448196;3432.2449061206494;3471.548698669182;3512.59605145409;3520.137566296248;3535.1338921964025;80251.5987420065;81808.18191818065;98770.50614746952;99556.50221748918;99781;14342.139471631735;15155.393784248727;15167.165805880783;15197.772033419507;15310.770338444932;27243.182704518895;27375.45249095007;27462;27601;27612.723872761417;8100.311473524698;8359.582020899052;8472.23749862503;8472.830543389098;8527.872081918777;3675.6691897728797;3721.981390093032;3735.831887565066;3743.401055831054;3750.587435382106;4110.445089912883;4173.227952828736;4188.979055104766;4199.853005144866;4218;828.3580225325301;849.0702680564772;854.5812551849549;860.0968982568278;862.1507814802414;649.4641920415676;674.9291324410964;675.0920012583068;680.4352387518348;683.6786710246176;9923.454210018373;10457.372557646413;10462.895371046345;11039.668809935714;11350.886491134983;574.22192928582;602.1960682488926;607.0045125993374;607.0287539936155;610.1854024876839;4479.081788233404;4586.4725556561425;4603.953960460352;4758.667573079543;4761.47623761386;92498.53750731204;94370;95691.0430895696;96042;97451.51274243584;84391;84581;85274.5736271327;85626;86257.1374286249;70448;70640.64679676671;70650;70824;71716;10480.266381353233;10574.101201397967;10884.836727448936;11168.441577921234;11304.49129789145;27504.17487475379;28255.71744282613;28737.281567960967;29071.563926540697;29952;53059.73470132625;55120;55166.72416637891;55404.44595553993;56180.71909640425;15643.217839107772;15695.764563531784;15703.371865125268;15786.368545258061;15884.68230635404;16870.57823554372;16875.156242187597;17728.55678608045;17863.017534035753;17898.731519026966;15523.611909702347;15675.137867416945;15823.050616963019;15919.204039798195;16068.196590170211;15763.921180394025;15784.21078946071;15978.60053498672;16525.66948660996;16555;14750.778738318719;14833.851661483248;15185.16481593523;15325.46360877364;15578.454754083552;10736.46317684097;11319;11465;11733.413329333329;11867.525298987945;12056.156069075081;12566.434510446868;12585.119041666996;12624.431900564681;12756.744865102832 09:39:31 INFO - PID 3548 | __end_tp_report 09:39:31 INFO - PID 3548 | __start_cc_report 09:39:31 INFO - PID 3548 | _x_x_mozilla_cycle_collect,384 09:39:31 INFO - PID 3548 | __end_cc_report 09:39:31 INFO - PID 3548 | __startTimestamp1496767171194__endTimestamp 09:39:31 INFO - PID 3548 | 09:39:31 INFO - PID 3548 | ------- Summary: start ------- 09:39:31 INFO - PID 3548 | Number of tests: 6 09:39:31 INFO - PID 3548 | 09:39:31 INFO - PID 3548 | [#0] dojo.html Cycles:165 Average:5996.37 Median:6218.72 stddev:687.66 (11.1%) stddev-sans-first:651.00 09:39:31 INFO - PID 3548 | Values: 3094.5 3100.7 3120.5 3132.8 3135.5 5935.5 5963.2 5973.0 5974.5 6000.1 5972.3 5998.0 6008.6 6009.8 6049.7 5574.4 5607.4 5676.7 5681.0 5691.5 5449.8 5636.4 5642.7 5661.3 5726.0 5613.1 5632.0 5696.5 5705.2 5717.5 5475.7 5527.9 5535.0 5562.5 5661.2 5556.9 5563.2 5595.8 5629.0 5648.1 6038.6 6041.6 6057.7 6099.8 6103.6 6206.2 6310.7 6485.0 6531.3 6554.7 6462.8 6590.2 6593.7 6600.0 6605.6 6042.3 6091.0 6097.8 6108.1 6111.0 6463.0 6554.9 6691.1 6697.7 6707.7 6271.0 6317.0 6381.3 6385.5 6390.9 6234.2 6317.7 6392.6 6487.1 6488.8 6452.0 6494.4 6505.4 6524.8 6532.1 6480.2 6527.5 6554.1 6572.2 6572.4 5083.1 5129.1 5210.8 5264.4 5301.0 4536.5 4567.9 4584.9 4587.6 4627.2 5613.8 5624.3 5657.4 5676.8 5691.8 6355.4 6394.9 6488.9 6577.7 6592.2 5669.2 5697.2 5711.2 5750.6 5754.8 5763.8 5773.8 5779.9 5799.8 5802.6 6121.8 6191.4 6372.5 6382.0 6405.8 6459.2 6551.2 6562.6 6569.2 6584.0 6283.2 6319.4 6342.6 6354.1 6379.8 6183.0 6380.7 6413.0 6429.3 6441.1 6408.5 6445.1 6477.4 6514.0 6530.6 6382.1 6384.4 6393.1 6399.4 6401.8 6164.8 6217.1 6276.1 6369.7 6411.6 6318.3 6323.2 6336.2 6353.8 6367.8 6458.3 6464.8 6471.9 6475.3 6483.7 6069.5 6218.7 6256.7 6278.8 6290.2 09:39:31 INFO - PID 3548 | 09:39:31 INFO - PID 3548 | [#1] ext.html Cycles:180 Average:33435.92 Median:32979.00 stddev:46395.83 (140.7%) stddev-sans-first:46460.69 09:39:31 INFO - PID 3548 | Values: 654.9 700.8 719.4 1227.3 1273.0 37221.6 37382.4 37441.8 37665.6 37700.6 35297.8 35441.8 35604.1 35615.5 35662.6 6901.0 7041.8 7053.2 7216.6 7221.3 7132.0 7245.3 7254.8 7277.5 7283.5 7255.9 7357.0 7363.2 7364.7 7380.0 7224.9 7282.6 7289.3 7290.5 7316.6 7183.2 7202.4 7241.9 7245.3 7259.6 33618.2 33678.3 33902.2 33924.8 33956.3 3450.8 3482.5 3487.9 3496.1 3497.8 27449.7 27506.7 27509.0 27535.4 27543.7 3579.6 3592.1 3607.6 3613.8 3621.4 163284.0 164023.2 164637.0 170513.0 176760.0 41278.8 41571.4 41655.8 41684.4 41754.0 43675.1 43834.3 43849.6 44868.6 45218.8 14400.6 14427.0 14532.9 14613.9 14651.6 11899.9 11959.8 11966.4 11995.9 12003.9 13486.2 13558.6 13633.7 13681.5 13872.9 5636.6 5711.5 5728.2 5817.5 5838.2 982.4 988.8 991.9 996.7 1006.1 21408.0 22188.4 22529.1 22578.5 22666.3 1049.1 1070.0 1070.1 1082.9 1128.2 11688.6 12181.0 12605.4 12619.4 12650.6 202014.0 203301.0 203342.0 203477.0 203888.0 46994.0 47130.5 47351.0 47496.5 47531.3 1342.1 1419.0 1419.2 1422.7 1427.9 20868.7 21384.8 23011.9 23189.7 23492.9 34934.0 34938.8 35034.0 35142.1 35145.3 164321.0 165599.2 165722.0 165828.2 165932.0 31920.8 32236.0 32491.4 32573.2 32608.5 37805.1 38970.6 39058.6 39127.4 39199.0 27908.6 28669.5 29122.1 29565.9 30395.7 28506.9 29023.7 29175.0 30578.0 30723.8 32510.8 32572.8 32943.0 33015.0 33306.2 27055.6 27094.2 28481.9 29167.9 29780.3 20682.3 23158.5 23532.2 23598.6 23752.2 09:39:31 INFO - PID 3548 | 09:39:31 INFO - PID 3548 | [#2] jquery.html Cycles:180 Average:30213.50 Median:2242.36 stddev:72886.30 (3250.4%) stddev-sans-first:73056.44 09:39:31 INFO - PID 3548 | Values: 417.9 420.0 425.0 439.4 443.4 19999.4 20616.3 20756.2 20860.5 22789.2 22870.3 23453.8 23557.4 23566.2 23595.8 6016.3 6168.6 6177.3 6177.8 6186.5 5234.3 5608.0 5696.2 6001.6 6052.1 5630.1 5655.5 5669.6 5675.3 5677.7 5625.9 5672.9 5676.6 5678.3 5688.2 5138.4 5139.7 5141.7 5144.2 5145.1 25572.0 25828.7 26031.2 26033.6 26138.2 1747.5 1770.1 1787.8 1789.2 1798.3 17128.1 17323.7 17413.0 17430.0 17442.0 2157.8 2160.1 2215.6 2224.8 2245.6 111626.4 116138.4 116408.4 116454.0 116465.4 11283.7 11905.8 11914.5 12061.2 12176.5 16837.4 16991.9 16994.7 16998.9 17099.6 8525.8 9017.7 9050.4 9074.5 9113.5 8717.0 8779.4 8794.6 8819.4 8871.4 7382.1 7660.3 7727.4 7891.4 7909.4 2217.2 2231.1 2239.1 2247.7 2402.4 913.1 924.5 931.0 974.2 981.7 18492.0 18832.0 19296.2 20539.0 21331.0 941.0 957.5 962.9 976.8 1019.2 9879.6 10186.7 10574.7 10604.8 10653.8 426295.0 430859.0 432425.0 437420.0 441383.0 95819.0 99770.0 99887.0 100012.0 105804.5 1128.5 1163.3 1198.5 1200.9 1211.0 18651.7 19987.7 20963.5 20990.9 21009.6 49031.8 50094.7 51496.0 51858.7 51931.0 62466.4 62720.0 62893.9 63134.4 64013.4 9728.7 9867.5 10116.4 10700.8 10841.3 16606.5 16721.9 16813.3 16860.2 18189.8 13108.5 13460.1 13639.9 13701.2 13782.4 13112.8 13800.2 14274.1 14338.6 14403.2 14122.4 14165.9 14197.4 14601.5 14626.9 10014.0 10513.2 10596.3 10665.7 10673.7 14109.5 14175.5 14232.4 14318.8 14403.2 09:39:31 INFO - PID 3548 | 09:39:31 INFO - PID 3548 | [#3] mootools.html Cycles:180 Average:6770.32 Median:3967.71 stddev:4306.54 (108.5%) stddev-sans-first:4299.18 09:39:31 INFO - PID 3548 | Values: 1324.5 1379.0 1389.1 1392.6 1419.1 10636.4 10946.4 11106.1 11131.4 11552.0 11079.4 11248.7 11254.4 11290.1 11318.9 2180.7 2211.5 2213.2 2214.1 2229.4 1858.1 1925.5 2268.4 2308.4 2357.7 2370.7 2384.9 2390.4 2398.1 2403.1 2230.1 2264.7 2270.9 2285.2 2305.5 2266.7 2284.6 2285.8 2296.7 2300.2 10887.5 11073.0 11108.5 11108.6 11132.8 6009.7 6186.5 6209.9 6247.9 6262.7 3618.3 3750.6 3823.3 3829.8 3844.2 1183.9 1218.8 1236.4 1245.8 1247.8 15749.4 15849.5 16012.9 16084.5 16146.4 5073.8 5136.3 5146.2 5259.9 5272.4 11896.3 11907.8 11911.1 11917.2 12070.7 5998.3 6204.8 6214.5 6215.7 6245.8 5757.5 5834.6 5841.7 5852.8 5864.7 3945.7 3989.7 4055.3 4084.2 4086.3 1135.8 1148.2 1169.0 1173.7 1174.3 840.0 841.2 862.9 863.7 891.7 6078.3 6495.5 6637.3 6800.7 7021.4 953.8 975.2 977.1 984.8 985.1 4041.9 4136.2 4356.4 4413.1 4477.1 13408.9 14029.2 14080.1 14157.8 14184.0 13899.6 14093.2 14104.4 14106.9 14116.6 8561.1 8727.3 8856.7 8889.0 8915.4 6237.4 6291.3 6472.7 6496.9 6673.0 12734.3 12887.4 12895.5 12938.5 13083.6 13018.5 13036.5 13038.5 13140.6 13212.0 8777.6 8985.0 8990.4 9017.2 9018.9 9460.9 9477.9 9509.2 9558.0 9582.5 8101.3 8154.5 8257.7 8328.3 8370.9 8041.4 8375.7 8659.3 8833.8 8911.0 7139.6 7328.9 7350.0 7373.2 7379.1 5425.6 5650.0 5787.2 5788.0 5955.1 5643.2 5824.2 5925.5 5954.5 6176.0 09:39:31 INFO - PID 3548 | 09:39:31 INFO - PID 3548 | [#4] prototype.html Cycles:180 Average:5479.19 Median:6169.90 stddev:1621.86 (26.3%) stddev-sans-first:1580.98 09:39:31 INFO - PID 3548 | Values: 400.6 405.6 409.2 411.5 411.5 6361.2 6368.2 6411.1 6424.5 6443.8 6152.9 6168.4 6171.4 6200.2 6244.3 4669.8 4774.9 4801.1 4806.7 4942.5 4833.2 4845.2 4856.8 4876.7 4878.5 4791.1 4791.4 4794.6 4799.8 4803.1 4797.0 4811.9 4825.2 4831.8 4846.5 4233.7 4235.8 4239.2 4240.8 4246.2 6085.2 6129.2 6138.1 6152.6 6174.8 5506.5 5518.8 5523.6 5524.3 5526.9 6505.3 6537.8 6554.9 6568.8 6571.4 4583.8 4595.2 4598.7 4613.8 4617.3 6521.8 6884.8 6921.6 6945.9 6952.7 4596.0 4635.5 4694.2 4704.3 4704.4 4699.1 4713.7 4753.8 4764.7 4782.7 5300.6 5431.8 5444.6 5466.2 5479.2 6540.6 6581.2 6598.2 6612.2 6622.7 1643.3 1652.1 1652.4 1655.2 1658.7 1073.4 1084.5 1110.7 1120.5 1120.9 5802.4 5845.7 5880.6 5881.9 5892.6 6755.4 6761.8 6774.3 6780.6 6801.3 5789.2 5812.9 5819.9 5823.4 5829.3 3599.9 3634.2 3647.1 3658.4 3670.2 6620.7 6623.3 6623.9 6638.8 6649.9 6892.7 6965.7 6978.5 6989.7 7016.2 6533.3 6560.8 6607.6 6617.4 6636.1 6750.8 6794.8 6795.5 6806.9 6825.2 6745.6 6761.3 6770.7 6771.3 6771.3 6217.9 6581.7 6587.9 6612.1 6617.5 4707.8 4708.6 4722.6 4723.3 4723.7 6726.5 6828.6 6852.3 6883.3 6884.6 6413.3 6633.9 6667.7 6676.9 6678.3 6620.4 6622.6 6626.0 6640.9 6667.8 6506.9 6535.2 6560.5 6563.2 6599.5 6647.9 6652.6 6683.4 6684.4 6700.6 6475.5 6491.4 6499.7 6543.5 6564.4 09:39:31 INFO - PID 3548 | 09:39:31 INFO - PID 3548 | [#5] yui.html Cycles:180 Average:19891.94 Median:27483.09 stddev:25905.16 (94.3%) stddev-sans-first:25938.21 09:39:31 INFO - PID 3548 | Values: 810.7 833.2 837.1 838.6 848.7 16712.7 17052.2 17074.0 18845.2 19887.4 18592.8 18686.3 18726.7 18811.0 18896.7 978.0 997.7 998.9 1000.5 1003.4 924.4 990.8 993.8 1003.1 1005.2 1044.1 1062.5 1062.6 1064.4 1064.9 1040.7 1050.6 1055.0 1057.6 1059.0 765.0 772.2 775.2 776.1 777.5 16846.2 17381.7 17437.2 17439.7 17705.6 19149.8 19159.8 19431.4 19454.3 19593.1 15102.7 15268.6 15298.7 15302.2 15325.8 3432.2 3471.5 3512.6 3520.1 3535.1 80251.6 81808.2 98770.5 99556.5 99781.0 14342.1 15155.4 15167.2 15197.8 15310.8 27243.2 27375.5 27462.0 27601.0 27612.7 8100.3 8359.6 8472.2 8472.8 8527.9 3675.7 3722.0 3735.8 3743.4 3750.6 4110.4 4173.2 4189.0 4199.9 4218.0 828.4 849.1 854.6 860.1 862.2 649.5 674.9 675.1 680.4 683.7 9923.5 10457.4 10462.9 11039.7 11350.9 574.2 602.2 607.0 607.0 610.2 4479.1 4586.5 4604.0 4758.7 4761.5 92498.5 94370.0 95691.0 96042.0 97451.5 84391.0 84581.0 85274.6 85626.0 86257.1 70448.0 70640.6 70650.0 70824.0 71716.0 10480.3 10574.1 10884.8 11168.4 11304.5 27504.2 28255.7 28737.3 29071.6 29952.0 53059.7 55120.0 55166.7 55404.4 56180.7 15643.2 15695.8 15703.4 15786.4 15884.7 16870.6 16875.2 17728.6 17863.0 17898.7 15523.6 15675.1 15823.1 15919.2 16068.2 15763.9 15784.2 15978.6 16525.7 16555.0 14750.8 14833.9 15185.2 15325.5 15578.5 10736.5 11319.0 11465.0 11733.4 11867.5 12056.2 12566.4 12585.1 12624.4 12756.7 09:39:31 INFO - PID 3548 | -------- Summary: end -------- 09:39:31 INFO - PID 3548 | 09:39:32 INFO - TEST-INFO | 3548: exit 0 09:39:32 INFO - TEST-OK | dromaeo_css | took 1144655ms 09:39:32 INFO - TEST-START | kraken 09:39:32 INFO - operating with platform_type : linux_ 09:39:32 INFO - Initialising browser for kraken test... 09:39:32 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:35378/getInfo.html -profile /tmp/tmpYNiV1J/profile 09:39:32 INFO - TEST-INFO | started process 3965 (/builds/slave/test/build/application/firefox/firefox http://localhost:35378/getInfo.html) 09:40:06 INFO - TEST-INFO | 3965: killed by SIGTERM 09:40:06 INFO - Browser initialized. 09:40:06 INFO - Running cycle 1/1 for kraken test... 09:40:06 INFO - TEST-INFO | started process 4194 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpYNiV1J/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:40:18 INFO - PID 4194 | RSS: Main: 199987200 09:40:18 INFO - PID 4194 | 09:40:21 INFO - PID 4194 | Cycle 1(1): loaded http://localhost:35378/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:35378/tests/kraken/driver.html?testName=audio-beat-detection) 09:40:22 INFO - PID 4194 | RSS: Main: 200679424 09:40:22 INFO - PID 4194 | 09:40:24 INFO - PID 4194 | Cycle 1(1): loaded http://localhost:35378/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:35378/tests/kraken/driver.html?testName=audio-dft) 09:40:25 INFO - PID 4194 | RSS: Main: 198873088 09:40:25 INFO - PID 4194 | 09:40:28 INFO - PID 4194 | Cycle 1(1): loaded http://localhost:35378/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:35378/tests/kraken/driver.html?testName=audio-fft) 09:40:29 INFO - PID 4194 | RSS: Main: 189825024 09:40:29 INFO - PID 4194 | 09:40:31 INFO - PID 4194 | Cycle 1(1): loaded http://localhost:35378/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:35378/tests/kraken/driver.html?testName=audio-oscillator) 09:40:31 INFO - PID 4194 | RSS: Main: 190480384 09:40:31 INFO - PID 4194 | 09:40:33 INFO - PID 4194 | Cycle 1(1): loaded http://localhost:35378/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:35378/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:40:34 INFO - PID 4194 | RSS: Main: 190320640 09:40:34 INFO - PID 4194 | 09:40:37 INFO - PID 4194 | Cycle 1(1): loaded http://localhost:35378/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:35378/tests/kraken/driver.html?testName=imaging-darkroom) 09:40:38 INFO - PID 4194 | RSS: Main: 191803392 09:40:38 INFO - PID 4194 | 09:40:41 INFO - PID 4194 | Cycle 1(1): loaded http://localhost:35378/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:35378/tests/kraken/driver.html?testName=imaging-desaturate) 09:40:42 INFO - PID 4194 | RSS: Main: 190070784 09:40:42 INFO - PID 4194 | 09:40:45 INFO - PID 4194 | Cycle 1(1): loaded http://localhost:35378/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:35378/tests/kraken/driver.html?testName=json-parse-financial) 09:40:45 INFO - PID 4194 | RSS: Main: 190926848 09:40:45 INFO - PID 4194 | 09:40:47 INFO - PID 4194 | Cycle 1(1): loaded http://localhost:35378/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:35378/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:40:48 INFO - PID 4194 | RSS: Main: 191168512 09:40:48 INFO - PID 4194 | 09:40:49 INFO - PID 4194 | Cycle 1(1): loaded http://localhost:35378/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:35378/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:40:50 INFO - PID 4194 | RSS: Main: 190693376 09:40:50 INFO - PID 4194 | 09:40:52 INFO - PID 4194 | Cycle 1(1): loaded http://localhost:35378/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:35378/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:40:53 INFO - PID 4194 | RSS: Main: 190951424 09:40:53 INFO - PID 4194 | 09:40:56 INFO - PID 4194 | Cycle 1(1): loaded http://localhost:35378/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:35378/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:40:56 INFO - PID 4194 | RSS: Main: 191291392 09:40:56 INFO - PID 4194 | 09:41:00 INFO - PID 4194 | Cycle 1(1): loaded http://localhost:35378/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:35378/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:41:00 INFO - PID 4194 | RSS: Main: 191451136 09:41:00 INFO - PID 4194 | 09:41:02 INFO - PID 4194 | Cycle 1(1): loaded http://localhost:35378/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:35378/tests/kraken/driver.html?testName=ai-astar) 09:41:02 INFO - PID 4194 | RSS: Main: 192905216 09:41:02 INFO - PID 4194 | 09:41:02 INFO - PID 4194 | __start_tp_report 09:41:02 INFO - PID 4194 | _x_x_mozilla_page_load 09:41:02 INFO - PID 4194 | _x_x_mozilla_page_load_details 09:41:02 INFO - PID 4194 | |i|pagename|runs| 09:41:02 INFO - PID 4194 | |0;ai-astar;103;111;115;112;110;112;110;110;111;111 09:41:02 INFO - PID 4194 | |1;audio-beat-detection;160;127;123;172;124;129;122;128;148;124 09:41:02 INFO - PID 4194 | |2;audio-dft;162;169;166;166;162;165;169;175;162;161 09:41:02 INFO - PID 4194 | |3;audio-fft;77;75;73;111;79;76;77;75;100;75 09:41:02 INFO - PID 4194 | |4;audio-oscillator;85;83;103;89;82;82;96;85;82;102 09:41:02 INFO - PID 4194 | |5;imaging-gaussian-blur;118;119;114;114;115;114;114;114;113;117 09:41:02 INFO - PID 4194 | |6;imaging-darkroom;150;150;151;156;150;155;151;151;150;154 09:41:02 INFO - PID 4194 | |7;imaging-desaturate;94;94;94;95;94;94;95;99;94;95 09:41:02 INFO - PID 4194 | |8;json-parse-financial;55;57;54;55;55;61;61;55;58;58 09:41:02 INFO - PID 4194 | |9;json-stringify-tinderbox;55;56;55;58;54;55;56;57;55;56 09:41:02 INFO - PID 4194 | |10;stanford-crypto-aes;90;88;98;87;87;87;91;89;110;92 09:41:02 INFO - PID 4194 | |11;stanford-crypto-ccm;134;138;132;129;128;129;128;136;142;137 09:41:02 INFO - PID 4194 | |12;stanford-crypto-pbkdf2;188;195;194;193;189;198;191;198;194;193 09:41:02 INFO - PID 4194 | |13;stanford-crypto-sha256-iterative;74;72;73;76;72;71;71;73;78;71 09:41:02 INFO - PID 4194 | __end_tp_report 09:41:02 INFO - PID 4194 | __start_cc_report 09:41:02 INFO - PID 4194 | _x_x_mozilla_cycle_collect,994 09:41:02 INFO - PID 4194 | __end_cc_report 09:41:02 INFO - PID 4194 | __startTimestamp1496767262653__endTimestamp 09:41:02 INFO - PID 4194 | 09:41:02 INFO - PID 4194 | ------- Summary: start ------- 09:41:02 INFO - PID 4194 | Number of tests: 14 09:41:02 INFO - PID 4194 | 09:41:02 INFO - PID 4194 | [#0] ai-astar Cycles:10 Average:110.50 Median:111.00 stddev:3.03 (2.7%) stddev-sans-first:1.58 09:41:02 INFO - PID 4194 | Values: 103.0 111.0 115.0 112.0 110.0 112.0 110.0 110.0 111.0 111.0 09:41:02 INFO - PID 4194 | 09:41:02 INFO - PID 4194 | [#1] audio-beat-detection Cycles:10 Average:135.70 Median:128.50 stddev:17.83 (13.9%) stddev-sans-first:16.61 09:41:02 INFO - PID 4194 | Values: 160.0 127.0 123.0 172.0 124.0 129.0 122.0 128.0 148.0 124.0 09:41:02 INFO - PID 4194 | 09:41:02 INFO - PID 4194 | [#2] audio-dft Cycles:10 Average:165.70 Median:166.00 stddev:4.37 (2.6%) stddev-sans-first:4.43 09:41:02 INFO - PID 4194 | Values: 162.0 169.0 166.0 166.0 162.0 165.0 169.0 175.0 162.0 161.0 09:41:02 INFO - PID 4194 | 09:41:02 INFO - PID 4194 | [#3] audio-fft Cycles:10 Average:81.80 Median:75.50 stddev:12.86 (17.0%) stddev-sans-first:13.52 09:41:02 INFO - PID 4194 | Values: 77.0 75.0 73.0 111.0 79.0 76.0 77.0 75.0 100.0 75.0 09:41:02 INFO - PID 4194 | 09:41:02 INFO - PID 4194 | [#4] audio-oscillator Cycles:10 Average:88.90 Median:84.00 stddev:8.36 (10.0%) stddev-sans-first:8.75 09:41:02 INFO - PID 4194 | Values: 85.0 83.0 103.0 89.0 82.0 82.0 96.0 85.0 82.0 102.0 09:41:02 INFO - PID 4194 | 09:41:02 INFO - PID 4194 | [#5] imaging-gaussian-blur Cycles:10 Average:115.20 Median:114.50 stddev:2.04 (1.8%) stddev-sans-first:1.90 09:41:02 INFO - PID 4194 | Values: 118.0 119.0 114.0 114.0 115.0 114.0 114.0 114.0 113.0 117.0 09:41:02 INFO - PID 4194 | 09:41:02 INFO - PID 4194 | [#6] imaging-darkroom Cycles:10 Average:151.80 Median:151.00 stddev:2.30 (1.5%) stddev-sans-first:2.35 09:41:02 INFO - PID 4194 | Values: 150.0 150.0 151.0 156.0 150.0 155.0 151.0 151.0 150.0 154.0 09:41:02 INFO - PID 4194 | 09:41:02 INFO - PID 4194 | [#7] imaging-desaturate Cycles:10 Average:94.80 Median:94.50 stddev:1.55 (1.6%) stddev-sans-first:1.62 09:41:02 INFO - PID 4194 | Values: 94.0 94.0 94.0 95.0 94.0 94.0 95.0 99.0 94.0 95.0 09:41:02 INFO - PID 4194 | 09:41:02 INFO - PID 4194 | [#8] json-parse-financial Cycles:10 Average:56.90 Median:57.50 stddev:2.56 (4.4%) stddev-sans-first:2.62 09:41:02 INFO - PID 4194 | Values: 55.0 57.0 54.0 55.0 55.0 61.0 61.0 55.0 58.0 58.0 09:41:02 INFO - PID 4194 | 09:41:02 INFO - PID 4194 | [#9] json-stringify-tinderbox Cycles:10 Average:55.70 Median:56.00 stddev:1.16 (2.1%) stddev-sans-first:1.20 09:41:02 INFO - PID 4194 | Values: 55.0 56.0 55.0 58.0 54.0 55.0 56.0 57.0 55.0 56.0 09:41:02 INFO - PID 4194 | 09:41:02 INFO - PID 4194 | [#10] stanford-crypto-aes Cycles:10 Average:91.90 Median:89.50 stddev:7.19 (8.0%) stddev-sans-first:7.59 09:41:02 INFO - PID 4194 | Values: 90.0 88.0 98.0 87.0 87.0 87.0 91.0 89.0 110.0 92.0 09:41:02 INFO - PID 4194 | 09:41:02 INFO - PID 4194 | [#11] stanford-crypto-ccm Cycles:10 Average:133.30 Median:135.00 stddev:4.88 (3.6%) stddev-sans-first:5.17 09:41:02 INFO - PID 4194 | Values: 134.0 138.0 132.0 129.0 128.0 129.0 128.0 136.0 142.0 137.0 09:41:02 INFO - PID 4194 | 09:41:02 INFO - PID 4194 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:193.30 Median:194.00 stddev:3.33 (1.7%) stddev-sans-first:2.93 09:41:02 INFO - PID 4194 | Values: 188.0 195.0 194.0 193.0 189.0 198.0 191.0 198.0 194.0 193.0 09:41:02 INFO - PID 4194 | 09:41:02 INFO - PID 4194 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:73.10 Median:73.00 stddev:2.33 (3.2%) stddev-sans-first:2.45 09:41:02 INFO - PID 4194 | Values: 74.0 72.0 73.0 76.0 72.0 71.0 71.0 73.0 78.0 71.0 09:41:02 INFO - PID 4194 | -------- Summary: end -------- 09:41:02 INFO - PID 4194 | 09:41:03 INFO - TEST-INFO | 4194: exit 0 09:41:03 INFO - TEST-OK | kraken | took 91824ms 09:41:03 INFO - SUITE-END | took 1236s 09:41:04 INFO - Completed test suite (00:20:36) 09:41:04 INFO - javascript benchmark 09:41:04 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7649.10934384218, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3094.4739394302965, 3100.7054329838666, 3120.469520181569, 3132.8120312781234, 3135.5139953307244, 5935.525157987361, 5963.194968679227, 5972.970135149329, 5974.4622983931495, 6000.099985002252, 5972.313183983843, 5998.040313549822, 6008.579399442041, 6009.849753756158, 6049.727762250698, 5574.442555744414, 5607.355154157273, 5676.716164191774, 5681.034224181899, 5691.459311365435, 5449.782008719647, 5636.436356364351, 5642.689652069134, 5661.264035675356, 5725.971370143144, 5613.07384281593, 5632.04255276604, 5696.544276457874, 5705.229793977802, 5717.456841600062, 5475.698836563987, 5527.944720552823, 5535.0, 5562.527185189264, 5661.179129026309, 5556.91664625031, 5563.193336966157, 5595.832125036255, 5629.043062679354, 5648.124540696199, 6038.57729958903, 6041.6375017499095, 6057.697115144225, 6099.756009759604, 6103.572749907508, 6206.162168107293, 6310.684465776739, 6485.0, 6531.314212007718, 6554.737810487575, 6462.838429039265, 6590.242122155918, 6593.703283352261, 6600.0, 6605.636689982049, 6042.335343112254, 6090.969545152246, 6097.847553811146, 6108.08378743192, 6111.0, 6463.0, 6554.901676474857, 6691.130153080068, 6697.665116744143, 6707.731690732414, 6271.0, 6316.968415157895, 6381.329960354189, 6385.5210859185745, 6390.8721825563225, 6234.220722409699, 6317.652529110943, 6392.584482008655, 6487.091807147003, 6488.837779055561, 6452.032195170762, 6494.350564943468, 6505.447037001908, 6524.771632992823, 6532.052852336385, 6480.189976252968, 6527.510436717265, 6554.147960765165, 6572.211334639874, 6572.375624315778, 5083.135866902636, 5129.12804823181, 5210.843674689765, 5264.368275806928, 5301.0, 4536.455625324982, 4567.931481027787, 4584.862454126382, 4587.610053145453, 4627.213373726408, 5613.775448982076, 5624.325080990226, 5657.4059723728415, 5676.772929082873, 5691.772329106872, 6355.396237357444, 6394.912864812993, 6488.870222595521, 6577.736890524421, 6592.17597800275, 5669.234653321749, 5697.202391665171, 5711.228984087178, 5750.6262092963825, 5754.827355179351, 5763.827085187451, 5773.797917072882, 5779.942200577941, 5799.82600521985, 5802.593818432669, 6121.7578389577775, 6191.442770150708, 6372.490200784019, 6381.968090159519, 6405.807825765234, 6459.192600924885, 6551.21385433751, 6562.573432726857, 6569.178852643419, 6583.967080164569, 6283.151774510383, 6319.368063193828, 6342.587731797418, 6354.078658594571, 6379.840503987438, 6183.0, 6380.744770209325, 6413.0, 6429.292777794345, 6441.066045423481, 6408.455281300955, 6445.065465507381, 6477.4170324671, 6513.967430162819, 6530.640814755234, 6382.138411314413, 6384.3934826191435, 6393.104965304954, 6399.424051835357, 6401.77593784234, 6164.7842325518395, 6217.129601855653, 6276.089966954857, 6369.7452101915405, 6411.551191416743, 6318.336574659778, 6323.177986861862, 6336.17629708135, 6353.777617783356, 6367.840803979938, 6458.289588145394, 6464.773732919325, 6471.902921456088, 6475.255345635123, 6483.708233129426, 6069.514438844793, 6218.720157593009, 6256.687165641791, 6278.780242691667, 6290.150829637941], "value": 5946.232895822315, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [654.8788474132286, 700.7722490190688, 719.399301583178, 1227.3249712658037, 1273.0261350067194, 37221.62778372216, 37382.43926341107, 37441.81279093604, 37665.62334376655, 37700.622993770055, 35297.82351088241, 35441.82279088607, 35604.10989725258, 35615.4657680135, 35662.64337356626, 6900.96549517253, 7041.753538626123, 7053.224145344008, 7216.603086830222, 7221.31397517235, 7132.0, 7245.311695388929, 7254.782356529313, 7277.526960747535, 7283.490155689104, 7255.927440725578, 7357.0, 7363.2268611795525, 7364.705411783522, 7380.0, 7224.927750722478, 7282.635868206595, 7289.271072892721, 7290.526115802456, 7316.56100633961, 7183.173934997438, 7202.387797037258, 7241.8551628967125, 7245.311695388929, 7259.60072196029, 33618.1595460113, 33678.32643347119, 33902.1524461888, 33924.83037584796, 33956.320873582634, 3450.8102054387, 3482.5472688550326, 3487.877924272638, 3496.108492334464, 3497.8425970831117, 27449.725502744917, 27506.724932750618, 27509.0, 27535.44929101407, 27543.724562754316, 3579.6420357964257, 3592.119930616989, 3607.621199774012, 3613.765105268149, 3621.3662609043313, 163284.0, 164023.1798840998, 164637.0, 170513.0, 176759.99999999872, 41278.79360603178, 41571.376429353586, 41655.7917210412, 41684.37473437901, 41754.0, 43675.12649746987, 43834.342484862755, 43849.56150438455, 44868.55131448709, 45218.77390613026, 14400.639984000274, 14427.0, 14532.854671453362, 14613.92693036528, 14651.633709157357, 11899.940500297444, 11959.820602690967, 11966.350263169817, 11995.880041199476, 12003.879961200277, 13486.190828550318, 13558.593242202749, 13633.727325453436, 13681.452741890413, 13872.907492289798, 5636.605437619327, 5711.543076553866, 5728.1694154348215, 5817.476427121579, 5838.153467747153, 982.3761911186448, 988.7972965542046, 991.8809742830762, 996.725900377402, 1006.0945149365483, 21408.0, 22188.445288867908, 22529.11614550085, 22578.54842903133, 22666.320010399715, 1049.1134990932649, 1069.978600427987, 1070.0525044419082, 1082.9241953063367, 1128.1651577832508, 11688.590899318484, 12181.0, 12605.432755526022, 12619.36903154857, 12650.620481385573, 202014.0, 203301.0, 203342.0, 203477.0, 203888.0, 46994.0, 47130.5286947133, 47351.0, 47496.52503474921, 47531.28703069457, 1342.1276170489066, 1418.971620567583, 1419.1697856753915, 1422.7225690990158, 1427.9357428915723, 20868.68696969577, 21384.78615213828, 23011.88494057519, 23189.652155217347, 23492.882535587214, 34933.95198143958, 34938.82530587331, 35034.0, 35142.12144696403, 35145.297094058486, 164321.0, 165599.1720041392, 165722.0, 165828.17085914494, 165932.0, 31920.840395797873, 32236.0, 32491.350172995935, 32573.18567035843, 32608.51087233646, 37805.05487362838, 38970.6102938967, 39058.6094139055, 39127.413088804264, 39199.0, 27908.58137127985, 28669.476519439857, 29122.12633620995, 29565.85217073901, 30395.734632645563, 28506.85746571337, 29023.709762902945, 29175.0, 30578.0, 30723.846380767955, 32510.83744581262, 32572.83713581417, 32943.0, 33015.0, 33306.167345816546, 27055.594166087918, 27094.1871743848, 28481.873676342344, 29167.85416072906, 29780.255493611967, 20682.276120335715, 23158.536829262983, 23532.176373826835, 23598.646020310054, 23752.168674096323], "value": 15803.383751319961, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [417.92477354076254, 420.03322510005285, 424.97237679550835, 439.43093693666697, 443.42797790849824, 19999.400017999447, 20616.278430254944, 20756.16975320989, 20860.478488037807, 22789.202377916776, 22870.313890583308, 23453.76546234537, 23557.41106472339, 23566.175183868567, 23595.764042359573, 6016.27804663441, 6168.599041062316, 6177.320494745574, 6177.783777567786, 6186.536009799283, 5234.298852872813, 5608.0, 5696.174054762057, 6001.639901605896, 6052.061930400795, 5630.071038278699, 5655.5475561954945, 5669.574781891354, 5675.290588676416, 5677.659340439587, 5625.859353516174, 5672.9432705672825, 5676.574256930747, 5678.34699009613, 5688.232088668018, 5138.409082955471, 5139.665921715076, 5141.74291285438, 5144.151215049513, 5145.125328694131, 25572.0, 25828.74171258282, 26031.21906342813, 26033.609495857578, 26138.215853524423, 1747.5106970048407, 1770.1326350088364, 1787.8390944815028, 1789.2306308287432, 1798.2537247042462, 17128.057956812372, 17323.65352692939, 17413.042282674447, 17430.041347725997, 17442.040687762168, 2157.8165855902266, 2160.146742036902, 2215.6344203206613, 2224.810891074261, 2245.607018771708, 111626.44186779096, 116138.41930790292, 116408.41795791051, 116453.99999999916, 116465.41767291194, 11283.717907052225, 11905.761884762256, 11914.46384912681, 12061.155719099754, 12176.452059657337, 16837.41069062577, 16991.91504042472, 16994.745078823827, 16998.91500542514, 17099.572510687332, 8525.786855328666, 9017.729468115967, 9050.387117520573, 9074.45553266806, 9113.498757568397, 8717.0, 8779.429337093068, 8794.560271986375, 8819.382643215042, 8871.379003469825, 7382.114146302478, 7660.2722741339485, 7727.420443466763, 7891.408144389194, 7909.378577391621, 2217.2018073493527, 2231.1187081102876, 2239.1043582567104, 2247.6516139998325, 2402.3633737059695, 913.1097180249336, 924.473050361301, 930.9581068851783, 974.2157563161722, 981.72866138351, 18492.0, 18832.022637623126, 19296.22815087409, 20539.0, 21331.0, 940.9623615055322, 957.5451660461365, 962.932594718377, 976.799756050008, 1019.2050200843354, 9879.555420006118, 10186.745331366626, 10574.735631609272, 10604.787904241872, 10653.84019239712, 426295.0, 430859.0, 432425.0, 437420.0, 441383.0, 95819.0, 99770.0, 99887.00564971722, 100012.0, 105804.47097764463, 1128.4865386249237, 1163.26714170074, 1198.4966314147905, 1200.903927685783, 1211.0311750599485, 18651.720224196375, 19987.66500542106, 20963.475913102295, 20990.895045524674, 21009.57980840405, 49031.754841225564, 50094.74952625213, 51496.0, 51858.74070629623, 51931.0, 62466.375336246056, 62720.0, 62893.936970084564, 63134.36865631285, 64013.35986640074, 9728.659496917573, 9867.506624668882, 10116.393016419039, 10700.785984280426, 10841.349519028883, 16606.50180494587, 16721.91639041797, 16813.327466901676, 16860.156992150587, 18189.818101819343, 13108.541201057917, 13460.125091868997, 13639.863601363859, 13701.246431445967, 13782.379792909143, 13112.803307950198, 13800.171989680652, 14274.072185307921, 14338.56984290473, 14403.207823569384, 14122.43510259578, 14165.929170354082, 14197.361118749888, 14601.488947886774, 14626.926865365605, 10014.0, 10513.211509136692, 10596.31123976939, 10665.733356666145, 10673.679789606324, 14109.506167284097, 14175.503857365355, 14232.359543820347, 14318.785218221943, 14403.207823569384], "value": 10318.52503292215, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1324.5231716582032, 1378.9862101378983, 1389.0554422992361, 1392.5891861900745, 1419.0634181440253, 10636.361818290909, 10946.39794811285, 11106.055985241264, 11131.443427828606, 11552.0, 11079.446027698623, 11248.662540123789, 11254.437278136102, 11290.09679225662, 11318.943405282962, 2180.672899065141, 2211.502411957305, 2213.181122984498, 2214.0811563201332, 2229.420350708819, 1858.135966775449, 1925.5089952062206, 2268.410213344534, 2308.365199570115, 2357.681712968753, 2370.6562548430466, 2384.9284521464297, 2390.4143484846236, 2398.136670798511, 2403.0748161957686, 2230.0856648774006, 2264.7169103862016, 2270.909163633453, 2285.2001799370337, 2305.5158416732424, 2266.7053283073096, 2284.6116160252795, 2285.771422857701, 2296.666983287414, 2300.18343488061, 10887.510062047228, 11073.0, 11108.500117494652, 11108.61119860801, 11132.827144263927, 6009.669468179249, 6186.536009799283, 6209.937900620981, 6247.875042499125, 6262.749490020394, 3618.3125206211, 3750.5686846012786, 3823.2926908521736, 3829.8276577554075, 3844.192719528902, 1183.8993685536739, 1218.8415505984253, 1236.4003458322707, 1245.8255844181822, 1247.7691627049026, 15749.370025199092, 15849.52451426459, 16012.919935400365, 16084.517464476085, 16146.434874779443, 5073.822416215415, 5136.306598609214, 5146.202338637517, 5259.868503287372, 5272.446393128743, 11896.345700986356, 11907.761844763056, 11911.10666700001, 11917.22538035025, 12070.69823254408, 5998.340182579913, 6204.7828326008375, 6214.471769899609, 6215.720292586844, 6245.781397651061, 5757.510611598061, 5834.591578589458, 5841.744025034553, 5852.765889364463, 5864.70676466175, 3945.684345252373, 3989.740666856645, 4055.2903241932545, 4084.223997440477, 4086.2644723949975, 1135.7614900870744, 1148.1915982327866, 1169.0180248591055, 1173.677238759348, 1174.2543484886987, 839.9916000840036, 841.1672444280118, 862.9137086291321, 863.6804382378434, 891.6968230801558, 6078.270607527125, 6495.487355852825, 6637.336266373324, 6800.727970881208, 7021.438284937193, 953.7696371680593, 975.2100798353357, 977.0571398600384, 984.8128855517429, 985.1281615769952, 4041.8989525261513, 4136.21411931732, 4356.390105385249, 4413.1394378095965, 4477.126960242721, 13408.865911340958, 14029.228392438514, 14080.084794488326, 14157.787633185304, 14184.0, 13899.583012509642, 14093.15441073539, 14104.435822567188, 14106.929465352812, 14116.576502704935, 8561.101084386175, 8727.258183054511, 8856.690015849543, 8888.955555222312, 8915.42049766763, 6237.4074462927765, 6291.307956124914, 6472.676366181766, 6496.870062598627, 6673.0, 12734.299613520974, 12887.42006609686, 12895.484180633044, 12938.482460701467, 13083.607491775261, 13018.479260829461, 13036.543720969721, 13038.47846086184, 13140.60578182656, 13212.0, 8777.561121944005, 8985.011648718504, 8990.370674052754, 9017.233535149586, 9018.909810902069, 9460.858087128561, 9477.905220947703, 9509.239260859253, 9558.0, 9582.472963987047, 8101.270885620323, 8154.469959452616, 8257.669693212205, 8328.250457458858, 8370.87443688333, 8041.437099402986, 8375.748727538183, 8659.263962563253, 8833.823323533365, 8911.019787823463, 7139.571625702474, 7328.926710732824, 7350.0, 7373.18894921569, 7379.077615298088, 5425.593080518898, 5650.0, 5787.218725472176, 5788.0, 5955.076963070731, 5643.209950606836, 5824.242848429677, 5925.496332811759, 5954.46409823118, 6176.042713379434], "value": 5124.889412812623, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [400.6414259237982, 405.63898130663694, 409.1510116508246, 411.4794784597483, 411.48975270664386, 6361.236651601808, 6368.235811702591, 6411.070394792752, 6424.453921416679, 6443.774467893625, 6152.876942461148, 6168.4448399644025, 6171.352008039158, 6200.224971878515, 6244.344343843888, 4669.789859456333, 4774.928376074345, 4801.135795556798, 4806.663533552653, 4942.517244826547, 4833.154198015351, 4845.2247640377545, 4856.805727770885, 4876.731779752112, 4878.536539028786, 4791.149266186613, 4791.401074865642, 4794.616430685537, 4799.760011999403, 4803.135435621587, 4796.97601511992, 4811.855644330676, 4825.227963525819, 4831.806727730886, 4846.515348465161, 4233.682473814445, 4235.767032813194, 4239.236937351276, 4240.830366785356, 4246.193223287565, 6085.2393450818645, 6129.1725617041575, 6138.14066030756, 6152.600080994765, 6174.84562885927, 5506.476884695948, 5518.806841760559, 5523.613347065667, 5524.33707955048, 5526.917096243559, 6505.251896031969, 6537.836554086139, 6554.901676474857, 6568.835779105513, 6571.408573228385, 4583.770811459413, 4595.2188128018315, 4598.655100867449, 4613.76931153441, 4617.3304870793545, 6521.771737989195, 6884.827879303058, 6921.619310937896, 6945.930540694579, 6952.721891124349, 4596.034832685174, 4635.513271106553, 4694.178518759271, 4704.270838020112, 4704.364910737075, 4699.107169637758, 4713.740744259098, 4753.809847606126, 4764.737939413296, 4782.736949467743, 5300.628955973045, 5431.8098866539485, 5444.5916556258435, 5466.234727138204, 5479.150731636602, 6540.640264785387, 6581.2102547694585, 6598.208215014133, 6612.173478315211, 6622.668866556653, 1643.2851709506403, 1652.0830938829065, 1652.4299116804684, 1655.2385902484991, 1658.6931417687767, 1073.3881687438086, 1084.5173897615484, 1110.722319420145, 1120.456578559398, 1120.9271397359146, 5802.448767367094, 5845.678487683218, 5880.588358814842, 5881.882362352729, 5892.646441213541, 6755.3582409671, 6761.830954226184, 6774.3225677431865, 6780.559263647847, 6801.285864984205, 5789.218455508537, 5812.94187058124, 5819.883602328015, 5823.446772556685, 5829.271341082364, 3599.94600080999, 3634.1823089804584, 3647.106458917582, 3658.4146536554554, 3670.247599242149, 6620.668966551653, 6623.271440141581, 6623.933760662332, 6638.800835974928, 6649.867002660017, 6892.655367231619, 6965.651717414109, 6978.546394484342, 6989.650517474106, 7016.158061032709, 6533.281339052701, 6560.835979100465, 6607.636579988147, 6617.43751781104, 6636.137302150786, 6750.831229219309, 6794.796156115324, 6795.456363491007, 6806.897896531457, 6825.249222585412, 6745.595264283962, 6761.3238676132, 6770.695318710571, 6771.255161932085, 6771.322867713189, 6217.916997805785, 6581.6709164540625, 6587.901181482377, 6612.140421745143, 6617.470602351704, 4707.764611769329, 4708.5997690195345, 4722.622190224705, 4723.267893476516, 4723.669343145947, 6726.495512836655, 6828.556143850634, 6852.2933441289415, 6883.346082122191, 6884.552504087218, 6413.294537600954, 6633.900491492535, 6667.699953502201, 6676.866462670622, 6678.265390806911, 6620.3710647488415, 6622.63575503352, 6626.0, 6640.933590664032, 6667.766628167991, 6506.934930650633, 6535.248446428532, 6560.539797575909, 6563.162314551933, 6599.5050371223315, 6647.933520664925, 6652.600843949379, 6683.4319082876555, 6684.364985326386, 6700.631465269457, 6475.546711730133, 6491.383318584727, 6499.6750162492635, 6543.5419520633095, 6564.372117657136], "value": 4967.7976128140535, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [810.7486679129466, 833.2417500074934, 837.1210229259278, 838.5639467476913, 848.7199224255996, 16712.74930876036, 17052.23264953077, 17074.0, 18845.15196816143, 19887.40337789865, 18592.814071859277, 18686.25254989802, 18726.71909921349, 18811.0, 18896.71654925177, 977.9608815647366, 997.6907158780765, 998.9200863930904, 1000.5347513406265, 1003.413003393016, 924.3760461688368, 990.7671697151163, 993.8260804359244, 1003.1272792670387, 1005.1807776662033, 1044.0551301072542, 1062.4687656171914, 1062.5643486170634, 1064.350746044912, 1064.930779499334, 1040.6513817870984, 1050.5745173204864, 1054.96307629233, 1057.5822550092748, 1059.0098258128673, 764.9579273139975, 772.1892013385923, 775.2402645407532, 776.1074764021364, 777.5218240781935, 16846.157692115346, 17381.652366952716, 17437.21532531039, 17439.73840392395, 17705.557361066076, 19149.80850191494, 19159.808401915943, 19431.4170574883, 19454.319098831475, 19593.118309676098, 15102.697946041128, 15268.618284542865, 15298.694026119416, 15302.158381289024, 15325.770113448196, 3432.2449061206494, 3471.548698669182, 3512.59605145409, 3520.137566296248, 3535.1338921964025, 80251.5987420065, 81808.18191818065, 98770.50614746952, 99556.50221748918, 99781.0, 14342.139471631735, 15155.393784248727, 15167.165805880783, 15197.772033419507, 15310.770338444932, 27243.182704518895, 27375.45249095007, 27462.0, 27601.0, 27612.723872761417, 8100.311473524698, 8359.582020899052, 8472.23749862503, 8472.830543389098, 8527.872081918777, 3675.6691897728797, 3721.981390093032, 3735.831887565066, 3743.401055831054, 3750.587435382106, 4110.445089912883, 4173.227952828736, 4188.979055104766, 4199.853005144866, 4218.0, 828.3580225325301, 849.0702680564772, 854.5812551849549, 860.0968982568278, 862.1507814802414, 649.4641920415676, 674.9291324410964, 675.0920012583068, 680.4352387518348, 683.6786710246176, 9923.454210018373, 10457.372557646413, 10462.895371046345, 11039.668809935714, 11350.886491134983, 574.22192928582, 602.1960682488926, 607.0045125993374, 607.0287539936155, 610.1854024876839, 4479.081788233404, 4586.4725556561425, 4603.953960460352, 4758.667573079543, 4761.47623761386, 92498.53750731204, 94370.0, 95691.0430895696, 96042.0, 97451.51274243584, 84391.0, 84581.0, 85274.5736271327, 85626.0, 86257.1374286249, 70448.0, 70640.64679676671, 70650.0, 70824.0, 71716.0, 10480.266381353233, 10574.101201397967, 10884.836727448936, 11168.441577921234, 11304.49129789145, 27504.17487475379, 28255.71744282613, 28737.281567960967, 29071.563926540697, 29952.0, 53059.73470132625, 55120.0, 55166.72416637891, 55404.44595553993, 56180.71909640425, 15643.217839107772, 15695.764563531784, 15703.371865125268, 15786.368545258061, 15884.68230635404, 16870.57823554372, 16875.156242187597, 17728.55678608045, 17863.017534035753, 17898.731519026966, 15523.611909702347, 15675.137867416945, 15823.050616963019, 15919.204039798195, 16068.196590170211, 15763.921180394025, 15784.21078946071, 15978.60053498672, 16525.66948660996, 16555.0, 14750.778738318719, 14833.851661483248, 15185.16481593523, 15325.46360877364, 15578.454754083552, 10736.46317684097, 11319.0, 11465.0, 11733.413329333329, 11867.525298987945, 12056.156069075081, 12566.434510446868, 12585.119041666996, 12624.431900564681, 12756.744865102832], "value": 8112.964336411897, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1548.6, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [103.0, 111.0, 115.0, 112.0, 110.0, 112.0, 110.0, 110.0, 111.0, 111.0], "value": 110.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 127.0, 123.0, 172.0, 124.0, 129.0, 122.0, 128.0, 148.0, 124.0], "value": 135.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 169.0, 166.0, 166.0, 162.0, 165.0, 169.0, 175.0, 162.0, 161.0], "value": 165.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 75.0, 73.0, 111.0, 79.0, 76.0, 77.0, 75.0, 100.0, 75.0], "value": 81.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 83.0, 103.0, 89.0, 82.0, 82.0, 96.0, 85.0, 82.0, 102.0], "value": 88.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 119.0, 114.0, 114.0, 115.0, 114.0, 114.0, 114.0, 113.0, 117.0], "value": 115.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 150.0, 151.0, 156.0, 150.0, 155.0, 151.0, 151.0, 150.0, 154.0], "value": 151.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 94.0, 95.0, 94.0, 94.0, 95.0, 99.0, 94.0, 95.0], "value": 94.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 57.0, 54.0, 55.0, 55.0, 61.0, 61.0, 55.0, 58.0, 58.0], "value": 56.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 56.0, 55.0, 58.0, 54.0, 55.0, 56.0, 57.0, 55.0, 56.0], "value": 55.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 88.0, 98.0, 87.0, 87.0, 87.0, 91.0, 89.0, 110.0, 92.0], "value": 91.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [134.0, 138.0, 132.0, 129.0, 128.0, 129.0, 128.0, 136.0, 142.0, 137.0], "value": 133.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [188.0, 195.0, 194.0, 193.0, 189.0, 198.0, 191.0, 198.0, 194.0, 193.0], "value": 193.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 72.0, 73.0, 76.0, 72.0, 71.0, 71.0, 73.0, 78.0, 71.0], "value": 73.1, "unit": "score"}]}]} 09:41:04 INFO - Return code: 0 09:41:04 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 09:41:04 INFO - # TBPL SUCCESS # 09:41:04 INFO - Running post-action listener: _resource_record_post_action 09:41:04 INFO - [mozharness: 2017-06-06 16:41:04.549995Z] Finished run-tests step (success) 09:41:04 INFO - Running post-run listener: _resource_record_post_run 09:41:04 INFO - Total resource usage - Wall time: 1255s; CPU: 13.0%; Read bytes: 8695808; Write bytes: 433459200; Read time: 1904; Write time: 228544 09:41:04 INFO - TinderboxPrint: CPU usage
12.7% 09:41:04 INFO - TinderboxPrint: I/O read bytes / time
8,695,808 / 1,904 09:41:04 INFO - TinderboxPrint: I/O write bytes / time
433,459,200 / 228,544 09:41:04 INFO - TinderboxPrint: CPU idle
8,745.7 (87.3%) 09:41:04 INFO - TinderboxPrint: CPU user
1,215.1 (12.1%) 09:41:04 INFO - TinderboxPrint: Swap in / out
0 / 0 09:41:04 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 4096; Write bytes: 134983680; Read time: 152; Write time: 63416 09:41:04 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 09:41:04 INFO - run-tests - Wall time: 1238s; CPU: 13.0%; Read bytes: 6848512; Write bytes: 198541312; Read time: 1664; Write time: 68572 09:41:05 INFO - Running post-run listener: _upload_blobber_files 09:41:05 INFO - Blob upload gear active. 09:41:05 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 09:41:05 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 09:41:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 09:41:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 09:41:05 INFO - (blobuploader) - INFO - Open directory for files ... 09:41:05 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 09:41:05 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:41:05 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:41:06 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 09:41:06 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:41:06 INFO - (blobuploader) - INFO - Done attempting. 09:41:06 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 09:41:06 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:41:06 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:41:07 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 09:41:07 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:41:07 INFO - (blobuploader) - INFO - Done attempting. 09:41:07 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 09:41:07 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:41:07 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:41:10 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 09:41:10 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:41:10 INFO - (blobuploader) - INFO - Done attempting. 09:41:10 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 09:41:10 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:41:10 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:41:11 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 09:41:11 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:41:11 INFO - (blobuploader) - INFO - Done attempting. 09:41:11 INFO - (blobuploader) - INFO - Iteration through files over. 09:41:11 INFO - Return code: 0 09:41:11 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 09:41:11 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 09:41:11 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ee4c76bab96268a2bfe5d2400f16b099aa755b4ce0d966ed83146491369e1cf29c7a73e1c50b8663893ee339b8807e014b6888e825be255dd5750b15abd5597b", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/71e2eeb0bed15f65603416012d88b1fd25b400b88fcb8b4a8e49e7da810968ef58de8f3faa3c977c673b48abb3639c0348e66e7bfb699de5d78b05db32da0b00", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/02e8b30688af5b1dc150e616b7c1959a9c662441fc47fce46dca24b9b34ddbdd9799c6d148217bd4b3128c3d364805a28f0278536c5fc6d39f8533d9bee1342d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6c1b978662d17669ab75c7d2d367350cf4cca3d4e67f61d6220331ede47a77b15abeb4935b428081d7e030269d451e33d2984bf9e908630dd1b3d652dbaa2078"} 09:41:11 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 09:41:11 INFO - Writing to file /builds/slave/test/properties/blobber_files 09:41:11 INFO - Contents: 09:41:11 INFO - blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ee4c76bab96268a2bfe5d2400f16b099aa755b4ce0d966ed83146491369e1cf29c7a73e1c50b8663893ee339b8807e014b6888e825be255dd5750b15abd5597b", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/71e2eeb0bed15f65603416012d88b1fd25b400b88fcb8b4a8e49e7da810968ef58de8f3faa3c977c673b48abb3639c0348e66e7bfb699de5d78b05db32da0b00", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/02e8b30688af5b1dc150e616b7c1959a9c662441fc47fce46dca24b9b34ddbdd9799c6d148217bd4b3128c3d364805a28f0278536c5fc6d39f8533d9bee1342d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6c1b978662d17669ab75c7d2d367350cf4cca3d4e67f61d6220331ede47a77b15abeb4935b428081d7e030269d451e33d2984bf9e908630dd1b3d652dbaa2078"} 09:41:11 INFO - Running post-run listener: copy_logs_to_upload_dir 09:41:11 INFO - Copying logs to upload dir... 09:41:11 INFO - mkdir: /builds/slave/test/build/upload/logs 09:41:11 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1321.727716 ========= master_lag: -0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 22 mins, 1 secs) (at 2017-06-06 09:41:11.785581) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-06-06 09:41:11.790566) ========= 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=e0e61f6f900f4dc42e3e8956000001ad-1496765643.857840-997882870 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/ee4c76bab96268a2bfe5d2400f16b099aa755b4ce0d966ed83146491369e1cf29c7a73e1c50b8663893ee339b8807e014b6888e825be255dd5750b15abd5597b", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/71e2eeb0bed15f65603416012d88b1fd25b400b88fcb8b4a8e49e7da810968ef58de8f3faa3c977c673b48abb3639c0348e66e7bfb699de5d78b05db32da0b00", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/02e8b30688af5b1dc150e616b7c1959a9c662441fc47fce46dca24b9b34ddbdd9799c6d148217bd4b3128c3d364805a28f0278536c5fc6d39f8533d9bee1342d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6c1b978662d17669ab75c7d2d367350cf4cca3d4e67f61d6220331ede47a77b15abeb4935b428081d7e030269d451e33d2984bf9e908630dd1b3d652dbaa2078"} build_url:https://queue.taskcluster.net/v1/task/ECGZ_RQZS4CyP3kbNjdMZw/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011346 build_url: 'https://queue.taskcluster.net/v1/task/ECGZ_RQZS4CyP3kbNjdMZw/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ee4c76bab96268a2bfe5d2400f16b099aa755b4ce0d966ed83146491369e1cf29c7a73e1c50b8663893ee339b8807e014b6888e825be255dd5750b15abd5597b", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/71e2eeb0bed15f65603416012d88b1fd25b400b88fcb8b4a8e49e7da810968ef58de8f3faa3c977c673b48abb3639c0348e66e7bfb699de5d78b05db32da0b00", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/02e8b30688af5b1dc150e616b7c1959a9c662441fc47fce46dca24b9b34ddbdd9799c6d148217bd4b3128c3d364805a28f0278536c5fc6d39f8533d9bee1342d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6c1b978662d17669ab75c7d2d367350cf4cca3d4e67f61d6220331ede47a77b15abeb4935b428081d7e030269d451e33d2984bf9e908630dd1b3d652dbaa2078"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-06-06 09:41:11.815553) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-06-06 09:41:11.815921) ========= 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=e0e61f6f900f4dc42e3e8956000001ad-1496765643.857840-997882870 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004398 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-06-06 09:41:11.900702) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-06-06 09:41:11.901061) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-06-06 09:41:11.901413) ========= ========= Total master_lag: 0.18 =========