builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-028 starttime: 1496227975.71 results: success (0) revision: 7b8937970f9ca85db88cb2496f2112175fd847c8 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-05-31 03:52:55.708333) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-05-31 03:52:55.708739) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-31 03:52:55.709039) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-31 03:52:55.744119) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-31 03:52:55.744397) ========= 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=836cfdc75598d54cb747368e000001a9-1496225697.633254-970548499 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-05-31 03:52:56-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.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% 35.3M=0s 2017-05-31 03:52:56 (35.3 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.361550 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-31 03:52:56.122394) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-31 03:52:56.122724) ========= 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=836cfdc75598d54cb747368e000001a9-1496225697.633254-970548499 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017442 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-31 03:52:56.172590) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-05-31 03:52:56.172900) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 7b8937970f9ca85db88cb2496f2112175fd847c8 --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 7b8937970f9ca85db88cb2496f2112175fd847c8 --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=836cfdc75598d54cb747368e000001a9-1496225697.633254-970548499 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-05-31 03:52:56,492 truncating revision to first 12 chars 2017-05-31 03:52:56,492 Setting DEBUG logging. 2017-05-31 03:52:56,492 attempt 1/10 2017-05-31 03:52:56,492 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/7b8937970f9c?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-05-31 03:52:56,813 unpacking tar archive at: mozilla-central-7b8937970f9c/testing/mozharness/ program finished with exit code 0 elapsedTime=1.081409 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-05-31 03:52:57.273193) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-31 03:52:57.273499) ========= script_repo_revision: 7b8937970f9ca85db88cb2496f2112175fd847c8 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-31 03:52:57.273942) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-31 03:52:57.274254) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-31 03:52:57.282852) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 51 secs) (at 2017-05-31 03:52:57.283168) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 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-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-Non-PGO'] 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=836cfdc75598d54cb747368e000001a9-1496225697.633254-970548499 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 03:52:57 INFO - MultiFileLogger online at 20170531 03:52:57 in /builds/slave/test 03:52:57 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 03:52:57 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:52:57 INFO - {'append_to_log': False, 03:52:57 INFO - 'base_work_dir': '/builds/slave/test', 03:52:57 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 03:52:57 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:52:57 INFO - 'branch': 'Firefox-Non-PGO', 03:52:57 INFO - 'buildbot_json_path': 'buildprops.json', 03:52:57 INFO - 'config_files': ('talos/linux_config.py',), 03:52:57 INFO - 'default_actions': ('clobber', 03:52:57 INFO - 'read-buildbot-config', 03:52:57 INFO - 'download-and-extract', 03:52:57 INFO - 'populate-webroot', 03:52:57 INFO - 'create-virtualenv', 03:52:57 INFO - 'install', 03:52:57 INFO - 'setup-mitmproxy', 03:52:57 INFO - 'run-tests'), 03:52:57 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:52:57 INFO - 'download_minidump_stackwalk': True, 03:52:57 INFO - 'download_symbols': 'ondemand', 03:52:57 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 03:52:57 INFO - 'tooltool.py': '/tools/tooltool.py', 03:52:57 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 03:52:57 INFO - '/tools/misc-python/virtualenv.py')}, 03:52:57 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:52:57 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:52:57 INFO - 'gecko_profile': False, 03:52:57 INFO - 'gecko_profile_interval': 0, 03:52:57 INFO - 'installer_path': 'installer.exe', 03:52:57 INFO - 'log_level': 'info', 03:52:57 INFO - 'log_name': 'talos', 03:52:57 INFO - 'log_to_console': True, 03:52:57 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 03:52:57 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 03:52:57 INFO - 'opt_config_files': (), 03:52:57 INFO - 'pip_index': False, 03:52:57 INFO - 'suite': 'dromaeojs-e10s', 03:52:57 INFO - 'system_bits': '32', 03:52:57 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:52:57 INFO - 'title': 'talos-linux64-ix-028', 03:52:57 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:52:57 INFO - 'use_talos_json': True, 03:52:57 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:52:57 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:52:57 INFO - 'work_dir': 'build'} 03:52:57 INFO - [mozharness: 2017-05-31 10:52:57.699248Z] Running clobber step. 03:52:57 INFO - Running pre-action listener: _resource_record_pre_action 03:52:57 INFO - Running main action method: clobber 03:52:57 INFO - rmtree: /builds/slave/test/build 03:52:57 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:52:58 INFO - Running post-action listener: _resource_record_post_action 03:52:58 INFO - [mozharness: 2017-05-31 10:52:58.727585Z] Finished clobber step (success) 03:52:58 INFO - [mozharness: 2017-05-31 10:52:58.727689Z] Running read-buildbot-config step. 03:52:58 INFO - Running pre-action listener: _resource_record_pre_action 03:52:58 INFO - Running main action method: read_buildbot_config 03:52:58 INFO - Using buildbot properties: 03:52:58 INFO - { 03:52:58 INFO - "project": "", 03:52:58 INFO - "product": "firefox", 03:52:58 INFO - "who": "nobody@mozilla.org", 03:52:58 INFO - "installer_path": "public/build/target.tar.bz2", 03:52:58 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 03:52:58 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 03:52:58 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-e10s", 03:52:58 INFO - "stage_platform": "linux64", 03:52:58 INFO - "basedir": "/builds/slave/test", 03:52:58 INFO - "buildnumber": 646, 03:52:58 INFO - "platform": "ubuntu64_hw", 03:52:58 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 03:52:58 INFO - "slavebuilddir": "test", 03:52:58 INFO - "taskId": "YxKCK2ZgQHmUuIzVVS4m-Q", 03:52:58 INFO - "branch": "mozilla-central", 03:52:58 INFO - "script_repo_revision": "production", 03:52:58 INFO - "revision": "7b8937970f9ca85db88cb2496f2112175fd847c8", 03:52:58 INFO - "slavename": "talos-linux64-ix-028", 03:52:58 INFO - "repo_path": "mozilla-central" 03:52:58 INFO - } 03:52:58 INFO - Finding installer, test and symbols from parent task. 03:52:58 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/YxKCK2ZgQHmUuIzVVS4m-Q'}, attempt #1 03:52:59 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/YxKCK2ZgQHmUuIzVVS4m-Q'}, attempt #1 03:52:59 INFO - Task dependencies: fvuJYUJtQ3i7Te9JmSkDtQ 03:52:59 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/fvuJYUJtQ3i7Te9JmSkDtQ'}, attempt #1 03:53:00 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/fvuJYUJtQ3i7Te9JmSkDtQ/artifacts/public/build/target.tar.bz2 03:53:00 INFO - Set test_url: https://queue.taskcluster.net/v1/task/fvuJYUJtQ3i7Te9JmSkDtQ/artifacts/public/build/test_packages.json 03:53:00 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/fvuJYUJtQ3i7Te9JmSkDtQ/artifacts/public/build/target.crashreporter-symbols.zip 03:53:00 INFO - Running post-action listener: _resource_record_post_action 03:53:00 INFO - [mozharness: 2017-05-31 10:53:00.124651Z] Finished read-buildbot-config step (success) 03:53:00 INFO - [mozharness: 2017-05-31 10:53:00.124873Z] Running download-and-extract step. 03:53:00 INFO - Running pre-action listener: _resource_record_pre_action 03:53:00 INFO - Running main action method: download_and_extract 03:53:00 INFO - mkdir: /builds/slave/test/build/tests 03:53:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:53:00 INFO - trying https://queue.taskcluster.net/v1/task/fvuJYUJtQ3i7Te9JmSkDtQ/artifacts/public/build/target.test_packages.json 03:53:00 INFO - Downloading https://queue.taskcluster.net/v1/task/fvuJYUJtQ3i7Te9JmSkDtQ/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 03:53:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/fvuJYUJtQ3i7Te9JmSkDtQ/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 03:53:00 INFO - Downloaded 986 bytes. 03:53:00 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 03:53:00 INFO - Using the following test package requirements: 03:53:00 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 03:53:00 INFO - u'common': [u'target.common.tests.zip'], 03:53:00 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 03:53:00 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 03:53:00 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 03:53:00 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 03:53:00 INFO - u'mozbase': [u'target.common.tests.zip'], 03:53:00 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 03:53:00 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 03:53:00 INFO - u'web-platform': [u'target.common.tests.zip', 03:53:00 INFO - u'target.web-platform.tests.zip'], 03:53:00 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 03:53:00 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 03:53:00 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/fvuJYUJtQ3i7Te9JmSkDtQ/artifacts/public/build/target.common.tests.zip 03:53:00 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/fvuJYUJtQ3i7Te9JmSkDtQ/artifacts/public/build/target.common.tests.zip'}, attempt #1 03:53:00 INFO - Fetch https://queue.taskcluster.net/v1/task/fvuJYUJtQ3i7Te9JmSkDtQ/artifacts/public/build/target.common.tests.zip into memory 03:53:01 INFO - Content-Length response header: 65716246 03:53:01 INFO - Bytes received: 65716246 03:53:12 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 03:53:12 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/fvuJYUJtQ3i7Te9JmSkDtQ/artifacts/public/build/target.common.tests.zip 03:53:12 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/fvuJYUJtQ3i7Te9JmSkDtQ/artifacts/public/build/target.common.tests.zip'}, attempt #1 03:53:12 INFO - Fetch https://queue.taskcluster.net/v1/task/fvuJYUJtQ3i7Te9JmSkDtQ/artifacts/public/build/target.common.tests.zip into memory 03:53:13 INFO - Content-Length response header: 65716246 03:53:13 INFO - Bytes received: 65716246 03:53:25 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/fvuJYUJtQ3i7Te9JmSkDtQ/artifacts/public/build/target.talos.tests.zip 03:53:25 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/fvuJYUJtQ3i7Te9JmSkDtQ/artifacts/public/build/target.talos.tests.zip'}, attempt #1 03:53:25 INFO - Fetch https://queue.taskcluster.net/v1/task/fvuJYUJtQ3i7Te9JmSkDtQ/artifacts/public/build/target.talos.tests.zip into memory 03:53:26 INFO - Content-Length response header: 14447425 03:53:26 INFO - Bytes received: 14447425 03:53: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')]} 03:53:27 INFO - trying https://queue.taskcluster.net/v1/task/fvuJYUJtQ3i7Te9JmSkDtQ/artifacts/public/build/target.tar.bz2 03:53:27 INFO - Downloading https://queue.taskcluster.net/v1/task/fvuJYUJtQ3i7Te9JmSkDtQ/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 03:53:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/fvuJYUJtQ3i7Te9JmSkDtQ/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 03:53:28 INFO - Downloaded 59697898 bytes. 03:53:28 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/fvuJYUJtQ3i7Te9JmSkDtQ/artifacts/public/build/target.tar.bz2 03:53:28 INFO - mkdir: /builds/slave/test/properties 03:53:28 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:53:28 INFO - Writing to file /builds/slave/test/properties/build_url 03:53:28 INFO - Contents: 03:53:28 INFO - build_url:https://queue.taskcluster.net/v1/task/fvuJYUJtQ3i7Te9JmSkDtQ/artifacts/public/build/target.tar.bz2 03:53:28 INFO - Running post-action listener: _resource_record_post_action 03:53:28 INFO - Running post-action listener: set_extra_try_arguments 03:53:28 INFO - [mozharness: 2017-05-31 10:53:28.189024Z] Finished download-and-extract step (success) 03:53:28 INFO - [mozharness: 2017-05-31 10:53:28.189121Z] Running populate-webroot step. 03:53:28 INFO - Running pre-action listener: _resource_record_pre_action 03:53:28 INFO - Running main action method: populate_webroot 03:53:28 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 03:53:28 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 03:53:28 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 03:53:28 INFO - '--tppagecycles', 03:53:28 INFO - '7'], 03:53:28 INFO - 'tests': ['tsvgm']}}, 03:53:28 INFO - 'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 03:53:28 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 03:53:28 INFO - 'tests': ['dromaeo_css', 'kraken']}, 03:53:28 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 03:53:28 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 03:53:28 INFO - 'talos_options': ['--disable-e10s'], 03:53:28 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:53:28 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 03:53:28 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:53:28 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 03:53:28 INFO - 'talos_options': ['--disable-e10s'], 03:53:28 INFO - 'tests': ['damp', 'tps']}, 03:53:28 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 03:53:28 INFO - 'tests': ['damp', 'tps']}, 03:53:28 INFO - 'g3': {'talos_options': ['--disable-e10s'], 03:53:28 INFO - 'tests': ['dromaeo_dom']}, 03:53:28 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:53:28 INFO - 'g4': {'talos_options': ['--disable-e10s'], 03:53:28 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 03:53:28 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 03:53:28 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 03:53:28 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 03:53:28 INFO - 'other': {'talos_options': ['--disable-e10s'], 03:53:28 INFO - 'tests': ['a11yr', 03:53:28 INFO - 'ts_paint', 03:53:28 INFO - 'tpaint', 03:53:28 INFO - 'sessionrestore', 03:53:28 INFO - 'sessionrestore_no_auto_restore', 03:53:28 INFO - 'tabpaint']}, 03:53:28 INFO - 'other-e10s': {'tests': ['a11yr', 03:53:28 INFO - 'ts_paint', 03:53:28 INFO - 'tpaint', 03:53:28 INFO - 'sessionrestore', 03:53:28 INFO - 'sessionrestore_no_auto_restore', 03:53:28 INFO - 'tabpaint']}, 03:53:28 INFO - 'other-e10s_l64': {'tests': ['a11yr', 03:53:28 INFO - 'ts_paint', 03:53:28 INFO - 'tpaint', 03:53:28 INFO - 'sessionrestore', 03:53:28 INFO - 'sessionrestore_no_auto_restore', 03:53:28 INFO - 'tabpaint']}, 03:53:28 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 03:53:28 INFO - 'ts_paint', 03:53:28 INFO - 'tpaint', 03:53:28 INFO - 'sessionrestore', 03:53:28 INFO - 'sessionrestore_no_auto_restore', 03:53:28 INFO - 'tabpaint']}, 03:53:28 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 03:53:28 INFO - 'tests': ['a11yr', 03:53:28 INFO - 'ts_paint', 03:53:28 INFO - 'tpaint', 03:53:28 INFO - 'sessionrestore', 03:53:28 INFO - 'sessionrestore_no_auto_restore', 03:53:28 INFO - 'tabpaint']}, 03:53:28 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 03:53:28 INFO - 'tests': ['a11yr', 03:53:28 INFO - 'ts_paint', 03:53:28 INFO - 'tpaint', 03:53:28 INFO - 'sessionrestore', 03:53:28 INFO - 'sessionrestore_no_auto_restore', 03:53:28 INFO - 'tabpaint']}, 03:53:28 INFO - 'perf-reftest': {'tests': ['bloom_basic', 'bloom_basic_ref']}, 03:53:28 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic', 03:53:28 INFO - 'bloom_basic_ref']}, 03:53:28 INFO - 'quantum-pageload-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set.zip', 03:53:28 INFO - 'talos_options': ['--mitmproxy', 03:53:28 INFO - 'mitmproxy-recording-1.mp', 03:53:28 INFO - '--firstNonBlankPaint'], 03:53:28 INFO - 'tests': ['Quantum_1']}, 03:53:28 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 03:53:28 INFO - 'tests': ['tsvgx', 03:53:28 INFO - 'tsvgr_opacity', 03:53:28 INFO - 'tart', 03:53:28 INFO - 'tscrollx', 03:53:28 INFO - 'cart', 03:53:28 INFO - 'tsvg_static']}, 03:53:28 INFO - 'svgr-e10s': {'tests': ['tsvgx', 03:53:28 INFO - 'tsvgr_opacity', 03:53:28 INFO - 'tart', 03:53:28 INFO - 'tscrollx', 03:53:28 INFO - 'cart', 03:53:28 INFO - 'tsvg_static']}, 03:53:28 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 03:53:28 INFO - 'talos_options': ['--disable-e10s'], 03:53:28 INFO - 'tests': ['tp5o']}, 03:53:28 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 03:53:28 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 03:53:28 INFO - 'talos_options': ['--disable-e10s', 03:53:28 INFO - '--xperf_path', 03:53:28 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:53:28 INFO - 'tests': ['tp5n']}, 03:53:28 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 03:53:28 INFO - 'talos_options': ['--xperf_path', 03:53:28 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:53:28 INFO - 'tests': ['tp5n']}}, 03:53:28 INFO - 'talos.zip': {'path': '', 03:53:28 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 03:53:28 INFO - Running post-action listener: _resource_record_post_action 03:53:28 INFO - [mozharness: 2017-05-31 10:53:28.203484Z] Finished populate-webroot step (success) 03:53:28 INFO - [mozharness: 2017-05-31 10:53:28.203580Z] Running create-virtualenv step. 03:53:28 INFO - Running pre-action listener: _resource_record_pre_action 03:53:28 INFO - Running main action method: create_virtualenv 03:53:28 INFO - Creating virtualenv /builds/slave/test/build/venv 03:53:28 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 03:53:28 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 03:53:28 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:53:28 INFO - Using real prefix '/usr' 03:53:28 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:53:28 INFO - Installing distribute.............................................................................................................................................................................................done. 03:53:30 INFO - Installing pip.................done. 03:53:30 INFO - Return code: 0 03:53:30 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 03:53:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 03:53:30 INFO - Reading from file tmpfile_stdout 03:53:30 INFO - Output received: 03:53:30 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) 03:53:30 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:53:30 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')]} 03:53:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:53:30 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')]} 03:53:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:53:30 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 0x14cc3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16a6a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x184add0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1847840>, '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 0x1848740>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1848bd0>, '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': '836cfdc75598d54cb747368e000001a9-1496225697.633254-970548499', '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 03:53:30 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 03:53:30 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 03:53:30 INFO - Using env: {'DISPLAY': ':0', 03:53:30 INFO - 'HOME': '/home/cltbld', 03:53:30 INFO - 'LANG': 'en_US.UTF-8', 03:53:30 INFO - 'LANGUAGE': 'en_US:en', 03:53:30 INFO - 'LOGNAME': 'cltbld', 03:53:30 INFO - 'MAIL': '/var/mail/cltbld', 03:53:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:53:30 INFO - 'MOZ_NO_REMOTE': '1', 03:53:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:53:30 INFO - 'NO_EM_RESTART': '1', 03:53:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:53:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:53:30 INFO - 'PWD': '/builds/slave/test', 03:53:30 INFO - 'SHELL': '/bin/bash', 03:53:30 INFO - 'SHLVL': '1', 03:53:30 INFO - 'TERM': 'linux', 03:53:30 INFO - 'TMOUT': '86400', 03:53:30 INFO - 'USER': 'cltbld', 03:53:30 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1496225697.633254-970548499', 03:53:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:53:30 INFO - '_': '/tools/buildbot/bin/python'} 03:53:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:53:31 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 03:53:31 INFO - Cleaning up... 03:53:31 INFO - Return code: 0 03:53:31 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 03:53:31 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')]} 03:53:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:53:31 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')]} 03:53:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:53:31 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 0x14cc3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16a6a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x184add0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1847840>, '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 0x1848740>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1848bd0>, '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': '836cfdc75598d54cb747368e000001a9-1496225697.633254-970548499', '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 03:53:31 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 03:53:31 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 03:53:31 INFO - Using env: {'DISPLAY': ':0', 03:53:31 INFO - 'HOME': '/home/cltbld', 03:53:31 INFO - 'LANG': 'en_US.UTF-8', 03:53:31 INFO - 'LANGUAGE': 'en_US:en', 03:53:31 INFO - 'LOGNAME': 'cltbld', 03:53:31 INFO - 'MAIL': '/var/mail/cltbld', 03:53:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:53:31 INFO - 'MOZ_NO_REMOTE': '1', 03:53:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:53:31 INFO - 'NO_EM_RESTART': '1', 03:53:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:53:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:53:31 INFO - 'PWD': '/builds/slave/test', 03:53:31 INFO - 'SHELL': '/bin/bash', 03:53:31 INFO - 'SHLVL': '1', 03:53:31 INFO - 'TERM': 'linux', 03:53:31 INFO - 'TMOUT': '86400', 03:53:31 INFO - 'USER': 'cltbld', 03:53:31 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1496225697.633254-970548499', 03:53:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:53:31 INFO - '_': '/tools/buildbot/bin/python'} 03:53:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:53:31 INFO - Downloading/unpacking psutil>=3.1.1 03:53:31 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 03:53:31 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 03:53:31 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 03:53:31 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 03:53:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:53:32 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:53:32 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:53:32 INFO - Installing collected packages: psutil 03:53:32 INFO - Running setup.py install for psutil 03:53:32 INFO - building 'psutil._psutil_linux' extension 03:53:32 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 03:53:32 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 03:53:32 INFO - building 'psutil._psutil_posix' extension 03:53:32 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 03:53:33 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 03:53:33 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:53:33 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:53:33 INFO - Successfully installed psutil 03:53:33 INFO - Cleaning up... 03:53:33 INFO - Return code: 0 03:53:33 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 03:53:33 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')]} 03:53:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:53:33 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')]} 03:53:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:53:33 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 0x14cc3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16a6a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x184add0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1847840>, '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 0x1848740>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1848bd0>, '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': '836cfdc75598d54cb747368e000001a9-1496225697.633254-970548499', '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 03:53:33 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 03:53:33 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 03:53:33 INFO - Using env: {'DISPLAY': ':0', 03:53:33 INFO - 'HOME': '/home/cltbld', 03:53:33 INFO - 'LANG': 'en_US.UTF-8', 03:53:33 INFO - 'LANGUAGE': 'en_US:en', 03:53:33 INFO - 'LOGNAME': 'cltbld', 03:53:33 INFO - 'MAIL': '/var/mail/cltbld', 03:53:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:53:33 INFO - 'MOZ_NO_REMOTE': '1', 03:53:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:53:33 INFO - 'NO_EM_RESTART': '1', 03:53:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:53:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:53:33 INFO - 'PWD': '/builds/slave/test', 03:53:33 INFO - 'SHELL': '/bin/bash', 03:53:33 INFO - 'SHLVL': '1', 03:53:33 INFO - 'TERM': 'linux', 03:53:33 INFO - 'TMOUT': '86400', 03:53:33 INFO - 'USER': 'cltbld', 03:53:33 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1496225697.633254-970548499', 03:53:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:53:33 INFO - '_': '/tools/buildbot/bin/python'} 03:53:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:53:33 INFO - Downloading/unpacking mozsystemmonitor==0.3 03:53:33 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 03:53:33 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 03:53:33 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 03:53:33 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 03:53:34 INFO - Downloading mozsystemmonitor-0.3.tar.gz 03:53:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:53:34 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 03:53:34 INFO - Installing collected packages: mozsystemmonitor 03:53:34 INFO - Running setup.py install for mozsystemmonitor 03:53:34 INFO - Successfully installed mozsystemmonitor 03:53:34 INFO - Cleaning up... 03:53:34 INFO - Return code: 0 03:53:34 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 03:53:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:53:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:53:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:53:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:53:34 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x14cc3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16a6a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x184add0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1847840>, '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 0x1848740>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1848bd0>, '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': '836cfdc75598d54cb747368e000001a9-1496225697.633254-970548499', '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 03:53:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 03:53:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 03:53:34 INFO - Using env: {'DISPLAY': ':0', 03:53:34 INFO - 'HOME': '/home/cltbld', 03:53:34 INFO - 'LANG': 'en_US.UTF-8', 03:53:34 INFO - 'LANGUAGE': 'en_US:en', 03:53:34 INFO - 'LOGNAME': 'cltbld', 03:53:34 INFO - 'MAIL': '/var/mail/cltbld', 03:53:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:53:34 INFO - 'MOZ_NO_REMOTE': '1', 03:53:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:53:34 INFO - 'NO_EM_RESTART': '1', 03:53:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:53:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:53:34 INFO - 'PWD': '/builds/slave/test', 03:53:34 INFO - 'SHELL': '/bin/bash', 03:53:34 INFO - 'SHLVL': '1', 03:53:34 INFO - 'TERM': 'linux', 03:53:34 INFO - 'TMOUT': '86400', 03:53:34 INFO - 'USER': 'cltbld', 03:53:34 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1496225697.633254-970548499', 03:53:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:53:34 INFO - '_': '/tools/buildbot/bin/python'} 03:53:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:53:34 INFO - Downloading/unpacking jsonschema==2.5.1 03:53:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:53:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:53:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:53:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:53:35 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:53:35 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 03:53:35 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 03:53:35 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 03:53:35 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 03:53:35 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 03:53:36 INFO - Downloading functools32-3.2.3-2.tar.gz 03:53:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:53:36 INFO - warning: no files found matching '*.txt' 03:53:36 INFO - no previously-included directories found matching 'build' 03:53:36 INFO - no previously-included directories found matching 'dist' 03:53:36 INFO - no previously-included directories found matching '.git*' 03:53:36 INFO - Installing collected packages: jsonschema, functools32 03:53:36 INFO - Running setup.py install for functools32 03:53:36 INFO - warning: no files found matching '*.txt' 03:53:36 INFO - no previously-included directories found matching 'build' 03:53:36 INFO - no previously-included directories found matching 'dist' 03:53:36 INFO - no previously-included directories found matching '.git*' 03:53:36 INFO - Successfully installed jsonschema functools32 03:53:36 INFO - Cleaning up... 03:53:36 INFO - Return code: 0 03:53:36 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 03:53:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:53:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:53:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:53:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:53:36 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x14cc3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16a6a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x184add0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1847840>, '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 0x1848740>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1848bd0>, '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': '836cfdc75598d54cb747368e000001a9-1496225697.633254-970548499', '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 03:53:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 03:53:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 03:53:36 INFO - Using env: {'DISPLAY': ':0', 03:53:36 INFO - 'HOME': '/home/cltbld', 03:53:36 INFO - 'LANG': 'en_US.UTF-8', 03:53:36 INFO - 'LANGUAGE': 'en_US:en', 03:53:36 INFO - 'LOGNAME': 'cltbld', 03:53:36 INFO - 'MAIL': '/var/mail/cltbld', 03:53:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:53:36 INFO - 'MOZ_NO_REMOTE': '1', 03:53:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:53:36 INFO - 'NO_EM_RESTART': '1', 03:53:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:53:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:53:36 INFO - 'PWD': '/builds/slave/test', 03:53:36 INFO - 'SHELL': '/bin/bash', 03:53:36 INFO - 'SHLVL': '1', 03:53:36 INFO - 'TERM': 'linux', 03:53:36 INFO - 'TMOUT': '86400', 03:53:36 INFO - 'USER': 'cltbld', 03:53:36 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1496225697.633254-970548499', 03:53:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:53:36 INFO - '_': '/tools/buildbot/bin/python'} 03:53:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:53:36 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 03:53:36 INFO - Cleaning up... 03:53:36 INFO - Return code: 0 03:53:36 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:53:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:53:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:53:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:53:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:53:36 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x14cc3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16a6a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x184add0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1847840>, '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 0x1848740>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1848bd0>, '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': '836cfdc75598d54cb747368e000001a9-1496225697.633254-970548499', '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 03:53:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 03:53:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 03:53:36 INFO - Using env: {'DISPLAY': ':0', 03:53:36 INFO - 'HOME': '/home/cltbld', 03:53:36 INFO - 'LANG': 'en_US.UTF-8', 03:53:36 INFO - 'LANGUAGE': 'en_US:en', 03:53:36 INFO - 'LOGNAME': 'cltbld', 03:53:36 INFO - 'MAIL': '/var/mail/cltbld', 03:53:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:53:36 INFO - 'MOZ_NO_REMOTE': '1', 03:53:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:53:36 INFO - 'NO_EM_RESTART': '1', 03:53:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:53:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:53:36 INFO - 'PWD': '/builds/slave/test', 03:53:36 INFO - 'SHELL': '/bin/bash', 03:53:36 INFO - 'SHLVL': '1', 03:53:36 INFO - 'TERM': 'linux', 03:53:36 INFO - 'TMOUT': '86400', 03:53:36 INFO - 'USER': 'cltbld', 03:53:36 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1496225697.633254-970548499', 03:53:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:53:36 INFO - '_': '/tools/buildbot/bin/python'} 03:53:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:53:36 INFO - Downloading/unpacking blobuploader==1.2.4 03:53:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:53:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:53:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:53:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:53:37 INFO - Downloading blobuploader-1.2.4.tar.gz 03:53:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:53:37 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:53:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:53:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:53:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:53:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:53:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:53:38 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:53:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:53:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:53:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:53:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:53:38 INFO - Downloading docopt-0.6.1.tar.gz 03:53:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:53:38 INFO - Installing collected packages: blobuploader, requests, docopt 03:53:38 INFO - Running setup.py install for blobuploader 03:53:38 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:53:38 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:53:38 INFO - Running setup.py install for requests 03:53:38 INFO - Running setup.py install for docopt 03:53:39 INFO - Successfully installed blobuploader requests docopt 03:53:39 INFO - Cleaning up... 03:53:39 INFO - Return code: 0 03:53:39 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:53:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:53:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:53:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:53:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:53:39 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 0x14cc3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16a6a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x184add0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1847840>, '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 0x1848740>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1848bd0>, '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': '836cfdc75598d54cb747368e000001a9-1496225697.633254-970548499', '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 03:53:39 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 03:53:39 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 03:53:39 INFO - Using env: {'DISPLAY': ':0', 03:53:39 INFO - 'HOME': '/home/cltbld', 03:53:39 INFO - 'LANG': 'en_US.UTF-8', 03:53:39 INFO - 'LANGUAGE': 'en_US:en', 03:53:39 INFO - 'LOGNAME': 'cltbld', 03:53:39 INFO - 'MAIL': '/var/mail/cltbld', 03:53:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:53:39 INFO - 'MOZ_NO_REMOTE': '1', 03:53:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:53:39 INFO - 'NO_EM_RESTART': '1', 03:53:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:53:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:53:39 INFO - 'PWD': '/builds/slave/test', 03:53:39 INFO - 'SHELL': '/bin/bash', 03:53:39 INFO - 'SHLVL': '1', 03:53:39 INFO - 'TERM': 'linux', 03:53:39 INFO - 'TMOUT': '86400', 03:53:39 INFO - 'USER': 'cltbld', 03:53:39 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1496225697.633254-970548499', 03:53:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:53:39 INFO - '_': '/tools/buildbot/bin/python'} 03:53:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:53:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:53:39 INFO - Running setup.py (path:/tmp/pip-T3JJjM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:53:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:53:39 INFO - Running setup.py (path:/tmp/pip-GaOxf7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:53:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:53:39 INFO - Running setup.py (path:/tmp/pip-cCsmRR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:53:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:53:39 INFO - Running setup.py (path:/tmp/pip-h9Q5Gk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:53:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:53:39 INFO - Running setup.py (path:/tmp/pip-vGsbg0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:53:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:53:39 INFO - Running setup.py (path:/tmp/pip-1aJqCR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:53:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:53:39 INFO - Running setup.py (path:/tmp/pip-lFb0NB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:53:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:53:39 INFO - Running setup.py (path:/tmp/pip-To0ASq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:53:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:53:39 INFO - Running setup.py (path:/tmp/pip-NXs3yE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:53:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:53:39 INFO - Running setup.py (path:/tmp/pip-wHFNx7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:53:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:53:40 INFO - Running setup.py (path:/tmp/pip-6332bm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:53:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:53:40 INFO - Running setup.py (path:/tmp/pip-FPg1Zg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:53:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:53:40 INFO - Running setup.py (path:/tmp/pip-ufIOpb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:53:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:53:40 INFO - Running setup.py (path:/tmp/pip-xcJLDk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:53:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:53:40 INFO - Running setup.py (path:/tmp/pip-YBGsz9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:53:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:53:40 INFO - Running setup.py (path:/tmp/pip-kYJuNg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:53:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:53:40 INFO - Running setup.py (path:/tmp/pip-o78mK8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:53:40 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:53:40 INFO - Running setup.py install for manifestparser 03:53:40 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:53:40 INFO - Running setup.py install for mozcrash 03:53:40 INFO - Running setup.py install for mozdebug 03:53:40 INFO - Running setup.py install for mozdevice 03:53:40 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:53:40 INFO - Running setup.py install for mozfile 03:53:41 INFO - Running setup.py install for mozhttpd 03:53:41 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:53:41 INFO - Running setup.py install for mozinfo 03:53:41 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:53:41 INFO - Running setup.py install for mozInstall 03:53:41 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:53:41 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:53:41 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:53:41 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:53:41 INFO - Running setup.py install for mozleak 03:53:41 INFO - Running setup.py install for mozlog 03:53:41 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:53:41 INFO - Running setup.py install for moznetwork 03:53:41 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:53:41 INFO - Running setup.py install for mozprocess 03:53:41 INFO - Running setup.py install for mozprofile 03:53:41 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:53:41 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:53:41 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:53:41 INFO - Running setup.py install for mozrunner 03:53:41 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:53:41 INFO - Running setup.py install for mozscreenshot 03:53:42 INFO - Running setup.py install for moztest 03:53:42 INFO - Running setup.py install for mozversion 03:53:42 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:53:42 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:53:42 INFO - Cleaning up... 03:53:42 INFO - Return code: 0 03:53:42 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:53:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:53:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:53:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:53:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:53:42 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 0x14cc3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16a6a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x184add0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1847840>, '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 0x1848740>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1848bd0>, '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': '836cfdc75598d54cb747368e000001a9-1496225697.633254-970548499', '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 03:53:42 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 03:53:42 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 03:53:42 INFO - Using env: {'DISPLAY': ':0', 03:53:42 INFO - 'HOME': '/home/cltbld', 03:53:42 INFO - 'LANG': 'en_US.UTF-8', 03:53:42 INFO - 'LANGUAGE': 'en_US:en', 03:53:42 INFO - 'LOGNAME': 'cltbld', 03:53:42 INFO - 'MAIL': '/var/mail/cltbld', 03:53:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:53:42 INFO - 'MOZ_NO_REMOTE': '1', 03:53:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:53:42 INFO - 'NO_EM_RESTART': '1', 03:53:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:53:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:53:42 INFO - 'PWD': '/builds/slave/test', 03:53:42 INFO - 'SHELL': '/bin/bash', 03:53:42 INFO - 'SHLVL': '1', 03:53:42 INFO - 'TERM': 'linux', 03:53:42 INFO - 'TMOUT': '86400', 03:53:42 INFO - 'USER': 'cltbld', 03:53:42 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1496225697.633254-970548499', 03:53:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:53:42 INFO - '_': '/tools/buildbot/bin/python'} 03:53:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:53:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:53:42 INFO - Running setup.py (path:/tmp/pip-AfFJpo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:53:42 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)) 03:53:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:53:42 INFO - Running setup.py (path:/tmp/pip-XvjTfn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:53:42 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)) 03:53:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:53:42 INFO - Running setup.py (path:/tmp/pip-9yIPOZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:53:42 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)) 03:53:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:53:42 INFO - Running setup.py (path:/tmp/pip-9pogQv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:53:42 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)) 03:53:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:53:42 INFO - Running setup.py (path:/tmp/pip-YpGUAF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:53:42 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)) 03:53:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:53:42 INFO - Running setup.py (path:/tmp/pip-mIgWZK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:53:42 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)) 03:53:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:53:42 INFO - Running setup.py (path:/tmp/pip-veh2BJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:53:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 03:53:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:53:43 INFO - Running setup.py (path:/tmp/pip-13B68y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:53:43 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)) 03:53:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:53:43 INFO - Running setup.py (path:/tmp/pip-pYcVEQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:53:43 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)) 03:53:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:53:43 INFO - Running setup.py (path:/tmp/pip-kOiNps-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:53:43 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)) 03:53:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:53:43 INFO - Running setup.py (path:/tmp/pip-CJMU35-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:53:43 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)) 03:53:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:53:43 INFO - Running setup.py (path:/tmp/pip-PxxYpX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:53:43 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)) 03:53:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:53:43 INFO - Running setup.py (path:/tmp/pip-DfOrKu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:53:43 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)) 03:53:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:53:43 INFO - Running setup.py (path:/tmp/pip-mSTant-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:53:43 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)) 03:53:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:53:43 INFO - Running setup.py (path:/tmp/pip-iak4d8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:53:43 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)) 03:53:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:53:43 INFO - Running setup.py (path:/tmp/pip-qR2qck-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:53:43 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)) 03:53:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:53:43 INFO - Running setup.py (path:/tmp/pip-ep_YDI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:53:43 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)) 03:53:43 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)) 03:53:43 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)) 03:53:43 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)) 03:53:43 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)) 03:53:43 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)) 03:53:43 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:53:43 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 03:53:43 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 03:53:43 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 03:53:43 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 03:53:44 INFO - Downloading blessings-1.6.tar.gz 03:53:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:53:44 INFO - Installing collected packages: blessings 03:53:44 INFO - Running setup.py install for blessings 03:53:45 INFO - Successfully installed blessings 03:53:45 INFO - Cleaning up... 03:53:45 INFO - Return code: 0 03:53:45 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:53:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:53:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:53:45 INFO - Reading from file tmpfile_stdout 03:53:45 INFO - Current package versions: 03:53:45 INFO - argparse == 1.2.1 03:53:45 INFO - blessings == 1.6 03:53:45 INFO - blobuploader == 1.2.4 03:53:45 INFO - docopt == 0.6.1 03:53:45 INFO - functools32 == 3.2.3-2 03:53:45 INFO - jsonschema == 2.5.1 03:53:45 INFO - manifestparser == 1.1 03:53:45 INFO - mozInstall == 1.12 03:53:45 INFO - mozcrash == 1.0 03:53:45 INFO - mozdebug == 0.1 03:53:45 INFO - mozdevice == 0.51 03:53:45 INFO - mozfile == 1.2 03:53:45 INFO - mozhttpd == 0.7 03:53:45 INFO - mozinfo == 0.9 03:53:45 INFO - mozleak == 0.1 03:53:45 INFO - mozlog == 3.4 03:53:45 INFO - moznetwork == 0.27 03:53:45 INFO - mozprocess == 0.25 03:53:45 INFO - mozprofile == 0.28 03:53:45 INFO - mozrunner == 6.13 03:53:45 INFO - mozscreenshot == 0.1 03:53:45 INFO - mozsystemmonitor == 0.3 03:53:45 INFO - moztest == 0.8 03:53:45 INFO - mozversion == 1.4 03:53:45 INFO - psutil == 3.1.1 03:53:45 INFO - requests == 1.2.3 03:53:45 INFO - wsgiref == 0.1.2 03:53:45 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:53:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:53:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:53:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:53:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:53:45 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 0x14cc3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16a6a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x184add0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1847840>, '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 0x1848740>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1848bd0>, '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': '836cfdc75598d54cb747368e000001a9-1496225697.633254-970548499', '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 03:53:45 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 03:53:45 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 03:53:45 INFO - Using env: {'DISPLAY': ':0', 03:53:45 INFO - 'HOME': '/home/cltbld', 03:53:45 INFO - 'LANG': 'en_US.UTF-8', 03:53:45 INFO - 'LANGUAGE': 'en_US:en', 03:53:45 INFO - 'LOGNAME': 'cltbld', 03:53:45 INFO - 'MAIL': '/var/mail/cltbld', 03:53:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:53:45 INFO - 'MOZ_NO_REMOTE': '1', 03:53:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:53:45 INFO - 'NO_EM_RESTART': '1', 03:53:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:53:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:53:45 INFO - 'PWD': '/builds/slave/test', 03:53:45 INFO - 'SHELL': '/bin/bash', 03:53:45 INFO - 'SHLVL': '1', 03:53:45 INFO - 'TERM': 'linux', 03:53:45 INFO - 'TMOUT': '86400', 03:53:45 INFO - 'USER': 'cltbld', 03:53:45 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1496225697.633254-970548499', 03:53:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:53:45 INFO - '_': '/tools/buildbot/bin/python'} 03:53:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:53:45 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)) 03:53:45 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)) 03:53:45 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)) 03:53:45 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)) 03:53:45 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)) 03:53:45 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)) 03:53:45 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)) 03:53:45 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)) 03:53:45 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)) 03:53:45 INFO - Downloading/unpacking marionette-driver>=1.4.0 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 03:53:45 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 03:53:45 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 03:53:45 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 03:53:45 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 03:53:46 INFO - Downloading marionette_driver-1.4.0.tar.gz 03:53:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/marionette-driver/setup.py) egg_info for package marionette-driver 03:53:46 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)) 03:53:46 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)) 03:53:46 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)) 03:53:46 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)) 03:53:46 INFO - Installing collected packages: marionette-driver 03:53:46 INFO - Running setup.py install for marionette-driver 03:53:46 INFO - Successfully installed marionette-driver 03:53:46 INFO - Cleaning up... 03:53:46 INFO - Return code: 0 03:53:46 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:53:46 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')]} 03:53:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:53:46 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')]} 03:53:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:53:46 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 0x14cc3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16a6a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x184add0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1847840>, '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 0x1848740>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1848bd0>, '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': '836cfdc75598d54cb747368e000001a9-1496225697.633254-970548499', '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 03:53:46 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 03:53:46 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 03:53:46 INFO - Using env: {'DISPLAY': ':0', 03:53:46 INFO - 'HOME': '/home/cltbld', 03:53:46 INFO - 'LANG': 'en_US.UTF-8', 03:53:46 INFO - 'LANGUAGE': 'en_US:en', 03:53:46 INFO - 'LOGNAME': 'cltbld', 03:53:46 INFO - 'MAIL': '/var/mail/cltbld', 03:53:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:53:46 INFO - 'MOZ_NO_REMOTE': '1', 03:53:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:53:46 INFO - 'NO_EM_RESTART': '1', 03:53:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:53:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:53:46 INFO - 'PWD': '/builds/slave/test', 03:53:46 INFO - 'SHELL': '/bin/bash', 03:53:46 INFO - 'SHLVL': '1', 03:53:46 INFO - 'TERM': 'linux', 03:53:46 INFO - 'TMOUT': '86400', 03:53:46 INFO - 'USER': 'cltbld', 03:53:46 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1496225697.633254-970548499', 03:53:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:53:46 INFO - '_': '/tools/buildbot/bin/python'} 03:53:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:53:47 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 03:53:47 INFO - Cleaning up... 03:53:47 INFO - Return code: 0 03:53:47 INFO - Running post-action listener: _resource_record_post_action 03:53:47 INFO - Running post-action listener: _start_resource_monitoring 03:53:47 INFO - Starting resource monitoring. 03:53:47 INFO - [mozharness: 2017-05-31 10:53:47.089952Z] Finished create-virtualenv step (success) 03:53:47 INFO - [mozharness: 2017-05-31 10:53:47.090478Z] Running install step. 03:53:47 INFO - Running pre-action listener: _resource_record_pre_action 03:53:47 INFO - Running main action method: install 03:53:47 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:53:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:53:47 INFO - Reading from file tmpfile_stdout 03:53:47 INFO - Detecting whether we're running mozinstall >=1.0... 03:53:47 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:53:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:53:47 INFO - Reading from file tmpfile_stdout 03:53:47 INFO - Output received: 03:53:47 INFO - Usage: mozinstall [options] installer 03:53:47 INFO - Options: 03:53:47 INFO - -h, --help show this help message and exit 03:53:47 INFO - -d DEST, --destination=DEST 03:53:47 INFO - Directory to install application into. [default: 03:53:47 INFO - "/builds/slave/test"] 03:53:47 INFO - --app=APP Application being installed. [default: firefox] 03:53:47 INFO - mkdir: /builds/slave/test/build/application 03:53:47 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'] 03:53:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 03:54:04 INFO - Reading from file tmpfile_stdout 03:54:04 INFO - Output received: 03:54:04 INFO - /builds/slave/test/build/application/firefox/firefox 03:54:04 INFO - Running post-action listener: _resource_record_post_action 03:54:04 INFO - [mozharness: 2017-05-31 10:54:04.207946Z] Finished install step (success) 03:54:04 INFO - [mozharness: 2017-05-31 10:54:04.208225Z] Running setup-mitmproxy step. 03:54:04 INFO - Running pre-action listener: _resource_record_pre_action 03:54:04 INFO - Running main action method: setup_mitmproxy 03:54:04 INFO - Skipping: mitmproxy is not required 03:54:04 INFO - Running post-action listener: _resource_record_post_action 03:54:04 INFO - [mozharness: 2017-05-31 10:54:04.209355Z] Finished setup-mitmproxy step (success) 03:54:04 INFO - [mozharness: 2017-05-31 10:54:04.209578Z] Running run-tests step. 03:54:04 INFO - Running pre-action listener: _resource_record_pre_action 03:54:04 INFO - Running main action method: run_tests 03:54:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:54:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:54:04 INFO - Python 2.7.3 03:54:04 INFO - Return code: 0 03:54:04 INFO - grabbing minidump binary from tooltool 03:54: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')]} 03:54:04 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 0x1847840>, '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 0x1848740>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1848bd0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:54:04 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 03:54:04 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 03:54:04 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 03:54:04 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:54:04 INFO - Return code: 0 03:54:04 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 03:54:04 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:54:04 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:54:04 INFO - ENV: RUST_BACKTRACE is now 1 03:54:04 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 03:54:04 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:54:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/fvuJYUJtQ3i7Te9JmSkDtQ/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-028', '--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 03:54:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/fvuJYUJtQ3i7Te9JmSkDtQ/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-028 --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 03:54:04 INFO - Using env: {'DISPLAY': ':0', 03:54:04 INFO - 'HOME': '/home/cltbld', 03:54:04 INFO - 'LANG': 'en_US.UTF-8', 03:54:04 INFO - 'LANGUAGE': 'en_US:en', 03:54:04 INFO - 'LOGNAME': 'cltbld', 03:54:04 INFO - 'MAIL': '/var/mail/cltbld', 03:54:04 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:54:04 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 03:54:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:54:04 INFO - 'MOZ_NO_REMOTE': '1', 03:54:04 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:54:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:54:04 INFO - 'NO_EM_RESTART': '1', 03:54:04 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:54:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:54:04 INFO - 'PWD': '/builds/slave/test', 03:54:04 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:54:04 INFO - 'RUST_BACKTRACE': '1', 03:54:04 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 03:54:04 INFO - 'SHELL': '/bin/bash', 03:54:04 INFO - 'SHLVL': '1', 03:54:04 INFO - 'TERM': 'linux', 03:54:04 INFO - 'TMOUT': '86400', 03:54:04 INFO - 'USER': 'cltbld', 03:54:04 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1496225697.633254-970548499', 03:54:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:54:04 INFO - '_': '/tools/buildbot/bin/python'} 03:54:04 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/fvuJYUJtQ3i7Te9JmSkDtQ/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-028', '--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 03:54:04 INFO - mozversion application_buildid: 20170531100318 03:54:04 INFO - mozversion application_changeset: 7b8937970f9ca85db88cb2496f2112175fd847c8 03:54:04 INFO - mozversion application_display_name: Nightly 03:54:04 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:54:04 INFO - mozversion application_name: Firefox 03:54:04 INFO - mozversion application_remotingname: firefox 03:54:04 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 03:54:04 INFO - mozversion application_vendor: Mozilla 03:54:04 INFO - mozversion application_version: 55.0a1 03:54:04 INFO - mozversion platform_buildid: 20170531100318 03:54:04 INFO - mozversion platform_changeset: 7b8937970f9ca85db88cb2496f2112175fd847c8 03:54:04 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 03:54:04 INFO - mozversion platform_version: 55.0a1 03:54:04 INFO - using testdate: 1496228044 03:54:04 INFO - actual date: 1496228044 03:54:04 INFO - starting webserver on 'localhost:55238' 03:54:04 INFO - SUITE-START | Running 2 tests 03:54:04 INFO - TEST-START | dromaeo_css 03:54:04 INFO - operating with platform_type : linux_ 03:54:04 INFO - Initialising browser for dromaeo_css test... 03:54:04 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:55238/getInfo.html -profile /tmp/tmpX68H8v/profile 03:54:04 INFO - TEST-INFO | started process 9797 (/builds/slave/test/build/application/firefox/firefox http://localhost:55238/getInfo.html) 03:54:39 INFO - TEST-INFO | 9797: killed by SIGTERM 03:54:39 INFO - Browser initialized. 03:54:39 INFO - Running cycle 1/1 for dromaeo_css test... 03:54:39 INFO - TEST-INFO | started process 10001 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpX68H8v/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:54:51 INFO - PID 10001 | RSS: Main: 182235136 03:54:51 INFO - PID 10001 | 03:57:51 INFO - PID 10001 | Cycle 1(1): loaded http://localhost:55238/tests/dromaeo/cssquery-dojo.html (next: http://localhost:55238/tests/dromaeo/cssquery-ext.html) 03:57:52 INFO - PID 10001 | RSS: Main: 176807936 03:57:52 INFO - PID 10001 | 04:00:54 INFO - PID 10001 | Cycle 1(1): loaded http://localhost:55238/tests/dromaeo/cssquery-ext.html (next: http://localhost:55238/tests/dromaeo/cssquery-jquery.html) 04:00:55 INFO - PID 10001 | RSS: Main: 182386688 04:00:55 INFO - PID 10001 | 04:03:56 INFO - PID 10001 | Cycle 1(1): loaded http://localhost:55238/tests/dromaeo/cssquery-jquery.html (next: http://localhost:55238/tests/dromaeo/cssquery-mootools.html) 04:03:57 INFO - PID 10001 | RSS: Main: 179683328 04:03:57 INFO - PID 10001 | 04:06:59 INFO - PID 10001 | Cycle 1(1): loaded http://localhost:55238/tests/dromaeo/cssquery-mootools.html (next: http://localhost:55238/tests/dromaeo/cssquery-prototype.html) 04:06:59 INFO - PID 10001 | RSS: Main: 185552896 04:06:59 INFO - PID 10001 | 04:10:02 INFO - PID 10001 | Cycle 1(1): loaded http://localhost:55238/tests/dromaeo/cssquery-prototype.html (next: http://localhost:55238/tests/dromaeo/cssquery-yui.html) 04:10:03 INFO - PID 10001 | RSS: Main: 184283136 04:10:03 INFO - PID 10001 | 04:13:04 INFO - PID 10001 | Cycle 1(1): loaded http://localhost:55238/tests/dromaeo/cssquery-yui.html (next: http://localhost:55238/tests/dromaeo/cssquery-dojo.html) 04:13:04 INFO - PID 10001 | RSS: Main: 183803904 04:13:04 INFO - PID 10001 | 04:13:04 INFO - PID 10001 | __start_tp_report 04:13:04 INFO - PID 10001 | _x_x_mozilla_page_load 04:13:04 INFO - PID 10001 | _x_x_mozilla_page_load_details 04:13:04 INFO - PID 10001 | |i|pagename|runs| 04:13:04 INFO - PID 10001 | |0;dojo.html;3384.915377115572;3393.6097348804865;3406.420908445564;3419.726421886249;3422.6064002639705;5875.9118613220835;6026.517878569714;6030.035194368902;6035.849103772408;6039.969800150999;5907;6022.066579680146;6066.908996365047;6080.452759251666;6144.293406258282;4950.615436417375;5142.331496905397;5296.682199068058;5315.362156541201;5334.359876814788;5321.920171197416;5396.676199428027;5404.081306177959;5408.8377348679605;5428.782848686067;5203.765830537635;5216.295800067019;5243.895122097537;5261.76322065508;5322.494363035506;5315.521603055705;5347.812826551052;5352.223927530486;5354.089804733166;5385.299911011543;5298.6555873868465;5303.893922121536;5317.069512835238;5324.54741346986;5365.973170134163;5814.040683287295;5897.52819774417;5969.164316995624;5972.492338151263;5989.9101513477335;6370.681465926731;6483.092367068614;6521.47828173745;6532.281449040602;6534.183227096613;6432.356764323577;6463.838404039937;6472.611643301417;6485.383888530582;6490.545661803676;5880.088586269135;5968.985272503684;5974.910376344358;5980.671063091485;5991.400859914017;6489.253735820346;6598.307177746364;6663.933360666429;6704.631245281556;6728.9570116632;6108.0992441897915;6123.953766440866;6179.104029915637;6396.680165991682;6430.2926678066315;6558.311377305409;6558.376954189344;6558.868822623616;6565.113709649232;6572.244191917895;6203;6434.131392262078;6499.252585952581;6500.447461965786;6509.251436084816;6295.276043254993;6376.266729326094;6447.7743278985945;6449.935500644933;6459.354064593503;4868.634852386085;4875.317455556225;4880.389951256093;4903.901921961541;4919.77860996256;4296.0548679290505;4314.654827613784;4316.848910288188;4317.568243175658;4338.436003319548;5881.000229960917;5958.761649534057;5966.910496342558;5977.193078934288;6002.369751176151;6465.903011454738;6468.256150542654;6469.708863101172;6477.190351206099;6522.673866306761;6058.575899687068;6059.7273122709585;6069.180660610761;6072;6078.513718902565;5330.973345133327;5440.6735595864375;5499.367572729107;5506.201600767866;5542.8337149885565;6590.176227971504;6631.602103873783;6690.59856408617;6702.899456508157;6794.626295553792;6550.934490655032;6563;6567.540272180901;6568.310327415553;6570.77002304917;6734.629595372302;6767.0526126341365;6821.931780682328;6842.486813489108;6846.075779769667;6208.627482350893;6261.843453913689;6321.462675672436;6418.807435776934;6419.871602567829;6602.537822352581;6626.204855417188;6626.370494802986;6627.37039981201;6633.071370008299;6150.692465376803;6216.906746398718;6314.905276420949;6427.903581446189;6431.324710905475;6377.394147555975;6403.487720982217;6426.068220108152;6428.742850285937;6429.260635027032;6359.650219237987;6370.29926708071;6386.744530218925;6387.233531976192;6403.167588213502;6160.876782464416;6240.095186197885;6439.388258115471;6479.643619600967;6490.578112422678;6179.320274769681;6264.154339164154;6265.655388953652;6274.309825919054;6278.340774218641 04:13:04 INFO - PID 10001 | |1;ext.html;697.4524997876665;764.4343186042329;778.4589710151444;1157.9652610421685;1181.4624345922607;38330.61669383305;38967;39042.60957390425;39046.60953390465;39152.412713809244;40101;40521;40561.797191014004;40569.59430405695;40583.391249131215;7155.105611798525;7168;7294.452916031292;7363.631818409058;7369.263073692641;7311.707531698726;7408.3332500074985;7415.258474152595;7424.777256682281;7430.479866409353;7377.188509264003;7392.225865792198;7432.851342973137;7450.664720087582;7455.664495097706;7394;7397.149327827261;7398.70405183792;7411.851762964738;7421.554706717588;7236;7283.089613798275;7287.599182044985;7292.161401438796;7315.378192853614;38495.422568661495;38731.8063409684;38781.41827872584;38843.22313553742;38949;3571.2678900825267;3594.3530164570366;3598.0285322962654;3599.94600080999;3602.657747513982;29552;29782.851085744434;29787.702122978928;29803.70196298031;29857.850710746523;3338.21551935295;3340.9331813363838;3342.548755917944;3348.096014076186;3396.575428071491;200459;200931;217820;223229;224111;47022.76488617535;47055.5294447058;47070.5292947073;47084.7645761769;47250;49384;49405.50594494081;49516.50483495191;50115;50155;14945.925270373578;14978.925105374621;15085.094894306376;15101.244937753288;15144.621384465476;12003.399830008464;12107;12115.878841211652;12140.15018948665;12220.327881966577;14887.255637218095;14938.850611493963;15017.474388396573;15020.324085416183;15026.624334391729;5970.194023806731;6002.399760023963;6030.075413424485;6032.195029311391;6093.542984276197;996.6760802739138;1057.4765491081964;1070.0583486531957;1071.4053700196466;1085.7068591480256;25097.372565686004;25312.873435632704;25342.239732808044;25414.618780718305;25762;1138.3397629374942;1148.8276758486295;1151.1193936638479;1155.381870699172;1174.9555772954998;13296.268705221306;13583.1850088993;13675.111117777313;13781.586552403243;13838.723225535434;261644;263775;264328;264575;264997;53748.462515375126;54478.45521544813;54558.727206363714;54630.726846366306;54645.72677136589;1468.7503124469079;1474.7492926202572;1490.6422458609857;1502.721996430664;1517.7419838627459;23644.881775591013;25028.24915252545;25036.62445063289;25122;30227.697723022487;53319;53598.46401535935;53632;53952;54053;229327;231063;231792;232656;232666;36329.63670363368;36670.8166459166;36753.816230918674;37779;38343.42484862673;47620;47997.520024799305;48876.26685599648;48990.75504622454;49235;35659;35697.64302357047;35718.4642230372;36067.639323606425;36459.81770091239;35062;35566.28867422689;36369.27261454809;36544.38948964712;37255.25489490249;42040.57959420489;42269.154616908105;42378.78810605927;42555;42744.57255427406;33059.33881322408;35103.47344789779;35500.72235191831;35594.822025889705;35793.46309805407;25765.742342577083;28539.571906421836;28724.712752872205;28915.56626650644;28939.42121157523 04:13:04 INFO - PID 10001 | |2;jquery.html;451.9266741488964;456.09920407195784;456.3269177962506;466.2633039797121;474.8717846181533;15309.846901530982;15872.365105395771;20452.89773551132;21124.366269011934;21244.150233990662;21406.464838379048;22290.331290061284;22472;22482.43793905153;22484.43788905278;5625.1843482694985;5791.247137872071;5791.478766910977;5796.159556864273;5796.739146738386;5645.943540564583;5715.714214289269;5716.14257861322;5718.914216286759;5721.170430287627;5486.561075114001;5645.350784659755;5679.914801277984;5689.573282003846;5707.5148612368;5679.062954612484;5703.0589952657765;5717.285339332583;5718.685472299043;5719.170720245562;5170.793168273264;5176.094183517869;5190.351206099238;5202.401723801773;5208.921866172011;25248.49503009948;25545.361365965815;25629.359266018313;25672.101476448235;25741;2201.526671765578;2234.55308938213;2236.8769717665523;2237.9104835806547;2238.1383167480476;17190.484285471455;17999.19003644839;18037.549061273443;18043.458696239133;18104.547386315317;2230.531588366445;2257.288953979508;2280.5780930527903;2294.472271377576;2297.2993237062688;121884.39057804743;124295.3785231068;124571;124602.37698811539;124760;12079.939600301943;12116.454759535665;12226.449809758404;12471.251724896536;12791.936040319739;17390.739138912926;17426.65146697059;17431.21559529799;17491.30034798619;17492.562685932953;8790.340724445692;8839.779005524784;8931.464112153291;9097.863532047024;9141.908580914238;8426.4944103354;8464.57677116154;8492.490450572985;8500.362472814564;8559.914400856036;7843.882341764878;7913.010873640795;7964.2433968772875;8041.557714325651;8091.716789912325;2272.204728345066;2308.407199032662;2319.895604697793;2343.390718413191;2401.8558886466867;980.9754756131153;1018.5620183321095;1030.1038096855634;1033.1476531861244;1035.4977835749655;19374.70937935932;19594.21623135087;19809.306674266332;19837;20301;1032.896710328976;1036.098594223031;1044.6709286574705;1045.5869931377063;1051.8685164354456;10804.29772064829;10826.783464330669;10830.512626931806;10979.121670266359;11128.888711112948;507117;508358;580609;588138;600059;107233.4638326819;111943;112714;113146;113239.4338028321;1234.1916044990546;1245.912786104964;1292.3021568352983;1293.7283170534106;1298.1691717300935;20067.698984515537;20132.39602811918;20806.271780487612;20948.895255523625;21143.471413214793;53142.73428632987;53238;53864;54718.726406367714;56196.97537807774;69497;70288.29711702818;70399.29600703927;71095.28904711094;71866.64066679633;15256.618584535032;16218.756718648994;16311.429099981444;16731.832681673513;16772.916135419244;17995.5501112468;18600;18709.719354209425;18733.531661708566;18851.434456965766;15057.397704092153;15380.615484612974;15544.145072021147;15669.373225070869;15728.29222684959;12928.418221179882;13448.93275533616;13453;13847.584572462842;13994.860051399355;15540.456084037005;15742.527724167836;15923.44267950616;15929.68140637204;15936.964097333635;15954.441594544136;16020.67958640844;16056.598585035468;16078.839211607734;16096.11471369086;14166.787498187741;14278.286085695881;14358.712825743218;14385.352659130574;15011.249437528299 04:13:04 INFO - PID 10001 | |3;mootools.html;1383.4673650644502;1411.5059729094824;1424.366157060108;1434.1610158057536;1454.2655958740831;11690.590829320965;12193.634190974262;12209.938950305248;12272;12608.495660173581;12161.331126788024;12414.503419863195;12481.625551233456;12501.874981250185;12515.561955331565;2423.8909249083836;2447.510497900418;2455.472073504196;2457.238256140602;2463.692038495188;2392.2673791045354;2438.244144315268;2443.425794938188;2445.0342114864616;2448.7796098351146;2262.807661348779;2265.592193405186;2269.092363054775;2279.2022792022826;2282.2924893283052;2242.88976956406;2317.44381348476;2317.7102862142233;2318.6869772580653;2320.6635037919577;1832.9450116496525;1890.0360815983947;2123.150739704115;2296.81625469962;2301.8503797253125;11432.085433165326;11601.187916845824;11603.303801771921;11617.244879082833;11652.708682282926;6074.271087469488;6280.403361680679;6282.371762823726;6292.528060395489;6299.401556852092;3452.913677158066;3579.2483578448555;3615.620359862203;3632.4369722693023;3640.1809592841664;1307.6469353274658;1307.6534718299658;1329.8869596084344;1342.7180292138662;1343.966400839977;17584.736228956575;17877;17953.820461795345;18005.7299140513;18051;5677.290338707661;5705;5758.107493338455;5837.9124313135335;5848.0350742127075;14818.851811481964;14832.332545035499;14841.851581484047;14871.776923346159;14925.402983880524;6657.300983396771;6756.121704178426;6774.8645027100165;6776.72893084281;6779;6096.177016102858;6140.2017737694705;6140.754369825247;6158.384161583896;6204.069389591597;4609.193391156534;4666.626669866402;4679.438467383936;4704.50602686713;4716.858494245178;1306.3468265867066;1322.5172811923771;1336.7994800779961;1349.7705390083709;1354.0589290443245;807.9192080791873;818.300353198019;834.4909605140859;841.7979684875709;864.2696921101659;6323.620582764956;6358.523110766711;6389.744410223539;6415.711292991827;6584.670766461658;600.474584738354;606.9119977603311;607.1469585232667;617.5306766857221;617.7745123030062;4259.488861336597;4292;4634.791434385461;4700.764961751899;4728.739919304402;15038.17290049036;15540.766888496682;15592.376304947902;15592.739052837274;15603.141827199614;15198.772018419733;15388;15797.526074217792;15812.525624231292;15841.603959900864;9540.47352423609;9675.274354423447;9676.177524910321;9683.031696830261;9700.078492543196;6554.705038273384;7000.22997470288;7106.964465177641;7359.963200184179;7370.815729606803;13910.652233693834;14080.366383512972;14397.208153551655;14408.783868241775;14442.855571444572;13731.862681373059;13891.513797017056;14441.711165776836;14452.494162704255;14615.780763288347;10252.28234023641;10317.761868575819;10337;10382.221333399873;10439.164866810788;11322.830157547478;11423.942880285545;11425.885741142481;11439;11455.828162577402;9228.538573071186;9326.160645541933;9340.906590934275;9578.9042109578;9713.951430242803;8998.955005224932;9028.006919238747;9100.59047342858;9193.218576421079;9460.2904782143;8454.32365410778;8522.616482258438;8563.743087707378;8583.527905965231;8597.65609375643;6255.749770009149;6480.092787009728;6488.513361497812;6492.772752953813;6727.327267273234;6242.563020588515;6280.937190628035;6322.114903913363;6483.643399612878;6605.966970165118 04:13:04 INFO - PID 10001 | |4;prototype.html;387.8661861657727;388.06476391895535;396.2847061054797;397.34438177007934;406.10656555577725;6151.846203844901;6173.259208894928;6216.16081828953;6257.624542527446;6266.436020758131;5834.2998840139135;6038.637681739098;6088;6126.416046612737;6138.132976224983;4641.303804429329;4649.256119020941;4649.465311489172;4663.8367657132;4665.253559430492;4613.177794771063;4643.303504474322;4661.417322834645;4663.720176789404;4690.530946905316;4620.630349572026;4628.143793398232;4639.907201855961;4643.930341044887;4654.674172807905;4627.167109920213;4636.884077898063;4639.118567472186;4649.581537661593;4655.976720116411;4094.488188976378;4095.6074934522107;4103.569125241836;4104.733192342518;4114.341705327163;6010.57925945184;6016.939830601682;6020.69896505173;6025.638461692312;6042.848928776816;5507.449255074501;5515.062439385314;5524.14375771756;5524.696141712204;5535.474129957647;6472.417482426557;6473.546851720382;6511.674416279215;6558.344165583451;6560.967195164041;4603.5959032495075;4645.117427688729;4646.930296045562;4650.511696271877;4654.208784506608;6538.346165383471;6716.294789047178;6831.146106736658;6884.345987131214;6923.273056329063;4596.724196548151;4599.103174880933;4653.301544936074;4658.161530924398;4663.230566956414;4703.741294228782;4720.693154944986;4728.4562275338085;4732.479427262998;4756.143894099096;5288.471152884681;5393.217983392465;5412.26426876483;5415.53967912724;5435.83692489226;6445.903311450332;6483.920137934443;6499.805005849832;6503.967480162569;6512.283648798629;1615.9596010099606;1619.7408414653598;1620.9432669856499;1632.2328505602347;1635.6156303268722;1078.9136869050615;1099.6426161497545;1136.176272202663;1147.6614398752388;1155.0817100405197;6174.9073763892675;6181.258249010058;6184.257889053342;6195.349488303754;6208.441240288395;6646.90029649546;6669.899951500732;6674.499412543982;6703.664816759143;6741.1910570731825;6198;6204.751809927642;6209;6210.844728881814;6212.726391089906;3528.364894318996;3558.448440491728;3560.679538841465;3566.7324950628285;3584.279545818022;6988.580685158907;6995.650217489207;7006.649667516604;7014.473914456436;7022.964885175644;6881.759138430131;6883;6895.482838787011;6921.165891038879;6931.064306318583;6904.585724856524;6921.996310534944;6972.198197207386;6974.407175390047;6991.685374158175;6651.833704157435;6687.732490700318;6696.363845434676;6735.966320168368;6764.8985265222045;6650.667466626746;6663.633500157344;6679.165104361955;6685.53201275906;6698.162729658793;6522.28254891952;6777.45780337562;6970.407515361251;6981.441484681315;6991.147345953428;4665;4684.601808846286;4687.718736875799;4706.529347065403;4707.340972263817;6465.450436712932;6675.632840193642;6745.190577130776;6760.763373281911;6778.525503214925;6443.516736244706;6455.354464553507;6466.676666166767;6482.546221764431;6539.869202615826;6344.302126766144;6409.35906409374;6440.516961227833;6448.774292899726;6449.709763060768;6435.678216089083;6480.481561474976;6499.472623933467;6537.150170477998;6550.6069635822005;6541.8691626168165;6561.573497722633;6586.934130658632;6587.736490540325;6602.1747281589805;6388.552801303864;6414.647194404352;6416.518761092843;6426.614403135827;6442.935570644234 04:13:04 INFO - PID 10001 | |5;yui.html;775.8487095016474;780.8945792318038;806.6087947345536;857.605501469324;878.7627340618034;16671.49985500437;16735.246913888874;17538.912305438487;17547.2103755331;17989.280428782866;19104.522386940334;19154.61690766184;19356.12897419616;19394.70907936382;19418.320358787445;963.6049219819876;980.2256217588133;982.8230918434679;983.650803964593;984.4880662055726;949.2216382566298;976.2336565795852;982.3123813330698;992.0377234082964;993.4436715439341;1026.558579810681;1029.150950465865;1031.3760175094073;1031.742064483879;1034.4103860799348;1024.2113572549133;1026.3687831983314;1028.100412139378;1028.99485502572;1030.737162023683;758.5221310574358;759.7075126076445;760.9086909570887;761.1817296406385;761.1969372312209;17387;17618.119094045247;17795.73306400405;17817.376391826223;18234.088295585167;18526.814731852777;19035.809641903543;19218.807811921983;19265.229390824352;19412.514687132792;13781.655458613515;13884.58346249614;13887.652808679864;13890.166590004632;13923.860761392358;3377.375185590649;3460.619331873492;3472.826358682056;3489.8953031409096;3495.1262184453885;102999.48500257525;104171;104544;105917.47041264821;106482.46758766234;14603.415863365346;14741.631459213606;14815.70368592622;14844.925775371054;15002.624934376729;27986.300342491602;28201.435971280458;28428.147155585364;28497.145085647462;28528.144155675363;7853.136155022943;7945.960270198612;8134.06458257308;8180.46826956246;8200.26197642203;3813.275477659236;3848.1726428817938;3905.258000979805;3905.5703872573995;3914.941275880864;3463.9134021649156;3474.513568100468;3490.2321489272317;3519.9648003519637;3548.6451354864826;887.8179973105498;903.0698380667923;908.7728067983004;918.5499105438287;920.2362039507193;661.1042038038485;696.1924167965136;699.5173330402006;700.0793955948014;708.9751858684921;10649.680509584725;11806.645800625995;12025.218360806695;12124.575639852563;12283.324417157142;650.6161364794793;671.6272468779777;672.2940912042336;676.2831398717277;690.1614538335846;5446.891062178814;5690.374058853523;5717.714114294268;5732.283464566929;5768.278965129359;104168.47915760524;107857;107907;109282;111246.44376778226;93904;93968;94196;94638.52680736552;95035.52482237545;81548.59225703952;82440.58779706183;84131.57934210412;84741.05178964231;85919;10712.196585256293;10780.892191078303;11116;11175.385353805294;11251.212415130862;37259.81370093132;37515.249695006496;37710.81144594259;38838.22323553456;38870.2225955485;48936.75531622462;49401.75299123481;49519.25721114114;49777.50222497729;49926.750366247936;13926.23405712655;14095.859041409865;14158.858411415755;14230.217338046506;14328.211948342941;17091.48725538236;17093.401730939357;17520.82479175192;18420.539486512946;18468.076596170406;17477.213525391642;17686.380976665754;18114.72827907556;18377.081145942917;18525.073746312362;17742.467725968243;18012.729809052613;18176;18405.53986150357;19441.513962150493;17217.760161329417;17247.22387492591;17784.91107544454;17941;18146.18342174632;12032.819507707567;12081.697957551132;12167.391630418266;12172.634820955385;12413.627591172279;13657.317134143055;14170.716585668022;14239.64400889986;14285.214313212873;14321.856781432052 04:13:04 INFO - PID 10001 | __end_tp_report 04:13:04 INFO - PID 10001 | __start_cc_report 04:13:04 INFO - PID 10001 | _x_x_mozilla_cycle_collect,346 04:13:04 INFO - PID 10001 | __end_cc_report 04:13:04 INFO - PID 10001 | __startTimestamp1496229184815__endTimestamp 04:13:04 INFO - PID 10001 | 04:13:04 INFO - PID 10001 | ------- Summary: start ------- 04:13:04 INFO - PID 10001 | Number of tests: 6 04:13:04 INFO - PID 10001 | 04:13:04 INFO - PID 10001 | [#0] dojo.html Cycles:165 Average:5969.46 Median:6208.63 stddev:740.91 (11.9%) stddev-sans-first:714.90 04:13:04 INFO - PID 10001 | Values: 3384.9 3393.6 3406.4 3419.7 3422.6 5875.9 6026.5 6030.0 6035.8 6040.0 5907.0 6022.1 6066.9 6080.5 6144.3 4950.6 5142.3 5296.7 5315.4 5334.4 5321.9 5396.7 5404.1 5408.8 5428.8 5203.8 5216.3 5243.9 5261.8 5322.5 5315.5 5347.8 5352.2 5354.1 5385.3 5298.7 5303.9 5317.1 5324.5 5366.0 5814.0 5897.5 5969.2 5972.5 5989.9 6370.7 6483.1 6521.5 6532.3 6534.2 6432.4 6463.8 6472.6 6485.4 6490.5 5880.1 5969.0 5974.9 5980.7 5991.4 6489.3 6598.3 6663.9 6704.6 6729.0 6108.1 6124.0 6179.1 6396.7 6430.3 6558.3 6558.4 6558.9 6565.1 6572.2 6203.0 6434.1 6499.3 6500.4 6509.3 6295.3 6376.3 6447.8 6449.9 6459.4 4868.6 4875.3 4880.4 4903.9 4919.8 4296.1 4314.7 4316.8 4317.6 4338.4 5881.0 5958.8 5966.9 5977.2 6002.4 6465.9 6468.3 6469.7 6477.2 6522.7 6058.6 6059.7 6069.2 6072.0 6078.5 5331.0 5440.7 5499.4 5506.2 5542.8 6590.2 6631.6 6690.6 6702.9 6794.6 6550.9 6563.0 6567.5 6568.3 6570.8 6734.6 6767.1 6821.9 6842.5 6846.1 6208.6 6261.8 6321.5 6418.8 6419.9 6602.5 6626.2 6626.4 6627.4 6633.1 6150.7 6216.9 6314.9 6427.9 6431.3 6377.4 6403.5 6426.1 6428.7 6429.3 6359.7 6370.3 6386.7 6387.2 6403.2 6160.9 6240.1 6439.4 6479.6 6490.6 6179.3 6264.2 6265.7 6274.3 6278.3 04:13:04 INFO - PID 10001 | 04:13:04 INFO - PID 10001 | [#1] ext.html Cycles:180 Average:41284.22 Median:19835.15 stddev:61667.36 (310.9%) stddev-sans-first:61765.05 04:13:04 INFO - PID 10001 | Values: 697.5 764.4 778.5 1158.0 1181.5 38330.6 38967.0 39042.6 39046.6 39152.4 40101.0 40521.0 40561.8 40569.6 40583.4 7155.1 7168.0 7294.5 7363.6 7369.3 7311.7 7408.3 7415.3 7424.8 7430.5 7377.2 7392.2 7432.9 7450.7 7455.7 7394.0 7397.1 7398.7 7411.9 7421.6 7236.0 7283.1 7287.6 7292.2 7315.4 38495.4 38731.8 38781.4 38843.2 38949.0 3571.3 3594.4 3598.0 3599.9 3602.7 29552.0 29782.9 29787.7 29803.7 29857.9 3338.2 3340.9 3342.5 3348.1 3396.6 200459.0 200931.0 217820.0 223229.0 224111.0 47022.8 47055.5 47070.5 47084.8 47250.0 49384.0 49405.5 49516.5 50115.0 50155.0 14945.9 14978.9 15085.1 15101.2 15144.6 12003.4 12107.0 12115.9 12140.2 12220.3 14887.3 14938.9 15017.5 15020.3 15026.6 5970.2 6002.4 6030.1 6032.2 6093.5 996.7 1057.5 1070.1 1071.4 1085.7 25097.4 25312.9 25342.2 25414.6 25762.0 1138.3 1148.8 1151.1 1155.4 1175.0 13296.3 13583.2 13675.1 13781.6 13838.7 261644.0 263775.0 264328.0 264575.0 264997.0 53748.5 54478.5 54558.7 54630.7 54645.7 1468.8 1474.7 1490.6 1502.7 1517.7 23644.9 25028.2 25036.6 25122.0 30227.7 53319.0 53598.5 53632.0 53952.0 54053.0 229327.0 231063.0 231792.0 232656.0 232666.0 36329.6 36670.8 36753.8 37779.0 38343.4 47620.0 47997.5 48876.3 48990.8 49235.0 35659.0 35697.6 35718.5 36067.6 36459.8 35062.0 35566.3 36369.3 36544.4 37255.3 42040.6 42269.2 42378.8 42555.0 42744.6 33059.3 35103.5 35500.7 35594.8 35793.5 25765.7 28539.6 28724.7 28915.6 28939.4 04:13:04 INFO - PID 10001 | 04:13:04 INFO - PID 10001 | [#2] jquery.html Cycles:180 Average:34921.07 Median:21036.63 stddev:92902.12 (441.6%) stddev-sans-first:93126.69 04:13:04 INFO - PID 10001 | Values: 451.9 456.1 456.3 466.3 474.9 15309.8 15872.4 20452.9 21124.4 21244.2 21406.5 22290.3 22472.0 22482.4 22484.4 5625.2 5791.2 5791.5 5796.2 5796.7 5645.9 5715.7 5716.1 5718.9 5721.2 5486.6 5645.4 5679.9 5689.6 5707.5 5679.1 5703.1 5717.3 5718.7 5719.2 5170.8 5176.1 5190.4 5202.4 5208.9 25248.5 25545.4 25629.4 25672.1 25741.0 2201.5 2234.6 2236.9 2237.9 2238.1 17190.5 17999.2 18037.5 18043.5 18104.5 2230.5 2257.3 2280.6 2294.5 2297.3 121884.4 124295.4 124571.0 124602.4 124760.0 12079.9 12116.5 12226.4 12471.3 12791.9 17390.7 17426.7 17431.2 17491.3 17492.6 8790.3 8839.8 8931.5 9097.9 9141.9 8426.5 8464.6 8492.5 8500.4 8559.9 7843.9 7913.0 7964.2 8041.6 8091.7 2272.2 2308.4 2319.9 2343.4 2401.9 981.0 1018.6 1030.1 1033.1 1035.5 19374.7 19594.2 19809.3 19837.0 20301.0 1032.9 1036.1 1044.7 1045.6 1051.9 10804.3 10826.8 10830.5 10979.1 11128.9 507117.0 508358.0 580609.0 588138.0 600059.0 107233.5 111943.0 112714.0 113146.0 113239.4 1234.2 1245.9 1292.3 1293.7 1298.2 20067.7 20132.4 20806.3 20948.9 21143.5 53142.7 53238.0 53864.0 54718.7 56197.0 69497.0 70288.3 70399.3 71095.3 71866.6 15256.6 16218.8 16311.4 16731.8 16772.9 17995.6 18600.0 18709.7 18733.5 18851.4 15057.4 15380.6 15544.1 15669.4 15728.3 12928.4 13448.9 13453.0 13847.6 13994.9 15540.5 15742.5 15923.4 15929.7 15937.0 15954.4 16020.7 16056.6 16078.8 16096.1 14166.8 14278.3 14358.7 14385.4 15011.2 04:13:04 INFO - PID 10001 | 04:13:04 INFO - PID 10001 | [#3] mootools.html Cycles:180 Average:7449.55 Median:2448.15 stddev:4912.61 (200.7%) stddev-sans-first:4905.24 04:13:04 INFO - PID 10001 | Values: 1383.5 1411.5 1424.4 1434.2 1454.3 11690.6 12193.6 12209.9 12272.0 12608.5 12161.3 12414.5 12481.6 12501.9 12515.6 2423.9 2447.5 2455.5 2457.2 2463.7 2392.3 2438.2 2443.4 2445.0 2448.8 2262.8 2265.6 2269.1 2279.2 2282.3 2242.9 2317.4 2317.7 2318.7 2320.7 1832.9 1890.0 2123.2 2296.8 2301.9 11432.1 11601.2 11603.3 11617.2 11652.7 6074.3 6280.4 6282.4 6292.5 6299.4 3452.9 3579.2 3615.6 3632.4 3640.2 1307.6 1307.7 1329.9 1342.7 1344.0 17584.7 17877.0 17953.8 18005.7 18051.0 5677.3 5705.0 5758.1 5837.9 5848.0 14818.9 14832.3 14841.9 14871.8 14925.4 6657.3 6756.1 6774.9 6776.7 6779.0 6096.2 6140.2 6140.8 6158.4 6204.1 4609.2 4666.6 4679.4 4704.5 4716.9 1306.3 1322.5 1336.8 1349.8 1354.1 807.9 818.3 834.5 841.8 864.3 6323.6 6358.5 6389.7 6415.7 6584.7 600.5 606.9 607.1 617.5 617.8 4259.5 4292.0 4634.8 4700.8 4728.7 15038.2 15540.8 15592.4 15592.7 15603.1 15198.8 15388.0 15797.5 15812.5 15841.6 9540.5 9675.3 9676.2 9683.0 9700.1 6554.7 7000.2 7107.0 7360.0 7370.8 13910.7 14080.4 14397.2 14408.8 14442.9 13731.9 13891.5 14441.7 14452.5 14615.8 10252.3 10317.8 10337.0 10382.2 10439.2 11322.8 11423.9 11425.9 11439.0 11455.8 9228.5 9326.2 9340.9 9578.9 9714.0 8999.0 9028.0 9100.6 9193.2 9460.3 8454.3 8522.6 8563.7 8583.5 8597.7 6255.7 6480.1 6488.5 6492.8 6727.3 6242.6 6280.9 6322.1 6483.6 6606.0 04:13:04 INFO - PID 10001 | 04:13:04 INFO - PID 10001 | [#4] prototype.html Cycles:180 Average:5453.13 Median:6196.67 stddev:1637.11 (26.4%) stddev-sans-first:1596.95 04:13:04 INFO - PID 10001 | Values: 387.9 388.1 396.3 397.3 406.1 6151.8 6173.3 6216.2 6257.6 6266.4 5834.3 6038.6 6088.0 6126.4 6138.1 4641.3 4649.3 4649.5 4663.8 4665.3 4613.2 4643.3 4661.4 4663.7 4690.5 4620.6 4628.1 4639.9 4643.9 4654.7 4627.2 4636.9 4639.1 4649.6 4656.0 4094.5 4095.6 4103.6 4104.7 4114.3 6010.6 6016.9 6020.7 6025.6 6042.8 5507.4 5515.1 5524.1 5524.7 5535.5 6472.4 6473.5 6511.7 6558.3 6561.0 4603.6 4645.1 4646.9 4650.5 4654.2 6538.3 6716.3 6831.1 6884.3 6923.3 4596.7 4599.1 4653.3 4658.2 4663.2 4703.7 4720.7 4728.5 4732.5 4756.1 5288.5 5393.2 5412.3 5415.5 5435.8 6445.9 6483.9 6499.8 6504.0 6512.3 1616.0 1619.7 1620.9 1632.2 1635.6 1078.9 1099.6 1136.2 1147.7 1155.1 6174.9 6181.3 6184.3 6195.3 6208.4 6646.9 6669.9 6674.5 6703.7 6741.2 6198.0 6204.8 6209.0 6210.8 6212.7 3528.4 3558.4 3560.7 3566.7 3584.3 6988.6 6995.7 7006.6 7014.5 7023.0 6881.8 6883.0 6895.5 6921.2 6931.1 6904.6 6922.0 6972.2 6974.4 6991.7 6651.8 6687.7 6696.4 6736.0 6764.9 6650.7 6663.6 6679.2 6685.5 6698.2 6522.3 6777.5 6970.4 6981.4 6991.1 4665.0 4684.6 4687.7 4706.5 4707.3 6465.5 6675.6 6745.2 6760.8 6778.5 6443.5 6455.4 6466.7 6482.5 6539.9 6344.3 6409.4 6440.5 6448.8 6449.7 6435.7 6480.5 6499.5 6537.2 6550.6 6541.9 6561.6 6586.9 6587.7 6602.2 6388.6 6414.6 6416.5 6426.6 6442.9 04:13:04 INFO - PID 10001 | 04:13:04 INFO - PID 10001 | [#5] yui.html Cycles:180 Average:21568.82 Median:19375.42 stddev:29215.39 (150.8%) stddev-sans-first:29255.62 04:13:04 INFO - PID 10001 | Values: 775.8 780.9 806.6 857.6 878.8 16671.5 16735.2 17538.9 17547.2 17989.3 19104.5 19154.6 19356.1 19394.7 19418.3 963.6 980.2 982.8 983.7 984.5 949.2 976.2 982.3 992.0 993.4 1026.6 1029.2 1031.4 1031.7 1034.4 1024.2 1026.4 1028.1 1029.0 1030.7 758.5 759.7 760.9 761.2 761.2 17387.0 17618.1 17795.7 17817.4 18234.1 18526.8 19035.8 19218.8 19265.2 19412.5 13781.7 13884.6 13887.7 13890.2 13923.9 3377.4 3460.6 3472.8 3489.9 3495.1 102999.5 104171.0 104544.0 105917.5 106482.5 14603.4 14741.6 14815.7 14844.9 15002.6 27986.3 28201.4 28428.1 28497.1 28528.1 7853.1 7946.0 8134.1 8180.5 8200.3 3813.3 3848.2 3905.3 3905.6 3914.9 3463.9 3474.5 3490.2 3520.0 3548.6 887.8 903.1 908.8 918.5 920.2 661.1 696.2 699.5 700.1 709.0 10649.7 11806.6 12025.2 12124.6 12283.3 650.6 671.6 672.3 676.3 690.2 5446.9 5690.4 5717.7 5732.3 5768.3 104168.5 107857.0 107907.0 109282.0 111246.4 93904.0 93968.0 94196.0 94638.5 95035.5 81548.6 82440.6 84131.6 84741.1 85919.0 10712.2 10780.9 11116.0 11175.4 11251.2 37259.8 37515.2 37710.8 38838.2 38870.2 48936.8 49401.8 49519.3 49777.5 49926.8 13926.2 14095.9 14158.9 14230.2 14328.2 17091.5 17093.4 17520.8 18420.5 18468.1 17477.2 17686.4 18114.7 18377.1 18525.1 17742.5 18012.7 18176.0 18405.5 19441.5 17217.8 17247.2 17784.9 17941.0 18146.2 12032.8 12081.7 12167.4 12172.6 12413.6 13657.3 14170.7 14239.6 14285.2 14321.9 04:13:04 INFO - PID 10001 | -------- Summary: end -------- 04:13:04 INFO - PID 10001 | 04:13:05 INFO - TEST-INFO | 10001: exit 0 04:13:05 INFO - TEST-OK | dromaeo_css | took 1141224ms 04:13:05 INFO - TEST-START | kraken 04:13:05 INFO - operating with platform_type : linux_ 04:13:05 INFO - Initialising browser for kraken test... 04:13:05 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:55238/getInfo.html -profile /tmp/tmp9ok_U4/profile 04:13:05 INFO - TEST-INFO | started process 10412 (/builds/slave/test/build/application/firefox/firefox http://localhost:55238/getInfo.html) 04:13:40 INFO - TEST-INFO | 10412: killed by SIGTERM 04:13:40 INFO - Browser initialized. 04:13:40 INFO - Running cycle 1/1 for kraken test... 04:13:40 INFO - TEST-INFO | started process 10618 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp9ok_U4/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:13:52 INFO - PID 10618 | RSS: Main: 182390784 04:13:52 INFO - PID 10618 | 04:13:55 INFO - PID 10618 | Cycle 1(1): loaded http://localhost:55238/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:55238/tests/kraken/driver.html?testName=audio-beat-detection) 04:13:55 INFO - PID 10618 | RSS: Main: 186638336 04:13:55 INFO - PID 10618 | 04:13:58 INFO - PID 10618 | Cycle 1(1): loaded http://localhost:55238/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:55238/tests/kraken/driver.html?testName=audio-dft) 04:13:59 INFO - PID 10618 | RSS: Main: 184885248 04:13:59 INFO - PID 10618 | 04:14:01 INFO - PID 10618 | Cycle 1(1): loaded http://localhost:55238/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:55238/tests/kraken/driver.html?testName=audio-fft) 04:14:02 INFO - PID 10618 | RSS: Main: 179433472 04:14:02 INFO - PID 10618 | 04:14:04 INFO - PID 10618 | Cycle 1(1): loaded http://localhost:55238/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:55238/tests/kraken/driver.html?testName=audio-oscillator) 04:14:05 INFO - PID 10618 | RSS: Main: 180514816 04:14:05 INFO - PID 10618 | 04:14:07 INFO - PID 10618 | Cycle 1(1): loaded http://localhost:55238/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:55238/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:14:07 INFO - PID 10618 | RSS: Main: 180187136 04:14:07 INFO - PID 10618 | 04:14:10 INFO - PID 10618 | Cycle 1(1): loaded http://localhost:55238/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:55238/tests/kraken/driver.html?testName=imaging-darkroom) 04:14:11 INFO - PID 10618 | RSS: Main: 182272000 04:14:11 INFO - PID 10618 | 04:14:15 INFO - PID 10618 | Cycle 1(1): loaded http://localhost:55238/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:55238/tests/kraken/driver.html?testName=imaging-desaturate) 04:14:15 INFO - PID 10618 | RSS: Main: 180936704 04:14:15 INFO - PID 10618 | 04:14:18 INFO - PID 10618 | Cycle 1(1): loaded http://localhost:55238/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:55238/tests/kraken/driver.html?testName=json-parse-financial) 04:14:19 INFO - PID 10618 | RSS: Main: 181633024 04:14:19 INFO - PID 10618 | 04:14:20 INFO - PID 10618 | Cycle 1(1): loaded http://localhost:55238/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:55238/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:14:21 INFO - PID 10618 | RSS: Main: 181604352 04:14:21 INFO - PID 10618 | 04:14:22 INFO - PID 10618 | Cycle 1(1): loaded http://localhost:55238/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:55238/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:14:23 INFO - PID 10618 | RSS: Main: 181858304 04:14:23 INFO - PID 10618 | 04:14:25 INFO - PID 10618 | Cycle 1(1): loaded http://localhost:55238/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:55238/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:14:26 INFO - PID 10618 | RSS: Main: 181764096 04:14:26 INFO - PID 10618 | 04:14:29 INFO - PID 10618 | Cycle 1(1): loaded http://localhost:55238/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:55238/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:14:29 INFO - PID 10618 | RSS: Main: 181444608 04:14:29 INFO - PID 10618 | 04:14:32 INFO - PID 10618 | Cycle 1(1): loaded http://localhost:55238/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:55238/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:14:33 INFO - PID 10618 | RSS: Main: 181751808 04:14:33 INFO - PID 10618 | 04:14:34 INFO - PID 10618 | Cycle 1(1): loaded http://localhost:55238/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:55238/tests/kraken/driver.html?testName=ai-astar) 04:14:35 INFO - PID 10618 | RSS: Main: 183328768 04:14:35 INFO - PID 10618 | 04:14:35 INFO - PID 10618 | __start_tp_report 04:14:35 INFO - PID 10618 | _x_x_mozilla_page_load 04:14:35 INFO - PID 10618 | _x_x_mozilla_page_load_details 04:14:35 INFO - PID 10618 | |i|pagename|runs| 04:14:35 INFO - PID 10618 | |0;ai-astar;101;107;110;108;109;108;110;108;108;108 04:14:35 INFO - PID 10618 | |1;audio-beat-detection;146;118;119;167;118;117;118;120;140;123 04:14:35 INFO - PID 10618 | |2;audio-dft;163;163;163;163;163;163;164;164;168;169 04:14:35 INFO - PID 10618 | |3;audio-fft;76;74;76;97;75;73;75;74;103;73 04:14:35 INFO - PID 10618 | |4;audio-oscillator;81;81;104;82;82;81;91;81;82;103 04:14:35 INFO - PID 10618 | |5;imaging-gaussian-blur;113;114;113;113;116;114;114;114;114;113 04:14:35 INFO - PID 10618 | |6;imaging-darkroom;149;149;148;149;148;147;151;150;149;148 04:14:35 INFO - PID 10618 | |7;imaging-desaturate;94;94;95;94;96;95;94;95;94;94 04:14:35 INFO - PID 10618 | |8;json-parse-financial;52;53;48;49;48;50;49;50;49;49 04:14:35 INFO - PID 10618 | |9;json-stringify-tinderbox;56;57;56;56;56;56;57;56;57;56 04:14:35 INFO - PID 10618 | |10;stanford-crypto-aes;87;86;87;93;85;86;93;86;120;86 04:14:35 INFO - PID 10618 | |11;stanford-crypto-ccm;127;143;139;133;121;125;125;125;133;144 04:14:35 INFO - PID 10618 | |12;stanford-crypto-pbkdf2;171;182;173;189;182;196;198;186;180;180 04:14:35 INFO - PID 10618 | |13;stanford-crypto-sha256-iterative;66;66;66;66;63;64;64;67;64;66 04:14:35 INFO - PID 10618 | __end_tp_report 04:14:35 INFO - PID 10618 | __start_cc_report 04:14:35 INFO - PID 10618 | _x_x_mozilla_cycle_collect,911 04:14:35 INFO - PID 10618 | __end_cc_report 04:14:35 INFO - PID 10618 | __startTimestamp1496229275211__endTimestamp 04:14:35 INFO - PID 10618 | 04:14:35 INFO - PID 10618 | ------- Summary: start ------- 04:14:35 INFO - PID 10618 | Number of tests: 14 04:14:35 INFO - PID 10618 | 04:14:35 INFO - PID 10618 | [#0] ai-astar Cycles:10 Average:107.70 Median:108.00 stddev:2.54 (2.4%) stddev-sans-first:1.01 04:14:35 INFO - PID 10618 | Values: 101.0 107.0 110.0 108.0 109.0 108.0 110.0 108.0 108.0 108.0 04:14:35 INFO - PID 10618 | 04:14:35 INFO - PID 10618 | [#1] audio-beat-detection Cycles:10 Average:128.60 Median:121.50 stddev:16.92 (13.9%) stddev-sans-first:16.73 04:14:35 INFO - PID 10618 | Values: 146.0 118.0 119.0 167.0 118.0 117.0 118.0 120.0 140.0 123.0 04:14:35 INFO - PID 10618 | 04:14:35 INFO - PID 10618 | [#2] audio-dft Cycles:10 Average:164.30 Median:163.50 stddev:2.26 (1.4%) stddev-sans-first:2.35 04:14:35 INFO - PID 10618 | Values: 163.0 163.0 163.0 163.0 163.0 163.0 164.0 164.0 168.0 169.0 04:14:35 INFO - PID 10618 | 04:14:35 INFO - PID 10618 | [#3] audio-fft Cycles:10 Average:79.60 Median:75.00 stddev:10.90 (14.5%) stddev-sans-first:11.48 04:14:35 INFO - PID 10618 | Values: 76.0 74.0 76.0 97.0 75.0 73.0 75.0 74.0 103.0 73.0 04:14:35 INFO - PID 10618 | 04:14:35 INFO - PID 10618 | [#4] audio-oscillator Cycles:10 Average:86.80 Median:81.50 stddev:9.31 (11.4%) stddev-sans-first:9.63 04:14:35 INFO - PID 10618 | Values: 81.0 81.0 104.0 82.0 82.0 81.0 91.0 81.0 82.0 103.0 04:14:35 INFO - PID 10618 | 04:14:35 INFO - PID 10618 | [#5] imaging-gaussian-blur Cycles:10 Average:113.80 Median:114.00 stddev:0.92 (0.8%) stddev-sans-first:0.93 04:14:35 INFO - PID 10618 | Values: 113.0 114.0 113.0 113.0 116.0 114.0 114.0 114.0 114.0 113.0 04:14:35 INFO - PID 10618 | 04:14:35 INFO - PID 10618 | [#6] imaging-darkroom Cycles:10 Average:148.80 Median:149.00 stddev:1.14 (0.8%) stddev-sans-first:1.20 04:14:35 INFO - PID 10618 | Values: 149.0 149.0 148.0 149.0 148.0 147.0 151.0 150.0 149.0 148.0 04:14:35 INFO - PID 10618 | 04:14:35 INFO - PID 10618 | [#7] imaging-desaturate Cycles:10 Average:94.50 Median:94.50 stddev:0.71 (0.7%) stddev-sans-first:0.73 04:14:35 INFO - PID 10618 | Values: 94.0 94.0 95.0 94.0 96.0 95.0 94.0 95.0 94.0 94.0 04:14:35 INFO - PID 10618 | 04:14:35 INFO - PID 10618 | [#8] json-parse-financial Cycles:10 Average:49.70 Median:49.50 stddev:1.64 (3.3%) stddev-sans-first:1.51 04:14:35 INFO - PID 10618 | Values: 52.0 53.0 48.0 49.0 48.0 50.0 49.0 50.0 49.0 49.0 04:14:35 INFO - PID 10618 | 04:14:35 INFO - PID 10618 | [#9] json-stringify-tinderbox Cycles:10 Average:56.30 Median:56.00 stddev:0.48 (0.9%) stddev-sans-first:0.50 04:14:35 INFO - PID 10618 | Values: 56.0 57.0 56.0 56.0 56.0 56.0 57.0 56.0 57.0 56.0 04:14:35 INFO - PID 10618 | 04:14:35 INFO - PID 10618 | [#10] stanford-crypto-aes Cycles:10 Average:90.90 Median:86.50 stddev:10.63 (12.3%) stddev-sans-first:11.18 04:14:35 INFO - PID 10618 | Values: 87.0 86.0 87.0 93.0 85.0 86.0 93.0 86.0 120.0 86.0 04:14:35 INFO - PID 10618 | 04:14:35 INFO - PID 10618 | [#11] stanford-crypto-ccm Cycles:10 Average:131.50 Median:133.00 stddev:8.21 (6.2%) stddev-sans-first:8.54 04:14:35 INFO - PID 10618 | Values: 127.0 143.0 139.0 133.0 121.0 125.0 125.0 125.0 133.0 144.0 04:14:35 INFO - PID 10618 | 04:14:35 INFO - PID 10618 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:183.70 Median:184.00 stddev:8.81 (4.8%) stddev-sans-first:8.05 04:14:35 INFO - PID 10618 | Values: 171.0 182.0 173.0 189.0 182.0 196.0 198.0 186.0 180.0 180.0 04:14:35 INFO - PID 10618 | 04:14:35 INFO - PID 10618 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.20 Median:66.00 stddev:1.32 (2.0%) stddev-sans-first:1.36 04:14:35 INFO - PID 10618 | Values: 66.0 66.0 66.0 66.0 63.0 64.0 64.0 67.0 64.0 66.0 04:14:35 INFO - PID 10618 | -------- Summary: end -------- 04:14:35 INFO - PID 10618 | 04:14:36 INFO - TEST-INFO | 10618: exit 0 04:14:36 INFO - TEST-OK | kraken | took 90655ms 04:14:36 INFO - SUITE-END | took 1231s 04:14:36 INFO - Completed test suite (00:20:32) 04:14:36 INFO - javascript benchmark 04:14:36 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8003.253445109286, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3384.915377115572, 3393.6097348804865, 3406.420908445564, 3419.726421886249, 3422.6064002639705, 5875.9118613220835, 6026.517878569714, 6030.035194368902, 6035.849103772408, 6039.969800150999, 5907.0, 6022.066579680146, 6066.908996365047, 6080.452759251666, 6144.293406258282, 4950.615436417375, 5142.331496905397, 5296.682199068058, 5315.362156541201, 5334.359876814788, 5321.920171197416, 5396.676199428027, 5404.081306177959, 5408.8377348679605, 5428.782848686067, 5203.765830537635, 5216.295800067019, 5243.895122097537, 5261.76322065508, 5322.494363035506, 5315.521603055705, 5347.812826551052, 5352.223927530486, 5354.089804733166, 5385.299911011543, 5298.6555873868465, 5303.893922121536, 5317.069512835238, 5324.54741346986, 5365.973170134163, 5814.040683287295, 5897.52819774417, 5969.164316995624, 5972.492338151263, 5989.9101513477335, 6370.681465926731, 6483.092367068614, 6521.47828173745, 6532.281449040602, 6534.183227096613, 6432.356764323577, 6463.838404039937, 6472.611643301417, 6485.383888530582, 6490.545661803676, 5880.088586269135, 5968.985272503684, 5974.910376344358, 5980.671063091485, 5991.400859914017, 6489.253735820346, 6598.307177746364, 6663.933360666429, 6704.631245281556, 6728.9570116632, 6108.0992441897915, 6123.953766440866, 6179.104029915637, 6396.680165991682, 6430.2926678066315, 6558.311377305409, 6558.376954189344, 6558.868822623616, 6565.113709649232, 6572.244191917895, 6203.0, 6434.131392262078, 6499.252585952581, 6500.447461965786, 6509.251436084816, 6295.276043254993, 6376.266729326094, 6447.7743278985945, 6449.935500644933, 6459.354064593503, 4868.634852386085, 4875.317455556225, 4880.389951256093, 4903.901921961541, 4919.77860996256, 4296.0548679290505, 4314.654827613784, 4316.848910288188, 4317.568243175658, 4338.436003319548, 5881.000229960917, 5958.761649534057, 5966.910496342558, 5977.193078934288, 6002.369751176151, 6465.903011454738, 6468.256150542654, 6469.708863101172, 6477.190351206099, 6522.673866306761, 6058.575899687068, 6059.7273122709585, 6069.180660610761, 6072.0, 6078.513718902565, 5330.973345133327, 5440.6735595864375, 5499.367572729107, 5506.201600767866, 5542.8337149885565, 6590.176227971504, 6631.602103873783, 6690.59856408617, 6702.899456508157, 6794.626295553792, 6550.934490655032, 6563.0, 6567.540272180901, 6568.310327415553, 6570.77002304917, 6734.629595372302, 6767.0526126341365, 6821.931780682328, 6842.486813489108, 6846.075779769667, 6208.627482350893, 6261.843453913689, 6321.462675672436, 6418.807435776934, 6419.871602567829, 6602.537822352581, 6626.204855417188, 6626.370494802986, 6627.37039981201, 6633.071370008299, 6150.692465376803, 6216.906746398718, 6314.905276420949, 6427.903581446189, 6431.324710905475, 6377.394147555975, 6403.487720982217, 6426.068220108152, 6428.742850285937, 6429.260635027032, 6359.650219237987, 6370.29926708071, 6386.744530218925, 6387.233531976192, 6403.167588213502, 6160.876782464416, 6240.095186197885, 6439.388258115471, 6479.643619600967, 6490.578112422678, 6179.320274769681, 6264.154339164154, 6265.655388953652, 6274.309825919054, 6278.340774218641], "value": 5915.440144431096, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [697.4524997876665, 764.4343186042329, 778.4589710151444, 1157.9652610421685, 1181.4624345922607, 38330.61669383305, 38967.0, 39042.60957390425, 39046.60953390465, 39152.412713809244, 40101.0, 40521.0, 40561.797191014004, 40569.59430405695, 40583.391249131215, 7155.105611798525, 7168.0, 7294.452916031292, 7363.631818409058, 7369.263073692641, 7311.707531698726, 7408.3332500074985, 7415.258474152595, 7424.777256682281, 7430.479866409353, 7377.188509264003, 7392.225865792198, 7432.851342973137, 7450.664720087582, 7455.664495097706, 7394.0, 7397.149327827261, 7398.70405183792, 7411.851762964738, 7421.554706717588, 7236.0, 7283.089613798275, 7287.599182044985, 7292.161401438796, 7315.378192853614, 38495.422568661495, 38731.8063409684, 38781.41827872584, 38843.22313553742, 38949.0, 3571.2678900825267, 3594.3530164570366, 3598.0285322962654, 3599.94600080999, 3602.657747513982, 29552.0, 29782.851085744434, 29787.702122978928, 29803.70196298031, 29857.850710746523, 3338.21551935295, 3340.9331813363838, 3342.548755917944, 3348.096014076186, 3396.575428071491, 200459.0, 200931.0, 217820.0, 223229.0, 224111.0, 47022.76488617535, 47055.5294447058, 47070.5292947073, 47084.7645761769, 47250.0, 49384.0, 49405.50594494081, 49516.50483495191, 50115.0, 50155.0, 14945.925270373578, 14978.925105374621, 15085.094894306376, 15101.244937753288, 15144.621384465476, 12003.399830008464, 12107.0, 12115.878841211652, 12140.15018948665, 12220.327881966577, 14887.255637218095, 14938.850611493963, 15017.474388396573, 15020.324085416183, 15026.624334391729, 5970.194023806731, 6002.399760023963, 6030.075413424485, 6032.195029311391, 6093.542984276197, 996.6760802739138, 1057.4765491081964, 1070.0583486531957, 1071.4053700196466, 1085.7068591480256, 25097.372565686004, 25312.873435632704, 25342.239732808044, 25414.618780718305, 25762.0, 1138.3397629374942, 1148.8276758486295, 1151.1193936638479, 1155.381870699172, 1174.9555772954998, 13296.268705221306, 13583.1850088993, 13675.111117777313, 13781.586552403243, 13838.723225535434, 261644.0, 263775.0, 264328.0, 264575.0, 264997.0, 53748.462515375126, 54478.45521544813, 54558.727206363714, 54630.726846366306, 54645.72677136589, 1468.7503124469079, 1474.7492926202572, 1490.6422458609857, 1502.721996430664, 1517.7419838627459, 23644.881775591013, 25028.24915252545, 25036.62445063289, 25122.0, 30227.697723022487, 53319.0, 53598.46401535935, 53632.0, 53952.0, 54053.0, 229327.0, 231063.0, 231792.0, 232656.0, 232666.0, 36329.63670363368, 36670.8166459166, 36753.816230918674, 37779.0, 38343.42484862673, 47620.0, 47997.520024799305, 48876.26685599648, 48990.75504622454, 49235.0, 35659.0, 35697.64302357047, 35718.4642230372, 36067.639323606425, 36459.81770091239, 35062.0, 35566.28867422689, 36369.27261454809, 36544.38948964712, 37255.25489490249, 42040.57959420489, 42269.154616908105, 42378.78810605927, 42555.0, 42744.57255427406, 33059.33881322408, 35103.47344789779, 35500.72235191831, 35594.822025889705, 35793.46309805407, 25765.742342577083, 28539.571906421836, 28724.712752872205, 28915.56626650644, 28939.42121157523], "value": 17788.416935520057, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [451.9266741488964, 456.09920407195784, 456.3269177962506, 466.2633039797121, 474.8717846181533, 15309.846901530982, 15872.365105395771, 20452.89773551132, 21124.366269011934, 21244.150233990662, 21406.464838379048, 22290.331290061284, 22472.0, 22482.43793905153, 22484.43788905278, 5625.1843482694985, 5791.247137872071, 5791.478766910977, 5796.159556864273, 5796.739146738386, 5645.943540564583, 5715.714214289269, 5716.14257861322, 5718.914216286759, 5721.170430287627, 5486.561075114001, 5645.350784659755, 5679.914801277984, 5689.573282003846, 5707.5148612368, 5679.062954612484, 5703.0589952657765, 5717.285339332583, 5718.685472299043, 5719.170720245562, 5170.793168273264, 5176.094183517869, 5190.351206099238, 5202.401723801773, 5208.921866172011, 25248.49503009948, 25545.361365965815, 25629.359266018313, 25672.101476448235, 25741.0, 2201.526671765578, 2234.55308938213, 2236.8769717665523, 2237.9104835806547, 2238.1383167480476, 17190.484285471455, 17999.19003644839, 18037.549061273443, 18043.458696239133, 18104.547386315317, 2230.531588366445, 2257.288953979508, 2280.5780930527903, 2294.472271377576, 2297.2993237062688, 121884.39057804743, 124295.3785231068, 124571.0, 124602.37698811539, 124760.0, 12079.939600301943, 12116.454759535665, 12226.449809758404, 12471.251724896536, 12791.936040319739, 17390.739138912926, 17426.65146697059, 17431.21559529799, 17491.30034798619, 17492.562685932953, 8790.340724445692, 8839.779005524784, 8931.464112153291, 9097.863532047024, 9141.908580914238, 8426.4944103354, 8464.57677116154, 8492.490450572985, 8500.362472814564, 8559.914400856036, 7843.882341764878, 7913.010873640795, 7964.2433968772875, 8041.557714325651, 8091.716789912325, 2272.204728345066, 2308.407199032662, 2319.895604697793, 2343.390718413191, 2401.8558886466867, 980.9754756131153, 1018.5620183321095, 1030.1038096855634, 1033.1476531861244, 1035.4977835749655, 19374.70937935932, 19594.21623135087, 19809.306674266332, 19837.0, 20301.0, 1032.896710328976, 1036.098594223031, 1044.6709286574705, 1045.5869931377063, 1051.8685164354456, 10804.29772064829, 10826.783464330669, 10830.512626931806, 10979.121670266359, 11128.888711112948, 507117.0, 508358.0, 580609.0, 588138.0, 600059.0, 107233.4638326819, 111943.0, 112714.0, 113146.0, 113239.4338028321, 1234.1916044990546, 1245.912786104964, 1292.3021568352983, 1293.7283170534106, 1298.1691717300935, 20067.698984515537, 20132.39602811918, 20806.271780487612, 20948.895255523625, 21143.471413214793, 53142.73428632987, 53238.0, 53864.0, 54718.726406367714, 56196.97537807774, 69497.0, 70288.29711702818, 70399.29600703927, 71095.28904711094, 71866.64066679633, 15256.618584535032, 16218.756718648994, 16311.429099981444, 16731.832681673513, 16772.916135419244, 17995.5501112468, 18600.0, 18709.719354209425, 18733.531661708566, 18851.434456965766, 15057.397704092153, 15380.615484612974, 15544.145072021147, 15669.373225070869, 15728.29222684959, 12928.418221179882, 13448.93275533616, 13453.0, 13847.584572462842, 13994.860051399355, 15540.456084037005, 15742.527724167836, 15923.44267950616, 15929.68140637204, 15936.964097333635, 15954.441594544136, 16020.67958640844, 16056.598585035468, 16078.839211607734, 16096.11471369086, 14166.787498187741, 14278.286085695881, 14358.712825743218, 14385.352659130574, 15011.249437528299], "value": 10999.391390361769, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1383.4673650644502, 1411.5059729094824, 1424.366157060108, 1434.1610158057536, 1454.2655958740831, 11690.590829320965, 12193.634190974262, 12209.938950305248, 12272.0, 12608.495660173581, 12161.331126788024, 12414.503419863195, 12481.625551233456, 12501.874981250185, 12515.561955331565, 2423.8909249083836, 2447.510497900418, 2455.472073504196, 2457.238256140602, 2463.692038495188, 2392.2673791045354, 2438.244144315268, 2443.425794938188, 2445.0342114864616, 2448.7796098351146, 2262.807661348779, 2265.592193405186, 2269.092363054775, 2279.2022792022826, 2282.2924893283052, 2242.88976956406, 2317.44381348476, 2317.7102862142233, 2318.6869772580653, 2320.6635037919577, 1832.9450116496525, 1890.0360815983947, 2123.150739704115, 2296.81625469962, 2301.8503797253125, 11432.085433165326, 11601.187916845824, 11603.303801771921, 11617.244879082833, 11652.708682282926, 6074.271087469488, 6280.403361680679, 6282.371762823726, 6292.528060395489, 6299.401556852092, 3452.913677158066, 3579.2483578448555, 3615.620359862203, 3632.4369722693023, 3640.1809592841664, 1307.6469353274658, 1307.6534718299658, 1329.8869596084344, 1342.7180292138662, 1343.966400839977, 17584.736228956575, 17877.0, 17953.820461795345, 18005.7299140513, 18051.0, 5677.290338707661, 5705.0, 5758.107493338455, 5837.9124313135335, 5848.0350742127075, 14818.851811481964, 14832.332545035499, 14841.851581484047, 14871.776923346159, 14925.402983880524, 6657.300983396771, 6756.121704178426, 6774.8645027100165, 6776.72893084281, 6779.0, 6096.177016102858, 6140.2017737694705, 6140.754369825247, 6158.384161583896, 6204.069389591597, 4609.193391156534, 4666.626669866402, 4679.438467383936, 4704.50602686713, 4716.858494245178, 1306.3468265867066, 1322.5172811923771, 1336.7994800779961, 1349.7705390083709, 1354.0589290443245, 807.9192080791873, 818.300353198019, 834.4909605140859, 841.7979684875709, 864.2696921101659, 6323.620582764956, 6358.523110766711, 6389.744410223539, 6415.711292991827, 6584.670766461658, 600.474584738354, 606.9119977603311, 607.1469585232667, 617.5306766857221, 617.7745123030062, 4259.488861336597, 4292.0, 4634.791434385461, 4700.764961751899, 4728.739919304402, 15038.17290049036, 15540.766888496682, 15592.376304947902, 15592.739052837274, 15603.141827199614, 15198.772018419733, 15388.0, 15797.526074217792, 15812.525624231292, 15841.603959900864, 9540.47352423609, 9675.274354423447, 9676.177524910321, 9683.031696830261, 9700.078492543196, 6554.705038273384, 7000.22997470288, 7106.964465177641, 7359.963200184179, 7370.815729606803, 13910.652233693834, 14080.366383512972, 14397.208153551655, 14408.783868241775, 14442.855571444572, 13731.862681373059, 13891.513797017056, 14441.711165776836, 14452.494162704255, 14615.780763288347, 10252.28234023641, 10317.761868575819, 10337.0, 10382.221333399873, 10439.164866810788, 11322.830157547478, 11423.942880285545, 11425.885741142481, 11439.0, 11455.828162577402, 9228.538573071186, 9326.160645541933, 9340.906590934275, 9578.9042109578, 9713.951430242803, 8998.955005224932, 9028.006919238747, 9100.59047342858, 9193.218576421079, 9460.2904782143, 8454.32365410778, 8522.616482258438, 8563.743087707378, 8583.527905965231, 8597.65609375643, 6255.749770009149, 6480.092787009728, 6488.513361497812, 6492.772752953813, 6727.327267273234, 6242.563020588515, 6280.937190628035, 6322.114903913363, 6483.643399612878, 6605.966970165118], "value": 5458.443357316541, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [387.8661861657727, 388.06476391895535, 396.2847061054797, 397.34438177007934, 406.10656555577725, 6151.846203844901, 6173.259208894928, 6216.16081828953, 6257.624542527446, 6266.436020758131, 5834.2998840139135, 6038.637681739098, 6088.0, 6126.416046612737, 6138.132976224983, 4641.303804429329, 4649.256119020941, 4649.465311489172, 4663.8367657132, 4665.253559430492, 4613.177794771063, 4643.303504474322, 4661.417322834645, 4663.720176789404, 4690.530946905316, 4620.630349572026, 4628.143793398232, 4639.907201855961, 4643.930341044887, 4654.674172807905, 4627.167109920213, 4636.884077898063, 4639.118567472186, 4649.581537661593, 4655.976720116411, 4094.488188976378, 4095.6074934522107, 4103.569125241836, 4104.733192342518, 4114.341705327163, 6010.57925945184, 6016.939830601682, 6020.69896505173, 6025.638461692312, 6042.848928776816, 5507.449255074501, 5515.062439385314, 5524.14375771756, 5524.696141712204, 5535.474129957647, 6472.417482426557, 6473.546851720382, 6511.674416279215, 6558.344165583451, 6560.967195164041, 4603.5959032495075, 4645.117427688729, 4646.930296045562, 4650.511696271877, 4654.208784506608, 6538.346165383471, 6716.294789047178, 6831.146106736658, 6884.345987131214, 6923.273056329063, 4596.724196548151, 4599.103174880933, 4653.301544936074, 4658.161530924398, 4663.230566956414, 4703.741294228782, 4720.693154944986, 4728.4562275338085, 4732.479427262998, 4756.143894099096, 5288.471152884681, 5393.217983392465, 5412.26426876483, 5415.53967912724, 5435.83692489226, 6445.903311450332, 6483.920137934443, 6499.805005849832, 6503.967480162569, 6512.283648798629, 1615.9596010099606, 1619.7408414653598, 1620.9432669856499, 1632.2328505602347, 1635.6156303268722, 1078.9136869050615, 1099.6426161497545, 1136.176272202663, 1147.6614398752388, 1155.0817100405197, 6174.9073763892675, 6181.258249010058, 6184.257889053342, 6195.349488303754, 6208.441240288395, 6646.90029649546, 6669.899951500732, 6674.499412543982, 6703.664816759143, 6741.1910570731825, 6198.0, 6204.751809927642, 6209.0, 6210.844728881814, 6212.726391089906, 3528.364894318996, 3558.448440491728, 3560.679538841465, 3566.7324950628285, 3584.279545818022, 6988.580685158907, 6995.650217489207, 7006.649667516604, 7014.473914456436, 7022.964885175644, 6881.759138430131, 6883.0, 6895.482838787011, 6921.165891038879, 6931.064306318583, 6904.585724856524, 6921.996310534944, 6972.198197207386, 6974.407175390047, 6991.685374158175, 6651.833704157435, 6687.732490700318, 6696.363845434676, 6735.966320168368, 6764.8985265222045, 6650.667466626746, 6663.633500157344, 6679.165104361955, 6685.53201275906, 6698.162729658793, 6522.28254891952, 6777.45780337562, 6970.407515361251, 6981.441484681315, 6991.147345953428, 4665.0, 4684.601808846286, 4687.718736875799, 4706.529347065403, 4707.340972263817, 6465.450436712932, 6675.632840193642, 6745.190577130776, 6760.763373281911, 6778.525503214925, 6443.516736244706, 6455.354464553507, 6466.676666166767, 6482.546221764431, 6539.869202615826, 6344.302126766144, 6409.35906409374, 6440.516961227833, 6448.774292899726, 6449.709763060768, 6435.678216089083, 6480.481561474976, 6499.472623933467, 6537.150170477998, 6550.6069635822005, 6541.8691626168165, 6561.573497722633, 6586.934130658632, 6587.736490540325, 6602.1747281589805, 6388.552801303864, 6414.647194404352, 6416.518761092843, 6426.614403135827, 6442.935570644234], "value": 4935.9673655141905, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [775.8487095016474, 780.8945792318038, 806.6087947345536, 857.605501469324, 878.7627340618034, 16671.49985500437, 16735.246913888874, 17538.912305438487, 17547.2103755331, 17989.280428782866, 19104.522386940334, 19154.61690766184, 19356.12897419616, 19394.70907936382, 19418.320358787445, 963.6049219819876, 980.2256217588133, 982.8230918434679, 983.650803964593, 984.4880662055726, 949.2216382566298, 976.2336565795852, 982.3123813330698, 992.0377234082964, 993.4436715439341, 1026.558579810681, 1029.150950465865, 1031.3760175094073, 1031.742064483879, 1034.4103860799348, 1024.2113572549133, 1026.3687831983314, 1028.100412139378, 1028.99485502572, 1030.737162023683, 758.5221310574358, 759.7075126076445, 760.9086909570887, 761.1817296406385, 761.1969372312209, 17387.0, 17618.119094045247, 17795.73306400405, 17817.376391826223, 18234.088295585167, 18526.814731852777, 19035.809641903543, 19218.807811921983, 19265.229390824352, 19412.514687132792, 13781.655458613515, 13884.58346249614, 13887.652808679864, 13890.166590004632, 13923.860761392358, 3377.375185590649, 3460.619331873492, 3472.826358682056, 3489.8953031409096, 3495.1262184453885, 102999.48500257525, 104171.0, 104544.0, 105917.47041264821, 106482.46758766234, 14603.415863365346, 14741.631459213606, 14815.70368592622, 14844.925775371054, 15002.624934376729, 27986.300342491602, 28201.435971280458, 28428.147155585364, 28497.145085647462, 28528.144155675363, 7853.136155022943, 7945.960270198612, 8134.06458257308, 8180.46826956246, 8200.26197642203, 3813.275477659236, 3848.1726428817938, 3905.258000979805, 3905.5703872573995, 3914.941275880864, 3463.9134021649156, 3474.513568100468, 3490.2321489272317, 3519.9648003519637, 3548.6451354864826, 887.8179973105498, 903.0698380667923, 908.7728067983004, 918.5499105438287, 920.2362039507193, 661.1042038038485, 696.1924167965136, 699.5173330402006, 700.0793955948014, 708.9751858684921, 10649.680509584725, 11806.645800625995, 12025.218360806695, 12124.575639852563, 12283.324417157142, 650.6161364794793, 671.6272468779777, 672.2940912042336, 676.2831398717277, 690.1614538335846, 5446.891062178814, 5690.374058853523, 5717.714114294268, 5732.283464566929, 5768.278965129359, 104168.47915760524, 107857.0, 107907.0, 109282.0, 111246.44376778226, 93904.0, 93968.0, 94196.0, 94638.52680736552, 95035.52482237545, 81548.59225703952, 82440.58779706183, 84131.57934210412, 84741.05178964231, 85919.0, 10712.196585256293, 10780.892191078303, 11116.0, 11175.385353805294, 11251.212415130862, 37259.81370093132, 37515.249695006496, 37710.81144594259, 38838.22323553456, 38870.2225955485, 48936.75531622462, 49401.75299123481, 49519.25721114114, 49777.50222497729, 49926.750366247936, 13926.23405712655, 14095.859041409865, 14158.858411415755, 14230.217338046506, 14328.211948342941, 17091.48725538236, 17093.401730939357, 17520.82479175192, 18420.539486512946, 18468.076596170406, 17477.213525391642, 17686.380976665754, 18114.72827907556, 18377.081145942917, 18525.073746312362, 17742.467725968243, 18012.729809052613, 18176.0, 18405.53986150357, 19441.513962150493, 17217.760161329417, 17247.22387492591, 17784.91107544454, 17941.0, 18146.18342174632, 12032.819507707567, 12081.697957551132, 12167.391630418266, 12172.634820955385, 12413.627591172279, 13657.317134143055, 14170.716585668022, 14239.64400889986, 14285.214313212873, 14321.856781432052], "value": 8426.253188576518, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1501.4, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [101.0, 107.0, 110.0, 108.0, 109.0, 108.0, 110.0, 108.0, 108.0, 108.0], "value": 107.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 118.0, 119.0, 167.0, 118.0, 117.0, 118.0, 120.0, 140.0, 123.0], "value": 128.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 163.0, 163.0, 163.0, 163.0, 163.0, 164.0, 164.0, 168.0, 169.0], "value": 164.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 74.0, 76.0, 97.0, 75.0, 73.0, 75.0, 74.0, 103.0, 73.0], "value": 79.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 81.0, 104.0, 82.0, 82.0, 81.0, 91.0, 81.0, 82.0, 103.0], "value": 86.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 114.0, 113.0, 113.0, 116.0, 114.0, 114.0, 114.0, 114.0, 113.0], "value": 113.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 149.0, 148.0, 149.0, 148.0, 147.0, 151.0, 150.0, 149.0, 148.0], "value": 148.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 95.0, 94.0, 96.0, 95.0, 94.0, 95.0, 94.0, 94.0], "value": 94.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [52.0, 53.0, 48.0, 49.0, 48.0, 50.0, 49.0, 50.0, 49.0, 49.0], "value": 49.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 57.0, 56.0, 56.0, 56.0, 56.0, 57.0, 56.0, 57.0, 56.0], "value": 56.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 86.0, 87.0, 93.0, 85.0, 86.0, 93.0, 86.0, 120.0, 86.0], "value": 90.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [127.0, 143.0, 139.0, 133.0, 121.0, 125.0, 125.0, 125.0, 133.0, 144.0], "value": 131.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [171.0, 182.0, 173.0, 189.0, 182.0, 196.0, 198.0, 186.0, 180.0, 180.0], "value": 183.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 66.0, 66.0, 66.0, 63.0, 64.0, 64.0, 67.0, 64.0, 66.0], "value": 65.2, "unit": "score"}]}]} 04:14:36 INFO - Return code: 0 04:14:37 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 04:14:37 INFO - # TBPL SUCCESS # 04:14:37 INFO - Running post-action listener: _resource_record_post_action 04:14:37 INFO - [mozharness: 2017-05-31 11:14:37.012117Z] Finished run-tests step (success) 04:14:37 INFO - Running post-run listener: _resource_record_post_run 04:14:37 INFO - Total resource usage - Wall time: 1249s; CPU: 13.0%; Read bytes: 20480; Write bytes: 420831232; Read time: 36; Write time: 326112 04:14:37 INFO - TinderboxPrint: CPU usage
12.6% 04:14:37 INFO - TinderboxPrint: I/O read bytes / time
20,480 / 36 04:14:37 INFO - TinderboxPrint: I/O write bytes / time
420,831,232 / 326,112 04:14:37 INFO - TinderboxPrint: CPU idle
8,712.7 (87.4%) 04:14:37 INFO - TinderboxPrint: CPU user
1,202.4 (12.1%) 04:14:37 INFO - TinderboxPrint: Swap in / out
0 / 0 04:14:37 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 103235584; Read time: 0; Write time: 113552 04:14:37 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 04:14:37 INFO - run-tests - Wall time: 1233s; CPU: 13.0%; Read bytes: 16384; Write bytes: 317595648; Read time: 24; Write time: 212560 04:14:37 INFO - Running post-run listener: _upload_blobber_files 04:14:37 INFO - Blob upload gear active. 04:14:37 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04:14:37 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 04:14:37 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-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 04:14:37 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-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 04:14:38 INFO - (blobuploader) - INFO - Open directory for files ... 04:14:38 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 04:14:38 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:14:38 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:14:39 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 04:14:39 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:14:39 INFO - (blobuploader) - INFO - Done attempting. 04:14:39 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 04:14:39 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:14:39 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:14:40 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 04:14:40 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:14:40 INFO - (blobuploader) - INFO - Done attempting. 04:14:40 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 04:14:40 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:14:40 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:14:47 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 04:14:47 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:14:47 INFO - (blobuploader) - INFO - Done attempting. 04:14:47 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 04:14:47 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:14:47 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:14:48 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 04:14:48 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:14:48 INFO - (blobuploader) - INFO - Done attempting. 04:14:48 INFO - (blobuploader) - INFO - Iteration through files over. 04:14:48 INFO - Return code: 0 04:14:48 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 04:14:48 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 04:14:48 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/945a54c8a8927bf8c999dc3fd69f754cb0877b05b1cf099960ce0a58a369920499a4bf2c212d6549a7d359e1a79831e2364fe1ccbe31f20f26cbe4deb4af08e0", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/721078933a5c0104b3de0ace5e907fc1ab9496f0896c06e155eef5ed3620305c7e1a56b742190f6243c217e1cf93a4f590bd900ca9a6c4d0cb767956872a8bef", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/b4f46cd8c62b149ad51410009c754bc435a9170b6ee76b3146a973c79a0ab1313ccbad9d887ac6968070abe050be9f77be22146533a5607e5be75f5acc1942c2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/cfbc36218b27cc2841133e31a6c84024d90d1130762a610dbfd88be2ae0b1d8bf12d2c116cca6797f8303e25e9a1340ccf6d11548cf0a561ef60a1fc31c30ecb"} 04:14:48 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:14:48 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:14:48 INFO - Contents: 04:14:48 INFO - blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/945a54c8a8927bf8c999dc3fd69f754cb0877b05b1cf099960ce0a58a369920499a4bf2c212d6549a7d359e1a79831e2364fe1ccbe31f20f26cbe4deb4af08e0", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/721078933a5c0104b3de0ace5e907fc1ab9496f0896c06e155eef5ed3620305c7e1a56b742190f6243c217e1cf93a4f590bd900ca9a6c4d0cb767956872a8bef", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/b4f46cd8c62b149ad51410009c754bc435a9170b6ee76b3146a973c79a0ab1313ccbad9d887ac6968070abe050be9f77be22146533a5607e5be75f5acc1942c2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/cfbc36218b27cc2841133e31a6c84024d90d1130762a610dbfd88be2ae0b1d8bf12d2c116cca6797f8303e25e9a1340ccf6d11548cf0a561ef60a1fc31c30ecb"} 04:14:48 INFO - Running post-run listener: copy_logs_to_upload_dir 04:14:48 INFO - Copying logs to upload dir... 04:14:48 INFO - mkdir: /builds/slave/test/build/upload/logs 04:14:48 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1310.902963 ========= master_lag: 0.18 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 51 secs) (at 2017-05-31 04:14:48.370131) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-31 04:14:48.374386) ========= 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=836cfdc75598d54cb747368e000001a9-1496225697.633254-970548499 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-Non-PGO/sha512/945a54c8a8927bf8c999dc3fd69f754cb0877b05b1cf099960ce0a58a369920499a4bf2c212d6549a7d359e1a79831e2364fe1ccbe31f20f26cbe4deb4af08e0", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/721078933a5c0104b3de0ace5e907fc1ab9496f0896c06e155eef5ed3620305c7e1a56b742190f6243c217e1cf93a4f590bd900ca9a6c4d0cb767956872a8bef", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/b4f46cd8c62b149ad51410009c754bc435a9170b6ee76b3146a973c79a0ab1313ccbad9d887ac6968070abe050be9f77be22146533a5607e5be75f5acc1942c2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/cfbc36218b27cc2841133e31a6c84024d90d1130762a610dbfd88be2ae0b1d8bf12d2c116cca6797f8303e25e9a1340ccf6d11548cf0a561ef60a1fc31c30ecb"} build_url:https://queue.taskcluster.net/v1/task/fvuJYUJtQ3i7Te9JmSkDtQ/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011249 build_url: 'https://queue.taskcluster.net/v1/task/fvuJYUJtQ3i7Te9JmSkDtQ/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/945a54c8a8927bf8c999dc3fd69f754cb0877b05b1cf099960ce0a58a369920499a4bf2c212d6549a7d359e1a79831e2364fe1ccbe31f20f26cbe4deb4af08e0", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/721078933a5c0104b3de0ace5e907fc1ab9496f0896c06e155eef5ed3620305c7e1a56b742190f6243c217e1cf93a4f590bd900ca9a6c4d0cb767956872a8bef", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/b4f46cd8c62b149ad51410009c754bc435a9170b6ee76b3146a973c79a0ab1313ccbad9d887ac6968070abe050be9f77be22146533a5607e5be75f5acc1942c2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/cfbc36218b27cc2841133e31a6c84024d90d1130762a610dbfd88be2ae0b1d8bf12d2c116cca6797f8303e25e9a1340ccf6d11548cf0a561ef60a1fc31c30ecb"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-31 04:14:48.401123) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-31 04:14:48.401410) ========= 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=836cfdc75598d54cb747368e000001a9-1496225697.633254-970548499 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004608 ========= master_lag: 0.07 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-31 04:14:48.480824) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-31 04:14:48.484159) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-31 04:14:48.484451) ========= ========= Total master_lag: 0.34 =========