builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-029 starttime: 1495948128.73 results: success (0) revision: 6a235092bda7c20cb83651d3404284fe36d04c1b ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-05-27 22:08:48.730077) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-05-27 22:08:48.730458) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-27 22:08:48.730745) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-27 22:08:48.769134) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-27 22:08:48.769399) ========= 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=ba164b0a7b0ec7655860e956000001c1-1495938088.707465-1433112007 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-05-27 22:08:48-- 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% 54.0M=0s 2017-05-27 22:08:49 (54.0 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.147347 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-27 22:08:48.929628) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-27 22:08:48.932948) ========= 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=ba164b0a7b0ec7655860e956000001c1-1495938088.707465-1433112007 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016441 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-27 22:08:48.982437) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-27 22:08:48.985778) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 6a235092bda7c20cb83651d3404284fe36d04c1b --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 6a235092bda7c20cb83651d3404284fe36d04c1b --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=ba164b0a7b0ec7655860e956000001c1-1495938088.707465-1433112007 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-05-27 22:08:49,189 truncating revision to first 12 chars 2017-05-27 22:08:49,189 Setting DEBUG logging. 2017-05-27 22:08:49,189 attempt 1/10 2017-05-27 22:08:49,189 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/6a235092bda7?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-05-27 22:08:49,525 unpacking tar archive at: mozilla-central-6a235092bda7/testing/mozharness/ program finished with exit code 0 elapsedTime=0.660613 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-27 22:08:49.662042) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-27 22:08:49.662354) ========= script_repo_revision: 6a235092bda7c20cb83651d3404284fe36d04c1b ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-27 22:08:49.662756) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-27 22:08:49.663046) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-27 22:08:49.675282) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 22 mins, 0 secs) (at 2017-05-27 22:08:49.675560) ========= /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=ba164b0a7b0ec7655860e956000001c1-1495938088.707465-1433112007 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 22:08:49 INFO - MultiFileLogger online at 20170527 22:08:49 in /builds/slave/test 22:08:49 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 22:08:49 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 22:08:49 INFO - {'append_to_log': False, 22:08:49 INFO - 'base_work_dir': '/builds/slave/test', 22:08:49 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 22:08:49 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 22:08:49 INFO - 'branch': 'Firefox-Non-PGO', 22:08:49 INFO - 'buildbot_json_path': 'buildprops.json', 22:08:49 INFO - 'config_files': ('talos/linux_config.py',), 22:08:49 INFO - 'default_actions': ('clobber', 22:08:49 INFO - 'read-buildbot-config', 22:08:49 INFO - 'download-and-extract', 22:08:49 INFO - 'populate-webroot', 22:08:49 INFO - 'create-virtualenv', 22:08:49 INFO - 'install', 22:08:49 INFO - 'setup-mitmproxy', 22:08:49 INFO - 'run-tests'), 22:08:49 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 22:08:49 INFO - 'download_minidump_stackwalk': True, 22:08:49 INFO - 'download_symbols': 'ondemand', 22:08:49 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 22:08:49 INFO - 'tooltool.py': '/tools/tooltool.py', 22:08:49 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 22:08:49 INFO - '/tools/misc-python/virtualenv.py')}, 22:08:49 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 22:08:49 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 22:08:49 INFO - 'gecko_profile': False, 22:08:49 INFO - 'gecko_profile_interval': 0, 22:08:49 INFO - 'installer_path': 'installer.exe', 22:08:49 INFO - 'log_level': 'info', 22:08:49 INFO - 'log_name': 'talos', 22:08:49 INFO - 'log_to_console': True, 22:08:49 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 22:08:49 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 22:08:49 INFO - 'opt_config_files': (), 22:08:49 INFO - 'pip_index': False, 22:08:49 INFO - 'suite': 'dromaeojs-e10s', 22:08:49 INFO - 'system_bits': '32', 22:08:49 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 22:08:49 INFO - 'title': 'talos-linux64-ix-029', 22:08:49 INFO - 'tooltool_cache': '/builds/tooltool_cache', 22:08:49 INFO - 'use_talos_json': True, 22:08:49 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 22:08:49 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 22:08:49 INFO - 'work_dir': 'build'} 22:08:49 INFO - [mozharness: 2017-05-28 05:08:49.984011Z] Running clobber step. 22:08:49 INFO - Running pre-action listener: _resource_record_pre_action 22:08:49 INFO - Running main action method: clobber 22:08:49 INFO - rmtree: /builds/slave/test/build 22:08:49 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 22:08:51 INFO - Running post-action listener: _resource_record_post_action 22:08:51 INFO - [mozharness: 2017-05-28 05:08:51.504136Z] Finished clobber step (success) 22:08:51 INFO - [mozharness: 2017-05-28 05:08:51.504236Z] Running read-buildbot-config step. 22:08:51 INFO - Running pre-action listener: _resource_record_pre_action 22:08:51 INFO - Running main action method: read_buildbot_config 22:08:51 INFO - Using buildbot properties: 22:08:51 INFO - { 22:08:51 INFO - "project": "", 22:08:51 INFO - "product": "firefox", 22:08:51 INFO - "who": "philringnalda@gmail.com", 22:08:51 INFO - "installer_path": "public/build/target.tar.bz2", 22:08:51 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 22:08:51 INFO - "repository": "https://hg.mozilla.org/mozilla-central/", 22:08:51 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-e10s", 22:08:51 INFO - "stage_platform": "linux64", 22:08:51 INFO - "basedir": "/builds/slave/test", 22:08:51 INFO - "buildnumber": 859, 22:08:51 INFO - "platform": "ubuntu64_hw", 22:08:51 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 22:08:51 INFO - "slavebuilddir": "test", 22:08:51 INFO - "taskId": "X_fmLpeMTk-hD8J07J8m0g", 22:08:51 INFO - "branch": "mozilla-central", 22:08:51 INFO - "script_repo_revision": "production", 22:08:51 INFO - "revision": "6a235092bda7c20cb83651d3404284fe36d04c1b", 22:08:51 INFO - "slavename": "talos-linux64-ix-029", 22:08:51 INFO - "repo_path": "mozilla-central" 22:08:51 INFO - } 22:08:51 INFO - Finding installer, test and symbols from parent task. 22:08:51 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/X_fmLpeMTk-hD8J07J8m0g'}, attempt #1 22:08:51 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/X_fmLpeMTk-hD8J07J8m0g'}, attempt #1 22:08:52 INFO - Task dependencies: QjHREwbRSoanfsUt133rMw 22:08:52 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/QjHREwbRSoanfsUt133rMw'}, attempt #1 22:08:52 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/QjHREwbRSoanfsUt133rMw/artifacts/public/build/target.tar.bz2 22:08:52 INFO - Set test_url: https://queue.taskcluster.net/v1/task/QjHREwbRSoanfsUt133rMw/artifacts/public/build/test_packages.json 22:08:52 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/QjHREwbRSoanfsUt133rMw/artifacts/public/build/target.crashreporter-symbols.zip 22:08:52 INFO - Running post-action listener: _resource_record_post_action 22:08:52 INFO - [mozharness: 2017-05-28 05:08:52.868577Z] Finished read-buildbot-config step (success) 22:08:52 INFO - [mozharness: 2017-05-28 05:08:52.868796Z] Running download-and-extract step. 22:08:52 INFO - Running pre-action listener: _resource_record_pre_action 22:08:52 INFO - Running main action method: download_and_extract 22:08:52 INFO - mkdir: /builds/slave/test/build/tests 22:08:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:08:52 INFO - trying https://queue.taskcluster.net/v1/task/QjHREwbRSoanfsUt133rMw/artifacts/public/build/target.test_packages.json 22:08:52 INFO - Downloading https://queue.taskcluster.net/v1/task/QjHREwbRSoanfsUt133rMw/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 22:08:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/QjHREwbRSoanfsUt133rMw/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 22:08:53 INFO - Downloaded 986 bytes. 22:08:53 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 22:08:53 INFO - Using the following test package requirements: 22:08:53 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 22:08:53 INFO - u'common': [u'target.common.tests.zip'], 22:08:53 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 22:08:53 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 22:08:53 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 22:08:53 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 22:08:53 INFO - u'mozbase': [u'target.common.tests.zip'], 22:08:53 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 22:08:53 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 22:08:53 INFO - u'web-platform': [u'target.common.tests.zip', 22:08:53 INFO - u'target.web-platform.tests.zip'], 22:08:53 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 22:08:53 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 22:08:53 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/QjHREwbRSoanfsUt133rMw/artifacts/public/build/target.common.tests.zip 22:08:53 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/QjHREwbRSoanfsUt133rMw/artifacts/public/build/target.common.tests.zip'}, attempt #1 22:08:53 INFO - Fetch https://queue.taskcluster.net/v1/task/QjHREwbRSoanfsUt133rMw/artifacts/public/build/target.common.tests.zip into memory 22:08:55 INFO - Content-Length response header: 63527037 22:08:55 INFO - Bytes received: 63527037 22:09:06 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 22:09:06 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/QjHREwbRSoanfsUt133rMw/artifacts/public/build/target.common.tests.zip 22:09:06 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/QjHREwbRSoanfsUt133rMw/artifacts/public/build/target.common.tests.zip'}, attempt #1 22:09:06 INFO - Fetch https://queue.taskcluster.net/v1/task/QjHREwbRSoanfsUt133rMw/artifacts/public/build/target.common.tests.zip into memory 22:09:07 INFO - Content-Length response header: 63527037 22:09:07 INFO - Bytes received: 63527037 22:09:19 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/QjHREwbRSoanfsUt133rMw/artifacts/public/build/target.talos.tests.zip 22:09:19 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/QjHREwbRSoanfsUt133rMw/artifacts/public/build/target.talos.tests.zip'}, attempt #1 22:09:19 INFO - Fetch https://queue.taskcluster.net/v1/task/QjHREwbRSoanfsUt133rMw/artifacts/public/build/target.talos.tests.zip into memory 22:09:21 INFO - Content-Length response header: 14447425 22:09:21 INFO - Bytes received: 14447425 22:09:21 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')]} 22:09:21 INFO - trying https://queue.taskcluster.net/v1/task/QjHREwbRSoanfsUt133rMw/artifacts/public/build/target.tar.bz2 22:09:21 INFO - Downloading https://queue.taskcluster.net/v1/task/QjHREwbRSoanfsUt133rMw/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 22:09:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/QjHREwbRSoanfsUt133rMw/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 22:09:23 INFO - Downloaded 54251617 bytes. 22:09:23 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/QjHREwbRSoanfsUt133rMw/artifacts/public/build/target.tar.bz2 22:09:23 INFO - mkdir: /builds/slave/test/properties 22:09:23 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 22:09:23 INFO - Writing to file /builds/slave/test/properties/build_url 22:09:23 INFO - Contents: 22:09:23 INFO - build_url:https://queue.taskcluster.net/v1/task/QjHREwbRSoanfsUt133rMw/artifacts/public/build/target.tar.bz2 22:09:23 INFO - Running post-action listener: _resource_record_post_action 22:09:23 INFO - Running post-action listener: set_extra_try_arguments 22:09:23 INFO - [mozharness: 2017-05-28 05:09:23.468459Z] Finished download-and-extract step (success) 22:09:23 INFO - [mozharness: 2017-05-28 05:09:23.468683Z] Running populate-webroot step. 22:09:23 INFO - Running pre-action listener: _resource_record_pre_action 22:09:23 INFO - Running main action method: populate_webroot 22:09:23 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 22:09:23 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 22:09:23 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 22:09:23 INFO - '--tppagecycles', 22:09:23 INFO - '7'], 22:09:23 INFO - 'tests': ['tsvgm']}}, 22:09:23 INFO - 'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 22:09:23 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 22:09:23 INFO - 'tests': ['dromaeo_css', 'kraken']}, 22:09:23 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 22:09:23 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 22:09:23 INFO - 'talos_options': ['--disable-e10s'], 22:09:23 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 22:09:23 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 22:09:23 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 22:09:23 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 22:09:23 INFO - 'talos_options': ['--disable-e10s'], 22:09:23 INFO - 'tests': ['damp', 'tps']}, 22:09:23 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 22:09:23 INFO - 'tests': ['damp', 'tps']}, 22:09:23 INFO - 'g3': {'talos_options': ['--disable-e10s'], 22:09:23 INFO - 'tests': ['dromaeo_dom']}, 22:09:23 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 22:09:23 INFO - 'g4': {'talos_options': ['--disable-e10s'], 22:09:23 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 22:09:23 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 22:09:23 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 22:09:23 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 22:09:23 INFO - 'other': {'talos_options': ['--disable-e10s'], 22:09:23 INFO - 'tests': ['a11yr', 22:09:23 INFO - 'ts_paint', 22:09:23 INFO - 'tpaint', 22:09:23 INFO - 'sessionrestore', 22:09:23 INFO - 'sessionrestore_no_auto_restore', 22:09:23 INFO - 'tabpaint']}, 22:09:23 INFO - 'other-e10s': {'tests': ['a11yr', 22:09:23 INFO - 'ts_paint', 22:09:23 INFO - 'tpaint', 22:09:23 INFO - 'sessionrestore', 22:09:23 INFO - 'sessionrestore_no_auto_restore', 22:09:23 INFO - 'tabpaint']}, 22:09:23 INFO - 'other-e10s_l64': {'tests': ['a11yr', 22:09:23 INFO - 'ts_paint', 22:09:23 INFO - 'tpaint', 22:09:23 INFO - 'sessionrestore', 22:09:23 INFO - 'sessionrestore_no_auto_restore', 22:09:23 INFO - 'tabpaint']}, 22:09:23 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 22:09:23 INFO - 'ts_paint', 22:09:23 INFO - 'tpaint', 22:09:23 INFO - 'sessionrestore', 22:09:23 INFO - 'sessionrestore_no_auto_restore', 22:09:23 INFO - 'tabpaint']}, 22:09:23 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 22:09:23 INFO - 'tests': ['a11yr', 22:09:23 INFO - 'ts_paint', 22:09:23 INFO - 'tpaint', 22:09:23 INFO - 'sessionrestore', 22:09:23 INFO - 'sessionrestore_no_auto_restore', 22:09:23 INFO - 'tabpaint']}, 22:09:23 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 22:09:23 INFO - 'tests': ['a11yr', 22:09:23 INFO - 'ts_paint', 22:09:23 INFO - 'tpaint', 22:09:23 INFO - 'sessionrestore', 22:09:23 INFO - 'sessionrestore_no_auto_restore', 22:09:23 INFO - 'tabpaint']}, 22:09:23 INFO - 'perf-reftest': {'tests': ['bloom_basic', 'bloom_basic_ref']}, 22:09:23 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic', 22:09:23 INFO - 'bloom_basic_ref']}, 22:09:23 INFO - 'quantum-pageload-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set.zip', 22:09:23 INFO - 'talos_options': ['--mitmproxy', 22:09:23 INFO - 'mitmproxy-recording-1.mp', 22:09:23 INFO - '--firstNonBlankPaint'], 22:09:23 INFO - 'tests': ['Quantum_1']}, 22:09:23 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 22:09:23 INFO - 'tests': ['tsvgx', 22:09:23 INFO - 'tsvgr_opacity', 22:09:23 INFO - 'tart', 22:09:23 INFO - 'tscrollx', 22:09:23 INFO - 'cart', 22:09:23 INFO - 'tsvg_static']}, 22:09:23 INFO - 'svgr-e10s': {'tests': ['tsvgx', 22:09:23 INFO - 'tsvgr_opacity', 22:09:23 INFO - 'tart', 22:09:23 INFO - 'tscrollx', 22:09:23 INFO - 'cart', 22:09:23 INFO - 'tsvg_static']}, 22:09:23 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 22:09:23 INFO - 'talos_options': ['--disable-e10s'], 22:09:23 INFO - 'tests': ['tp5o']}, 22:09:23 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 22:09:23 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 22:09:23 INFO - 'talos_options': ['--disable-e10s', 22:09:23 INFO - '--xperf_path', 22:09:23 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 22:09:23 INFO - 'tests': ['tp5n']}, 22:09:23 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 22:09:23 INFO - 'talos_options': ['--xperf_path', 22:09:23 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 22:09:23 INFO - 'tests': ['tp5n']}}, 22:09:23 INFO - 'talos.zip': {'path': '', 22:09:23 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 22:09:23 INFO - Running post-action listener: _resource_record_post_action 22:09:23 INFO - [mozharness: 2017-05-28 05:09:23.487005Z] Finished populate-webroot step (success) 22:09:23 INFO - [mozharness: 2017-05-28 05:09:23.487099Z] Running create-virtualenv step. 22:09:23 INFO - Running pre-action listener: _resource_record_pre_action 22:09:23 INFO - Running main action method: create_virtualenv 22:09:23 INFO - Creating virtualenv /builds/slave/test/build/venv 22:09:23 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 22:09:23 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 22:09:23 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 22:09:23 INFO - Using real prefix '/usr' 22:09:23 INFO - New python executable in /builds/slave/test/build/venv/bin/python 22:09:24 INFO - Installing distribute.............................................................................................................................................................................................done. 22:09:26 INFO - Installing pip.................done. 22:09:26 INFO - Return code: 0 22:09:26 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 22:09:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 22:09:26 INFO - Reading from file tmpfile_stdout 22:09:26 INFO - Output received: 22:09:26 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) 22:09:26 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 22:09:26 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')]} 22:09:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:09:26 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')]} 22:09:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:09:26 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 0x26183b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27f2a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2995ef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2992e40>, '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 0x2993fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2994440>, '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': 'ba164b0a7b0ec7655860e956000001c1-1495938088.707465-1433112007', '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 22:09:26 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 22:09:26 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 22:09:26 INFO - Using env: {'DISPLAY': ':0', 22:09:26 INFO - 'HOME': '/home/cltbld', 22:09:26 INFO - 'LANG': 'en_US.UTF-8', 22:09:26 INFO - 'LANGUAGE': 'en_US:en', 22:09:26 INFO - 'LOGNAME': 'cltbld', 22:09:26 INFO - 'MAIL': '/var/mail/cltbld', 22:09:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:09:26 INFO - 'MOZ_NO_REMOTE': '1', 22:09:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:09:26 INFO - 'NO_EM_RESTART': '1', 22:09:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:09:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:09:26 INFO - 'PWD': '/builds/slave/test', 22:09:26 INFO - 'SHELL': '/bin/bash', 22:09:26 INFO - 'SHLVL': '1', 22:09:26 INFO - 'TERM': 'linux', 22:09:26 INFO - 'TMOUT': '86400', 22:09:26 INFO - 'USER': 'cltbld', 22:09:26 INFO - 'XDG_SESSION_COOKIE': 'ba164b0a7b0ec7655860e956000001c1-1495938088.707465-1433112007', 22:09:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:09:26 INFO - '_': '/tools/buildbot/bin/python'} 22:09:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:09:26 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 22:09:26 INFO - Cleaning up... 22:09:26 INFO - Return code: 0 22:09:26 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 22:09:26 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')]} 22:09:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:09:26 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')]} 22:09:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:09:26 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 0x26183b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27f2a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2995ef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2992e40>, '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 0x2993fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2994440>, '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': 'ba164b0a7b0ec7655860e956000001c1-1495938088.707465-1433112007', '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 22:09:26 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 22:09:26 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 22:09:26 INFO - Using env: {'DISPLAY': ':0', 22:09:26 INFO - 'HOME': '/home/cltbld', 22:09:26 INFO - 'LANG': 'en_US.UTF-8', 22:09:26 INFO - 'LANGUAGE': 'en_US:en', 22:09:26 INFO - 'LOGNAME': 'cltbld', 22:09:26 INFO - 'MAIL': '/var/mail/cltbld', 22:09:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:09:26 INFO - 'MOZ_NO_REMOTE': '1', 22:09:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:09:26 INFO - 'NO_EM_RESTART': '1', 22:09:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:09:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:09:26 INFO - 'PWD': '/builds/slave/test', 22:09:26 INFO - 'SHELL': '/bin/bash', 22:09:26 INFO - 'SHLVL': '1', 22:09:26 INFO - 'TERM': 'linux', 22:09:26 INFO - 'TMOUT': '86400', 22:09:26 INFO - 'USER': 'cltbld', 22:09:26 INFO - 'XDG_SESSION_COOKIE': 'ba164b0a7b0ec7655860e956000001c1-1495938088.707465-1433112007', 22:09:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:09:26 INFO - '_': '/tools/buildbot/bin/python'} 22:09:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:09:26 INFO - Downloading/unpacking psutil>=3.1.1 22:09:26 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 22:09:26 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 22:09:26 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 22:09:26 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 22:09:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 22:09:27 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 22:09:27 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 22:09:28 INFO - Installing collected packages: psutil 22:09:28 INFO - Running setup.py install for psutil 22:09:28 INFO - building 'psutil._psutil_linux' extension 22:09:28 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 22:09:28 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 22:09:28 INFO - building 'psutil._psutil_posix' extension 22:09:28 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 22:09:28 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 22:09:28 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 22:09:28 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 22:09:28 INFO - Successfully installed psutil 22:09:28 INFO - Cleaning up... 22:09:28 INFO - Return code: 0 22:09:28 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 22:09:28 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')]} 22:09:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:09:28 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')]} 22:09:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:09:28 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 0x26183b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27f2a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2995ef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2992e40>, '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 0x2993fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2994440>, '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': 'ba164b0a7b0ec7655860e956000001c1-1495938088.707465-1433112007', '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 22:09:28 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 22:09:28 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 22:09:28 INFO - Using env: {'DISPLAY': ':0', 22:09:28 INFO - 'HOME': '/home/cltbld', 22:09:28 INFO - 'LANG': 'en_US.UTF-8', 22:09:28 INFO - 'LANGUAGE': 'en_US:en', 22:09:28 INFO - 'LOGNAME': 'cltbld', 22:09:28 INFO - 'MAIL': '/var/mail/cltbld', 22:09:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:09:28 INFO - 'MOZ_NO_REMOTE': '1', 22:09:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:09:28 INFO - 'NO_EM_RESTART': '1', 22:09:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:09:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:09:28 INFO - 'PWD': '/builds/slave/test', 22:09:28 INFO - 'SHELL': '/bin/bash', 22:09:28 INFO - 'SHLVL': '1', 22:09:28 INFO - 'TERM': 'linux', 22:09:28 INFO - 'TMOUT': '86400', 22:09:28 INFO - 'USER': 'cltbld', 22:09:28 INFO - 'XDG_SESSION_COOKIE': 'ba164b0a7b0ec7655860e956000001c1-1495938088.707465-1433112007', 22:09:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:09:28 INFO - '_': '/tools/buildbot/bin/python'} 22:09:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:09:28 INFO - Downloading/unpacking mozsystemmonitor==0.3 22:09:28 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 22:09:28 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 22:09:28 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 22:09:28 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 22:09:29 INFO - Downloading mozsystemmonitor-0.3.tar.gz 22:09:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 22:09:29 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 22:09:29 INFO - Installing collected packages: mozsystemmonitor 22:09:29 INFO - Running setup.py install for mozsystemmonitor 22:09:30 INFO - Successfully installed mozsystemmonitor 22:09:30 INFO - Cleaning up... 22:09:30 INFO - Return code: 0 22:09:30 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 22:09: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')]} 22:09:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:09: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')]} 22:09:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:09: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', '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 0x26183b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27f2a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2995ef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2992e40>, '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 0x2993fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2994440>, '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': 'ba164b0a7b0ec7655860e956000001c1-1495938088.707465-1433112007', '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 22:09: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', 'jsonschema==2.5.1'] in /builds/slave/test/build 22:09: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 jsonschema==2.5.1 22:09:30 INFO - Using env: {'DISPLAY': ':0', 22:09:30 INFO - 'HOME': '/home/cltbld', 22:09:30 INFO - 'LANG': 'en_US.UTF-8', 22:09:30 INFO - 'LANGUAGE': 'en_US:en', 22:09:30 INFO - 'LOGNAME': 'cltbld', 22:09:30 INFO - 'MAIL': '/var/mail/cltbld', 22:09:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:09:30 INFO - 'MOZ_NO_REMOTE': '1', 22:09:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:09:30 INFO - 'NO_EM_RESTART': '1', 22:09:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:09:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:09:30 INFO - 'PWD': '/builds/slave/test', 22:09:30 INFO - 'SHELL': '/bin/bash', 22:09:30 INFO - 'SHLVL': '1', 22:09:30 INFO - 'TERM': 'linux', 22:09:30 INFO - 'TMOUT': '86400', 22:09:30 INFO - 'USER': 'cltbld', 22:09:30 INFO - 'XDG_SESSION_COOKIE': 'ba164b0a7b0ec7655860e956000001c1-1495938088.707465-1433112007', 22:09:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:09:30 INFO - '_': '/tools/buildbot/bin/python'} 22:09:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:09:30 INFO - Downloading/unpacking jsonschema==2.5.1 22:09:30 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 22:09:30 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 22:09:30 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 22:09:30 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 22:09:31 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 22:09:31 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 22:09: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 22:09: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 22:09: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 22:09: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 22:09:31 INFO - Downloading functools32-3.2.3-2.tar.gz 22:09:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 22:09:31 INFO - warning: no files found matching '*.txt' 22:09:31 INFO - no previously-included directories found matching 'build' 22:09:31 INFO - no previously-included directories found matching 'dist' 22:09:31 INFO - no previously-included directories found matching '.git*' 22:09:31 INFO - Installing collected packages: jsonschema, functools32 22:09:31 INFO - Running setup.py install for functools32 22:09:31 INFO - warning: no files found matching '*.txt' 22:09:31 INFO - no previously-included directories found matching 'build' 22:09:31 INFO - no previously-included directories found matching 'dist' 22:09:31 INFO - no previously-included directories found matching '.git*' 22:09:31 INFO - Successfully installed jsonschema functools32 22:09:31 INFO - Cleaning up... 22:09:31 INFO - Return code: 0 22:09:31 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 22:09: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')]} 22:09:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:09: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')]} 22:09:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:09: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', '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 0x26183b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27f2a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2995ef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2992e40>, '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 0x2993fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2994440>, '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': 'ba164b0a7b0ec7655860e956000001c1-1495938088.707465-1433112007', '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 22:09: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', 'functools32==3.2.3-2'] in /builds/slave/test/build 22:09: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 functools32==3.2.3-2 22:09:31 INFO - Using env: {'DISPLAY': ':0', 22:09:31 INFO - 'HOME': '/home/cltbld', 22:09:31 INFO - 'LANG': 'en_US.UTF-8', 22:09:31 INFO - 'LANGUAGE': 'en_US:en', 22:09:31 INFO - 'LOGNAME': 'cltbld', 22:09:31 INFO - 'MAIL': '/var/mail/cltbld', 22:09:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:09:31 INFO - 'MOZ_NO_REMOTE': '1', 22:09:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:09:31 INFO - 'NO_EM_RESTART': '1', 22:09:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:09:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:09:31 INFO - 'PWD': '/builds/slave/test', 22:09:31 INFO - 'SHELL': '/bin/bash', 22:09:31 INFO - 'SHLVL': '1', 22:09:31 INFO - 'TERM': 'linux', 22:09:31 INFO - 'TMOUT': '86400', 22:09:31 INFO - 'USER': 'cltbld', 22:09:31 INFO - 'XDG_SESSION_COOKIE': 'ba164b0a7b0ec7655860e956000001c1-1495938088.707465-1433112007', 22:09:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:09:31 INFO - '_': '/tools/buildbot/bin/python'} 22:09:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:09:31 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 22:09:31 INFO - Cleaning up... 22:09:31 INFO - Return code: 0 22:09:31 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 22:09: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')]} 22:09:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:09: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')]} 22:09:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:09: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', '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 0x26183b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27f2a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2995ef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2992e40>, '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 0x2993fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2994440>, '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': 'ba164b0a7b0ec7655860e956000001c1-1495938088.707465-1433112007', '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 22:09: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 22:09: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 blobuploader==1.2.4 22:09:31 INFO - Using env: {'DISPLAY': ':0', 22:09:31 INFO - 'HOME': '/home/cltbld', 22:09:31 INFO - 'LANG': 'en_US.UTF-8', 22:09:31 INFO - 'LANGUAGE': 'en_US:en', 22:09:31 INFO - 'LOGNAME': 'cltbld', 22:09:31 INFO - 'MAIL': '/var/mail/cltbld', 22:09:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:09:31 INFO - 'MOZ_NO_REMOTE': '1', 22:09:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:09:31 INFO - 'NO_EM_RESTART': '1', 22:09:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:09:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:09:31 INFO - 'PWD': '/builds/slave/test', 22:09:31 INFO - 'SHELL': '/bin/bash', 22:09:31 INFO - 'SHLVL': '1', 22:09:31 INFO - 'TERM': 'linux', 22:09:31 INFO - 'TMOUT': '86400', 22:09:31 INFO - 'USER': 'cltbld', 22:09:31 INFO - 'XDG_SESSION_COOKIE': 'ba164b0a7b0ec7655860e956000001c1-1495938088.707465-1433112007', 22:09:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:09:31 INFO - '_': '/tools/buildbot/bin/python'} 22:09:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:09:32 INFO - Downloading/unpacking blobuploader==1.2.4 22:09:32 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 22:09:32 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 22:09:32 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 22:09:32 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 22:09:33 INFO - Downloading blobuploader-1.2.4.tar.gz 22:09:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 22:09:33 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 22:09: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 22:09: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 22:09: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 22:09: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 22:09:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 22:09:33 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 22:09: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 22:09: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 22:09: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 22:09: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 22:09:33 INFO - Downloading docopt-0.6.1.tar.gz 22:09:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 22:09:33 INFO - Installing collected packages: blobuploader, requests, docopt 22:09:33 INFO - Running setup.py install for blobuploader 22:09:33 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 22:09:33 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 22:09:33 INFO - Running setup.py install for requests 22:09:34 INFO - Running setup.py install for docopt 22:09:34 INFO - Successfully installed blobuploader requests docopt 22:09:34 INFO - Cleaning up... 22:09:34 INFO - Return code: 0 22:09:34 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:09: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')]} 22:09:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:09: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')]} 22:09:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:09:34 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 0x26183b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27f2a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2995ef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2992e40>, '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 0x2993fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2994440>, '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': 'ba164b0a7b0ec7655860e956000001c1-1495938088.707465-1433112007', '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 22:09:34 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 22:09:34 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 22:09:34 INFO - Using env: {'DISPLAY': ':0', 22:09:34 INFO - 'HOME': '/home/cltbld', 22:09:34 INFO - 'LANG': 'en_US.UTF-8', 22:09:34 INFO - 'LANGUAGE': 'en_US:en', 22:09:34 INFO - 'LOGNAME': 'cltbld', 22:09:34 INFO - 'MAIL': '/var/mail/cltbld', 22:09:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:09:34 INFO - 'MOZ_NO_REMOTE': '1', 22:09:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:09:34 INFO - 'NO_EM_RESTART': '1', 22:09:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:09:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:09:34 INFO - 'PWD': '/builds/slave/test', 22:09:34 INFO - 'SHELL': '/bin/bash', 22:09:34 INFO - 'SHLVL': '1', 22:09:34 INFO - 'TERM': 'linux', 22:09:34 INFO - 'TMOUT': '86400', 22:09:34 INFO - 'USER': 'cltbld', 22:09:34 INFO - 'XDG_SESSION_COOKIE': 'ba164b0a7b0ec7655860e956000001c1-1495938088.707465-1433112007', 22:09:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:09:34 INFO - '_': '/tools/buildbot/bin/python'} 22:09:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:09:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 22:09:34 INFO - Running setup.py (path:/tmp/pip-13iMuI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 22:09:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 22:09:34 INFO - Running setup.py (path:/tmp/pip-ywAhEH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 22:09:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 22:09:34 INFO - Running setup.py (path:/tmp/pip-LaTddV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 22:09:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 22:09:34 INFO - Running setup.py (path:/tmp/pip-hAe097-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 22:09:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 22:09:34 INFO - Running setup.py (path:/tmp/pip-Jdzysz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 22:09:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 22:09:34 INFO - Running setup.py (path:/tmp/pip-9gV1rL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 22:09:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 22:09:35 INFO - Running setup.py (path:/tmp/pip-WOlk1d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 22:09:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 22:09:35 INFO - Running setup.py (path:/tmp/pip-vCmmO5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 22:09:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 22:09:35 INFO - Running setup.py (path:/tmp/pip-NYyDo_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 22:09:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 22:09:35 INFO - Running setup.py (path:/tmp/pip-CxMo4L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 22:09:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 22:09:35 INFO - Running setup.py (path:/tmp/pip-jiWNib-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 22:09:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 22:09:35 INFO - Running setup.py (path:/tmp/pip-lyGTs2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 22:09:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 22:09:35 INFO - Running setup.py (path:/tmp/pip-uI1vhB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 22:09:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 22:09:35 INFO - Running setup.py (path:/tmp/pip-7WMz0s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 22:09:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 22:09:35 INFO - Running setup.py (path:/tmp/pip-VVVfC5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 22:09:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 22:09:35 INFO - Running setup.py (path:/tmp/pip-I66Ooi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 22:09:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 22:09:35 INFO - Running setup.py (path:/tmp/pip-dKjcUn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 22:09:35 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 22:09:35 INFO - Running setup.py install for manifestparser 22:09:35 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 22:09:35 INFO - Running setup.py install for mozcrash 22:09:36 INFO - Running setup.py install for mozdebug 22:09:36 INFO - Running setup.py install for mozdevice 22:09:36 INFO - Installing dm script to /builds/slave/test/build/venv/bin 22:09:36 INFO - Running setup.py install for mozfile 22:09:36 INFO - Running setup.py install for mozhttpd 22:09:36 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 22:09:36 INFO - Running setup.py install for mozinfo 22:09:36 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 22:09:36 INFO - Running setup.py install for mozInstall 22:09:36 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 22:09:36 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 22:09:36 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 22:09:36 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 22:09:36 INFO - Running setup.py install for mozleak 22:09:36 INFO - Running setup.py install for mozlog 22:09:36 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 22:09:36 INFO - Running setup.py install for moznetwork 22:09:36 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 22:09:36 INFO - Running setup.py install for mozprocess 22:09:37 INFO - Running setup.py install for mozprofile 22:09:37 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 22:09:37 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 22:09:37 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 22:09:37 INFO - Running setup.py install for mozrunner 22:09:37 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 22:09:37 INFO - Running setup.py install for mozscreenshot 22:09:37 INFO - Running setup.py install for moztest 22:09:37 INFO - Running setup.py install for mozversion 22:09:37 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 22:09:37 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 22:09:37 INFO - Cleaning up... 22:09:37 INFO - Return code: 0 22:09:37 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:09:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:09:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:09:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:09:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:09:37 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 0x26183b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27f2a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2995ef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2992e40>, '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 0x2993fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2994440>, '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': 'ba164b0a7b0ec7655860e956000001c1-1495938088.707465-1433112007', '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 22:09:37 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 22:09:37 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 22:09:37 INFO - Using env: {'DISPLAY': ':0', 22:09:37 INFO - 'HOME': '/home/cltbld', 22:09:37 INFO - 'LANG': 'en_US.UTF-8', 22:09:37 INFO - 'LANGUAGE': 'en_US:en', 22:09:37 INFO - 'LOGNAME': 'cltbld', 22:09:37 INFO - 'MAIL': '/var/mail/cltbld', 22:09:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:09:37 INFO - 'MOZ_NO_REMOTE': '1', 22:09:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:09:37 INFO - 'NO_EM_RESTART': '1', 22:09:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:09:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:09:37 INFO - 'PWD': '/builds/slave/test', 22:09:37 INFO - 'SHELL': '/bin/bash', 22:09:37 INFO - 'SHLVL': '1', 22:09:37 INFO - 'TERM': 'linux', 22:09:37 INFO - 'TMOUT': '86400', 22:09:37 INFO - 'USER': 'cltbld', 22:09:37 INFO - 'XDG_SESSION_COOKIE': 'ba164b0a7b0ec7655860e956000001c1-1495938088.707465-1433112007', 22:09:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:09:37 INFO - '_': '/tools/buildbot/bin/python'} 22:09:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:09:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 22:09:37 INFO - Running setup.py (path:/tmp/pip-Hy81sa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 22:09:37 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)) 22:09:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 22:09:37 INFO - Running setup.py (path:/tmp/pip-SIsXBg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 22:09:38 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)) 22:09:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 22:09:38 INFO - Running setup.py (path:/tmp/pip-IN1gC0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 22:09:38 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)) 22:09:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 22:09:38 INFO - Running setup.py (path:/tmp/pip-8OZ_ee-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 22:09:38 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)) 22:09:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 22:09:38 INFO - Running setup.py (path:/tmp/pip-gD_mub-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 22:09:38 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)) 22:09:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 22:09:38 INFO - Running setup.py (path:/tmp/pip-FK1ksv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 22:09:38 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)) 22:09:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 22:09:38 INFO - Running setup.py (path:/tmp/pip-KUktb4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 22:09:38 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)) 22:09:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 22:09:38 INFO - Running setup.py (path:/tmp/pip-_sccxe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 22:09:38 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)) 22:09:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 22:09:38 INFO - Running setup.py (path:/tmp/pip-juzKdq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 22:09:38 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)) 22:09:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 22:09:38 INFO - Running setup.py (path:/tmp/pip-Jm4y0D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 22:09:38 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)) 22:09:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 22:09:38 INFO - Running setup.py (path:/tmp/pip-TolyGi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 22:09:38 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)) 22:09:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 22:09:38 INFO - Running setup.py (path:/tmp/pip-osdpos-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 22:09:38 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)) 22:09:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 22:09:38 INFO - Running setup.py (path:/tmp/pip-t2zm4o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 22:09:38 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)) 22:09:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 22:09:38 INFO - Running setup.py (path:/tmp/pip-5E1dMy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 22:09:38 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)) 22:09:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 22:09:38 INFO - Running setup.py (path:/tmp/pip-VIKEEB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 22:09:38 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)) 22:09:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 22:09:38 INFO - Running setup.py (path:/tmp/pip-dF6pTq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 22:09:39 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)) 22:09:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 22:09:39 INFO - Running setup.py (path:/tmp/pip-Sj2uBo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 22:09:39 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)) 22:09:39 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)) 22:09:39 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)) 22:09:39 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)) 22:09:39 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)) 22:09:39 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)) 22:09:39 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 22:09:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:09:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:09:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:09:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:09:40 INFO - Downloading blessings-1.6.tar.gz 22:09:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 22:09:40 INFO - Installing collected packages: blessings 22:09:40 INFO - Running setup.py install for blessings 22:09:40 INFO - Successfully installed blessings 22:09:40 INFO - Cleaning up... 22:09:40 INFO - Return code: 0 22:09:40 INFO - Done creating virtualenv /builds/slave/test/build/venv. 22:09:40 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 22:09:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 22:09:40 INFO - Reading from file tmpfile_stdout 22:09:40 INFO - Current package versions: 22:09:40 INFO - argparse == 1.2.1 22:09:40 INFO - blessings == 1.6 22:09:40 INFO - blobuploader == 1.2.4 22:09:40 INFO - docopt == 0.6.1 22:09:40 INFO - functools32 == 3.2.3-2 22:09:40 INFO - jsonschema == 2.5.1 22:09:40 INFO - manifestparser == 1.1 22:09:40 INFO - mozInstall == 1.12 22:09:40 INFO - mozcrash == 1.0 22:09:40 INFO - mozdebug == 0.1 22:09:40 INFO - mozdevice == 0.51 22:09:40 INFO - mozfile == 1.2 22:09:40 INFO - mozhttpd == 0.7 22:09:40 INFO - mozinfo == 0.9 22:09:40 INFO - mozleak == 0.1 22:09:40 INFO - mozlog == 3.4 22:09:40 INFO - moznetwork == 0.27 22:09:40 INFO - mozprocess == 0.25 22:09:40 INFO - mozprofile == 0.28 22:09:40 INFO - mozrunner == 6.13 22:09:40 INFO - mozscreenshot == 0.1 22:09:40 INFO - mozsystemmonitor == 0.3 22:09:40 INFO - moztest == 0.8 22:09:40 INFO - mozversion == 1.4 22:09:40 INFO - psutil == 3.1.1 22:09:40 INFO - requests == 1.2.3 22:09:40 INFO - wsgiref == 0.1.2 22:09:40 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:09:40 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')]} 22:09:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:09:40 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')]} 22:09:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:09:40 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 0x26183b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27f2a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2995ef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2992e40>, '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 0x2993fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2994440>, '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': 'ba164b0a7b0ec7655860e956000001c1-1495938088.707465-1433112007', '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 22:09:40 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 22:09:40 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 22:09:40 INFO - Using env: {'DISPLAY': ':0', 22:09:40 INFO - 'HOME': '/home/cltbld', 22:09:40 INFO - 'LANG': 'en_US.UTF-8', 22:09:40 INFO - 'LANGUAGE': 'en_US:en', 22:09:40 INFO - 'LOGNAME': 'cltbld', 22:09:40 INFO - 'MAIL': '/var/mail/cltbld', 22:09:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:09:40 INFO - 'MOZ_NO_REMOTE': '1', 22:09:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:09:40 INFO - 'NO_EM_RESTART': '1', 22:09:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:09:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:09:40 INFO - 'PWD': '/builds/slave/test', 22:09:40 INFO - 'SHELL': '/bin/bash', 22:09:40 INFO - 'SHLVL': '1', 22:09:40 INFO - 'TERM': 'linux', 22:09:40 INFO - 'TMOUT': '86400', 22:09:40 INFO - 'USER': 'cltbld', 22:09:40 INFO - 'XDG_SESSION_COOKIE': 'ba164b0a7b0ec7655860e956000001c1-1495938088.707465-1433112007', 22:09:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:09:40 INFO - '_': '/tools/buildbot/bin/python'} 22:09:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:09:40 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)) 22:09:40 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)) 22:09:40 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)) 22:09:40 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)) 22:09:40 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)) 22:09:40 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)) 22:09:40 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)) 22:09:40 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)) 22:09:40 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)) 22:09:40 INFO - Downloading/unpacking marionette-driver>=1.4.0 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 22:09:40 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 22:09:40 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 22:09:40 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 22:09:40 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 22:09:41 INFO - Downloading marionette_driver-1.4.0.tar.gz 22:09:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/marionette-driver/setup.py) egg_info for package marionette-driver 22:09:42 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)) 22:09:42 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)) 22:09:42 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)) 22:09:42 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)) 22:09:42 INFO - Installing collected packages: marionette-driver 22:09:42 INFO - Running setup.py install for marionette-driver 22:09:42 INFO - Successfully installed marionette-driver 22:09:42 INFO - Cleaning up... 22:09:42 INFO - Return code: 0 22:09:42 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 22:09: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')]} 22:09:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:09: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')]} 22:09:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:09:42 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 0x26183b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27f2a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2995ef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2992e40>, '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 0x2993fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2994440>, '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': 'ba164b0a7b0ec7655860e956000001c1-1495938088.707465-1433112007', '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 22:09:42 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 22:09:42 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 22:09:42 INFO - Using env: {'DISPLAY': ':0', 22:09:42 INFO - 'HOME': '/home/cltbld', 22:09:42 INFO - 'LANG': 'en_US.UTF-8', 22:09:42 INFO - 'LANGUAGE': 'en_US:en', 22:09:42 INFO - 'LOGNAME': 'cltbld', 22:09:42 INFO - 'MAIL': '/var/mail/cltbld', 22:09:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:09:42 INFO - 'MOZ_NO_REMOTE': '1', 22:09:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:09:42 INFO - 'NO_EM_RESTART': '1', 22:09:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:09:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:09:42 INFO - 'PWD': '/builds/slave/test', 22:09:42 INFO - 'SHELL': '/bin/bash', 22:09:42 INFO - 'SHLVL': '1', 22:09:42 INFO - 'TERM': 'linux', 22:09:42 INFO - 'TMOUT': '86400', 22:09:42 INFO - 'USER': 'cltbld', 22:09:42 INFO - 'XDG_SESSION_COOKIE': 'ba164b0a7b0ec7655860e956000001c1-1495938088.707465-1433112007', 22:09:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:09:42 INFO - '_': '/tools/buildbot/bin/python'} 22:09:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:09:42 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 22:09:42 INFO - Cleaning up... 22:09:42 INFO - Return code: 0 22:09:42 INFO - Running post-action listener: _resource_record_post_action 22:09:42 INFO - Running post-action listener: _start_resource_monitoring 22:09:42 INFO - Starting resource monitoring. 22:09:42 INFO - [mozharness: 2017-05-28 05:09:42.448172Z] Finished create-virtualenv step (success) 22:09:42 INFO - [mozharness: 2017-05-28 05:09:42.448653Z] Running install step. 22:09:42 INFO - Running pre-action listener: _resource_record_pre_action 22:09:42 INFO - Running main action method: install 22:09:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 22:09:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 22:09:42 INFO - Reading from file tmpfile_stdout 22:09:42 INFO - Detecting whether we're running mozinstall >=1.0... 22:09:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 22:09:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 22:09:42 INFO - Reading from file tmpfile_stdout 22:09:42 INFO - Output received: 22:09:42 INFO - Usage: mozinstall [options] installer 22:09:42 INFO - Options: 22:09:42 INFO - -h, --help show this help message and exit 22:09:42 INFO - -d DEST, --destination=DEST 22:09:42 INFO - Directory to install application into. [default: 22:09:42 INFO - "/builds/slave/test"] 22:09:42 INFO - --app=APP Application being installed. [default: firefox] 22:09:42 INFO - mkdir: /builds/slave/test/build/application 22:09:42 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'] 22:09:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 22:09:59 INFO - Reading from file tmpfile_stdout 22:09:59 INFO - Output received: 22:09:59 INFO - /builds/slave/test/build/application/firefox/firefox 22:09:59 INFO - Running post-action listener: _resource_record_post_action 22:09:59 INFO - [mozharness: 2017-05-28 05:09:59.080559Z] Finished install step (success) 22:09:59 INFO - [mozharness: 2017-05-28 05:09:59.080838Z] Running setup-mitmproxy step. 22:09:59 INFO - Running pre-action listener: _resource_record_pre_action 22:09:59 INFO - Running main action method: setup_mitmproxy 22:09:59 INFO - Skipping: mitmproxy is not required 22:09:59 INFO - Running post-action listener: _resource_record_post_action 22:09:59 INFO - [mozharness: 2017-05-28 05:09:59.081974Z] Finished setup-mitmproxy step (success) 22:09:59 INFO - [mozharness: 2017-05-28 05:09:59.082194Z] Running run-tests step. 22:09:59 INFO - Running pre-action listener: _resource_record_pre_action 22:09:59 INFO - Running main action method: run_tests 22:09:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 22:09:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 22:09:59 INFO - Python 2.7.3 22:09:59 INFO - Return code: 0 22:09:59 INFO - grabbing minidump binary from tooltool 22:09:59 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')]} 22:09:59 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 0x2992e40>, '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 0x2993fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2994440>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 22:09:59 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 22:09:59 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 22:09:59 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 22:09:59 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 22:09:59 INFO - Return code: 0 22:09:59 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 22:09:59 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 22:09:59 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 22:09:59 INFO - ENV: RUST_BACKTRACE is now 1 22:09:59 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 22:09:59 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 22:09:59 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/QjHREwbRSoanfsUt133rMw/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-029', '--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 22:09:59 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/QjHREwbRSoanfsUt133rMw/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-029 --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 22:09:59 INFO - Using env: {'DISPLAY': ':0', 22:09:59 INFO - 'HOME': '/home/cltbld', 22:09:59 INFO - 'LANG': 'en_US.UTF-8', 22:09:59 INFO - 'LANGUAGE': 'en_US:en', 22:09:59 INFO - 'LOGNAME': 'cltbld', 22:09:59 INFO - 'MAIL': '/var/mail/cltbld', 22:09:59 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 22:09:59 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 22:09:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:09:59 INFO - 'MOZ_NO_REMOTE': '1', 22:09:59 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 22:09:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:09:59 INFO - 'NO_EM_RESTART': '1', 22:09:59 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:09:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:09:59 INFO - 'PWD': '/builds/slave/test', 22:09:59 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 22:09:59 INFO - 'RUST_BACKTRACE': '1', 22:09:59 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 22:09:59 INFO - 'SHELL': '/bin/bash', 22:09:59 INFO - 'SHLVL': '1', 22:09:59 INFO - 'TERM': 'linux', 22:09:59 INFO - 'TMOUT': '86400', 22:09:59 INFO - 'USER': 'cltbld', 22:09:59 INFO - 'XDG_SESSION_COOKIE': 'ba164b0a7b0ec7655860e956000001c1-1495938088.707465-1433112007', 22:09:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:09:59 INFO - '_': '/tools/buildbot/bin/python'} 22:09:59 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/QjHREwbRSoanfsUt133rMw/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-029', '--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 22:09:59 INFO - mozversion application_buildid: 20170528043016 22:09:59 INFO - mozversion application_changeset: 6a235092bda7c20cb83651d3404284fe36d04c1b 22:09:59 INFO - mozversion application_display_name: Nightly 22:09:59 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 22:09:59 INFO - mozversion application_name: Firefox 22:09:59 INFO - mozversion application_remotingname: firefox 22:09:59 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 22:09:59 INFO - mozversion application_vendor: Mozilla 22:09:59 INFO - mozversion application_version: 55.0a1 22:09:59 INFO - mozversion platform_buildid: 20170528043016 22:09:59 INFO - mozversion platform_changeset: 6a235092bda7c20cb83651d3404284fe36d04c1b 22:09:59 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 22:09:59 INFO - mozversion platform_version: 55.0a1 22:09:59 INFO - using testdate: 1495948199 22:09:59 INFO - actual date: 1495948199 22:09:59 INFO - starting webserver on 'localhost:34289' 22:09:59 INFO - SUITE-START | Running 2 tests 22:09:59 INFO - TEST-START | dromaeo_css 22:09:59 INFO - operating with platform_type : linux_ 22:09:59 INFO - Initialising browser for dromaeo_css test... 22:09:59 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:34289/getInfo.html -profile /tmp/tmpJCCXaT/profile 22:09:59 INFO - TEST-INFO | started process 10745 (/builds/slave/test/build/application/firefox/firefox http://localhost:34289/getInfo.html) 22:10:34 INFO - TEST-INFO | 10745: killed by SIGTERM 22:10:34 INFO - Browser initialized. 22:10:34 INFO - Running cycle 1/1 for dromaeo_css test... 22:10:34 INFO - TEST-INFO | started process 10943 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpJCCXaT/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 22:10:46 INFO - PID 10943 | RSS: Main: 182738944 22:10:46 INFO - PID 10943 | 22:13:52 INFO - PID 10943 | Cycle 1(1): loaded http://localhost:34289/tests/dromaeo/cssquery-dojo.html (next: http://localhost:34289/tests/dromaeo/cssquery-ext.html) 22:13:54 INFO - PID 10943 | RSS: Main: 178634752 22:13:54 INFO - PID 10943 | 22:16:56 INFO - PID 10943 | Cycle 1(1): loaded http://localhost:34289/tests/dromaeo/cssquery-ext.html (next: http://localhost:34289/tests/dromaeo/cssquery-jquery.html) 22:16:56 INFO - PID 10943 | RSS: Main: 183386112 22:16:56 INFO - PID 10943 | 22:19:58 INFO - PID 10943 | Cycle 1(1): loaded http://localhost:34289/tests/dromaeo/cssquery-jquery.html (next: http://localhost:34289/tests/dromaeo/cssquery-mootools.html) 22:19:59 INFO - PID 10943 | RSS: Main: 180801536 22:19:59 INFO - PID 10943 | 22:23:00 INFO - PID 10943 | Cycle 1(1): loaded http://localhost:34289/tests/dromaeo/cssquery-mootools.html (next: http://localhost:34289/tests/dromaeo/cssquery-prototype.html) 22:23:01 INFO - PID 10943 | RSS: Main: 184422400 22:23:01 INFO - PID 10943 | 22:26:04 INFO - PID 10943 | Cycle 1(1): loaded http://localhost:34289/tests/dromaeo/cssquery-prototype.html (next: http://localhost:34289/tests/dromaeo/cssquery-yui.html) 22:26:04 INFO - PID 10943 | RSS: Main: 183906304 22:26:04 INFO - PID 10943 | 22:29:06 INFO - PID 10943 | Cycle 1(1): loaded http://localhost:34289/tests/dromaeo/cssquery-yui.html (next: http://localhost:34289/tests/dromaeo/cssquery-dojo.html) 22:29:06 INFO - PID 10943 | RSS: Main: 181071872 22:29:06 INFO - PID 10943 | 22:29:06 INFO - PID 10943 | __start_tp_report 22:29:06 INFO - PID 10943 | _x_x_mozilla_page_load 22:29:06 INFO - PID 10943 | _x_x_mozilla_page_load_details 22:29:06 INFO - PID 10943 | |i|pagename|runs| 22:29:06 INFO - PID 10943 | |0;dojo.html;2682.0612785525063;2730.931726706831;2750.5049091163596;2765.516034693928;2769.9307517312063;5160.948390516094;5239.86900327492;5266.868328291795;5301.6818990860575;5318.069337865877;5249.632525723201;5251.474852514747;5275.393329767078;5374.973125134369;5403.351597808269;4661.557152070565;4679.74261415622;4700.741459219742;4704.835330763415;4740.976295118519;4671.672982891199;4710.97644511777;4731.384919960417;4757.333973243732;4770;4598.333241679938;4642.86071417858;4659.277811939155;4696.154692155411;4722.52774722525;4713.976430117862;4716.457607375161;4719.221328480797;4738.952610473885;4756.310335001405;4689.531046895318;4690.296455531663;4701.976490117561;4730.574248317634;4751.548602882721;5145.897082058338;5206.583473322125;5211.739413029333;5278.049951008817;5279.392869819982;5701.2018317435595;5737.168110623978;5748.223989761413;5750.252467179282;5761.740721667535;5717.828465146011;5740.138979153118;5756.107803290497;5756.683382413966;5759.5968282220265;5217.373915130132;5313.309269794902;5315.335583052119;5329.280547126166;5339.706316152571;5789.044807606698;5804.651720896675;5819;5852.034414321589;5875.559333050039;5611.130274807411;5614.410486898817;5631.690257035821;5653.491185793216;5661.065924122474;5600.747966341524;5701.059325211377;5701.914471282934;5710.685912274865;5725.742341594639;5484.287042684506;5544.085225937756;5656.43435656431;5667.036603777367;5670.631408958487;5528.087865502228;5603.971980140073;5664.716764161775;5680.005998950167;5685;4692.718436893797;4731.384919960383;4746.572808447257;4752.976235118871;4782.402199725035;4027.436158937751;4040.777757223381;4068.8372465101656;4144.109016561454;4144.896377590584;4692.131955588227;4706.788194531255;4772.785224664898;4802.783874725646;4855.053264613366;5651.491365777099;5686.630369026;5706.771729130871;5730.455606717355;5734.283214598176;4802.927956080662;4809.182438985381;4824.758762061883;4833.626957147493;4859.3682821233015;4927.28554359623;5055.216441451581;5074.898502029939;5079.415867175322;5084.77118529667;5177.8187763428095;5218.530332270114;5254;5335.919961200662;5346.278252435872;5571.916421253765;5627.549796016391;5641.605087643826;5665.85835354103;5695.800646977336;5264.31563896691;5268.81559145428;5277.28756617867;5285.418603953639;5327.627066105335;5600.69196194197;5618.353889302783;5633.0705433603;5633.126865335879;5634.098544232903;5633.352164501135;5656.5757568181725;5697.259356283656;5698.173764803997;5709;5465.562754979513;5534.280543529316;5536.114221724666;5548.472895074961;5568.16477528374;5503.422140675171;5511.311086114236;5522.171674248734;5524;5534.7786088556;5330.9733451332495;5416.945830541644;5464.945350546603;5474.151506516497;5510.090835012178;5513.3108361454815;5526.115821468546;5550.861228469159;5597.412271711411;5599.440055994368;5292.629515933848;5308.840734777963;5319.547838433622;5319.707416092152;5351.3043304370185 22:29:06 INFO - PID 10943 | |1;ext.html;661.1603263854904;726.4079774983388;746.970121195152;1095.8191898336775;1107.457345900509;33455.330893382146;34425.311493770176;34582;34625.826870865676;34672.30655386894;35836.104097397576;35990;36029.459558106646;36067.819660901725;36290.274194516096;6653.933460665404;6712.160979877503;6819.420349270318;6819.556728812611;6828.726850925957;6791.219009813861;6881.862362752742;6892.4141447976735;6894.448444124458;6901.309869013109;6860.828479288033;6920.861582768342;6921.861562768741;6921.930780692204;6929.514933954625;6852.794416167523;6874.828129296758;6879.89680154798;6903.1371078615175;6909.965450172767;6719.387347036725;6726.192856857208;6766.695498702521;6778.254392016875;6792.252852186256;31589.684103158903;31761.205969850707;31769.364612707846;31771.84114079438;31830.522542161885;3071.4010767900268;3072.3548054908497;3079.2148002259282;3086.845657717105;3104.28601421672;24506.754932450804;24554;24556.508869822504;24597.631035534483;24607.261782146565;2973.4177846491575;3030.681778413279;3031.1209749172713;3032.818030918152;3078.4612692778674;127366;128791.35604322012;130136;140123.99999999898;140592;39630.2258841884;39795.20409591792;39886.401703974465;39932.80033599814;40096.799516002815;41814.58185418168;41910.58089419128;41929.580704192565;41931;41953.790231048646;11374.601888933848;11476.540938362372;11476.942615286871;11480.827787583194;11486.368249746343;9013.18881300673;9020.05289444612;9089.681861134828;9093.272538196929;9116.680916168036;12772.233665979886;12839;12978.415971281314;13012.373453318336;13146.671333216746;5136.768845401966;5221.55616772571;5251.76367063483;5299.178627312773;5340.567329116824;819.7991492084477;846.1834329871581;848.3764433141636;871.4640496094983;876.071364353787;20449.386518404473;21519.67720484194;25166;27260.59109113365;27490.312742181606;952.4523399045577;965.0687086961116;979.4515071559949;983.5475681186591;983.8917719050899;10580.418077005685;11201.943990279997;11296.6046188383;11432.657020289405;11456.828147577793;165999;167021;168100.15949920416;168403;168713;41041.58958410378;41043;41176.58823411787;41184;41388.79305603453;1184.9407529623484;1190.1847234644297;1208.0939295528353;1212.5634771482435;1212.6422705301957;19335.51661208481;19918.90040549788;20179.79820201779;21249.893750531766;24285.392865178514;37488.812555937046;38349.23301533898;38435.61564384432;38459;40418.59581404148;161287;164558;164659;165211.17394412952;165360;26024.609630855175;26267.343316417242;28109.578356324262;30548.84725576358;30908;34583.308333832676;34939.126521837155;35146;35147.82426087853;35709;26400.339991500365;27161.728382716712;27188;27270.454590907673;28077.298067548476;26381;26385.604215936393;27299.181024569294;27317.317067073483;27974.3006424841;28934.829887758082;29079.12762617125;29696.109116726533;29995.550066749453;30149.246268842577;25500.617490738026;25874.482510350063;26114.216573502825;26495.73504264933;27310.590341145296;18938.621227575648;21376.786232137478;21504.569908602054;21559;21834.89082554577 22:29:06 INFO - PID 10943 | |2;jquery.html;413.9689523285754;418.84293389978757;422.666093785909;430.72003197921345;441.04953824508175;11979.221350612204;13681.794773078387;17292.221850016747;17897.10514474276;18049.819501804977;18130.3654372097;18323.908380458113;18353;18368.540786480346;18420.907895460536;5398.24424580559;5573.052581061209;5573.888522229553;5596.608237423382;5601.80393686221;5087.364079490064;5325.627206095555;5334.413214546416;5340.198970154469;5412.485813847678;5255.395629502599;5279.524842764151;5281.471852814726;5295.708736019517;5308.893822123555;5270.288511051017;5274.235235890794;5319.6808191508635;5429.484199001088;5458.918116228259;4917.188663870493;4925.926111108336;4935.728534930578;4943.950560494385;4948.406191257072;20811.5837683247;21610.459738506506;21689.457763555878;21694.674579881314;21795.128194872344;1602.7275363188287;1606.3735143294007;1630.657561911988;1635.681042196772;1637.4923773630212;14335.713285734331;14354.210518421483;14505.41978320866;14553.636159096108;15030.849691503163;1855.5732181598173;1877.9248830046781;1903.714442833572;1912.1204246046834;1921.9711704324307;87462;89263.55368223182;90929;96277.5186124065;96988.51505742497;17290.312311924037;17571.912140439217;17601.559961001076;17685.734713979302;17930.641387172185;32726.672733272837;32974.50538241928;33110.17224569357;33147.34821214297;33287.50068748971;8193.180681931759;8196.467229630054;8215.507069575844;8359.832803344021;8493.532855692873;6490.967545162244;6517.739290428424;6550.705218265094;6719.092922455406;6749.662516874137;9144.268458523302;9236.72289831306;9282.721518354325;9576.952115239379;9644.421334719938;3319.9170020749675;3505.614382417932;3519.5780884621227;3604.243108947098;3628.6552777486095;828.5898480252193;856.2636132925679;875.0811647769816;882.1751662195867;892.0633334998225;16832.495025149266;16975.830241697673;17037.659246814994;17350.826491734922;17639.73540396895;866.913308669128;880.6917578847352;883.4346018548134;885.5218182181678;899.7075950316173;9245.260379169651;9295;9494.857577136348;9516.809663806824;9569.186619137312;352200;352382;353848;357084;358719;73659;75210.62394687992;76352.61823690846;77047.61476192583;77749;1020.2450186861818;1044.6448207609449;1074.8172810622057;1076.445630500293;1077.854489643888;14233.786493202817;14690.853091468949;14706.161729783777;14779.630509237355;15368.462103826312;36236.27527449489;37153.62846371502;37893.81053094717;37954.43068354032;38364.80817595894;45614;45730.31404529001;46482.53517464782;46655.60033199009;47763.28355074746;11285.887141128813;11441.485133169193;11585.189036767346;11623.476943537731;12016.098792590765;12438.12933094711;12442.191257568229;12449.626511204679;12876.806847897476;13029.804552931902;10584.417857017937;10686.946565267124;10744.785104298027;10965.56137754481;11206.607768728381;9955.253355998184;10131.696049118538;10192.439415832201;10343.27597068198;10516.737081572715;10380.04168811885;10756.892431075588;11004.724881878017;11305.7738845221;11634.011109055826;11377.601783937522;11501.53993840237;11597.304161750322;11694.4737486815;11916.76166476683;10938.671839844817;10948.56205751761;10978.451077446256;10988.890111098786;11282.830757538479 22:29:06 INFO - PID 10943 | |3;mootools.html;1155.716849371904;1205.855297364316;1220.8596011458678;1225.2464734188466;1244.6328333141723;9973.601055957763;10462.68611941641;10509.106725928305;10512.842307365396;10744.892551074487;10417.427041512714;10541.420221887793;10548.1561475082;10565.366078035324;10587;2120.8409369297324;2147.3128598848375;2160.708304378912;2168.230278251222;2170.4573856535867;2096.559722458278;2126.1176611706123;2128.2125613523017;2131.136889559723;2131.467133216696;2033.298512013353;2052.261185973056;2057.4856285928518;2059.4851287178208;2062.02054024338;1978.8317992970542;1979.980310140279;1984.7519060117486;1988.0556735550642;1991.492169496769;1842.769653793276;1897.8956157411337;1976.1502553901817;2002.3692536850845;2040.4796776821963;10306.948465257701;10378.11785998191;10397.948010259975;10432.947835260775;10441.373517588969;5152.871178220537;5391.487808658171;5391.514763671288;5398.190271459273;5399;3164.7784655074156;3282.868685252587;3339.3321335732708;3341.198112453018;3355.8154301513405;978.5107446276861;985.300436689951;1092.6885837536263;1124.3310230412892;1144.7252659361693;15068.849311506854;15197.240137993056;15232.162231077285;15241.23793810305;15254.923725381414;4469.955300447019;4510.594046535762;4642.442906851199;4683.765811709401;4710.882227944328;11117.444127793578;11129.165312601426;11133.610323638633;11156.16328775345;11160.720981975515;5249.291345668286;5342.038433082005;5344.331958505187;5359.651622644516;5361.169018802092;4900.240462728283;4934.432540257844;4941;4958.107540642719;4961.2806143109765;3806.1245913440066;3846.4999550058315;3910.96089039106;3946.4869566956113;3957.722959392815;1141.2923987128033;1146.9254498457574;1149.51720277482;1153.9249948753304;1184.5202692909386;695.3776370148789;718.1059580821806;726.3680597879878;739.8779201431811;743.6207534157511;5432.185172224119;5457.372402173722;5528.44715528444;5533.280673512498;5612.579056570692;491.5453205784635;513.2275924733327;517.5652451940313;517.6945602094706;519.6803965561228;3285.5564498792837;3310.337932413527;3321.8339083045753;3378.7128094112277;3454.7063499602314;12965.870341296466;13090.934545327213;13283.136596121221;13293.66765830862;13330.133541319783;12942.417591208417;13154.60536183916;13216.603501894959;13240.602781916557;13276.73446531064;6959.304069593101;6983.441324694012;7157.391621712213;7161.67772450241;7300.853982920312;5768.134779783066;5925.881482370242;5982.162497250301;6061.605995610271;6304.873902521832;12111.636650900487;12131.878681213075;12317.692057698629;12525.624231273076;12567.622971310875;12100.334481603597;12605.93697031509;12660.366981650697;12687.80968285458;12691.555795547112;8359.456635318686;8421.789455263668;8437.451565648458;8459.746207613782;8467.407281490237;9318.487483188219;9638.373505722106;9708.077732615391;9787.265955053543;9813;8370.539620320696;8431.789205269672;8479.618417171365;8488.787780305542;8514.829703406022;7873.173316801883;7909.209079092045;7911.920880791118;7932;8020.077691065602;6917.9654101731185;6961.129858767654;6997.895031574429;7002.579845209304;7010.474214433836;4652.906941861212;4956.281339205723;4963.305137280856;5063.8480845574695;5255.3693556771905;5219.399769026611;5220.190870415092;5291.735413229246;5327.893442131213;5498.45015498447 22:29:06 INFO - PID 10943 | |4;prototype.html;359.5344029481821;380.2660864531455;382.5199374784645;386.3837179698381;389.94930659014335;5313.654612450188;5500.5874559408;5509.760303931614;5539.889202215953;5573.637713548622;5277.393099793515;5341.798095428527;5344.412114667383;5355.518003379695;5363.168708850125;4072.3891416287497;4081.979590102045;4082.285600019992;4087.897802554945;4120.8969775755695;3977.8209980550946;4087.509498860141;4089.8568550100754;4105.2815757242515;4112.095339025424;4107.8973025674295;4108.4453598764085;4114.670826333886;4117.3206420940505;4118.6499147572495;4075.025231580933;4085.7140000199997;4094.1402305515876;4099.941058352239;4104.440312681177;3608.0979755061235;3608.314420260142;3614.8011859347725;3617.9095522612147;3628.2380700053022;5138.897222055538;5255.921161182585;5287.762050707727;5288.471152884719;5301.840944771663;4759.428868535763;4806.375171227718;4812.5668689818085;4819.156647586658;4823.962847987699;5427.3215848019;5624.15637654351;5628.831135065954;5666.57500687446;5701.71491425427;4039.5354534228645;4063.7561746295023;4064.695147863922;4079.571644977294;4081.7142800004012;5826.854328641775;5986.311574168983;6003.879922401571;6006.96996515019;6094.664793436359;4063.7968101595393;4096.836126554905;4108.219438306772;4115.52671442782;4121.752694838319;4151.97924010378;4159.10579225462;4166.749995000309;4167.4790651168605;4172.332426811757;4693.389859318267;4750.548697873696;4758.95241047592;4774.427068751703;4782.832600858953;5676.120201368794;5701.144828275792;5708.1723150143;5711.257536520309;5730.111832665943;1416.8441471438134;1424.3376829773997;1425.9287035648176;1427.4861050021984;1430.0847457627126;937.8546325319586;978.7308490165119;992.9304948653524;996.1283876607968;998.9650362237433;4966.850994470172;4969.975150124298;4977.651564390458;4981.750912454435;5016.247562865599;5876.236089308362;5919.200907877467;5925.229720136441;5936.643801371932;5951;4827.648258487629;4903.239997800347;4911.778969946289;4935.654504184745;4948.183549714328;3088.474959256932;3112.7860134547545;3127.5465057566526;3133.5613014178034;3142.214446388403;5351.892962140813;5409.783608655688;5421.783128674809;5433.130699088127;5486.588505862076;5844.561657875676;6020.458158765645;6021.253836387486;6031.939680603138;6061.181740465069;5432.70120143388;5436.6737995719595;5437.293151890229;5461.344638643309;5465.863353416196;5776.220210271559;5887.764489420547;5897.643541985281;5916.526677865846;5920.615160014585;5814.331351894586;5817.94182058174;5825.57273468003;5839.270091238595;5858.121281807763;5231.843044708665;5282.418933917343;5353.707469905902;5433.2665090213895;5448.727563621724;4016.477857878457;4101.835926563023;4103.651189648914;4127.380892866094;4130.008797888545;5900.203472531325;5917.970410147922;5933.139694744152;5940.6435613863305;5966.254218222723;5722.227499287709;5731.5701322400155;5745.764660597992;5769.365369809401;5779.422057794187;5579.8884022320135;5700.486956173964;5717.828465146053;5746.218672211628;5746.712664366682;5654.956705955262;5673.943260567342;5680.346760122474;5694.857628559153;5712.685802280915;5720.8690578614205;5751.654900705971;5813.738381772915;5815.505682016907;5817.614777941024;5602.327720673546;5649.802256920988;5662.377138514677;5667.291588551431;5675.659460432387 22:29:06 INFO - PID 10943 | |5;yui.html;739.5784402890355;762.7254188492142;769.0463824857179;774.8798936164897;784.9607519624021;12408.999999999978;12697;12924.547640832572;13262.801057984127;13296.800547991776;15071.171085590287;15802.84197158031;15841.128737919438;15916.761248581251;15988.520344389657;880.6521424037518;898.6046139698544;902.8916530016407;903.5166186090443;904.7738065483629;899.8245342158282;903.029243563169;908.0556221529602;909.0455022226636;909.586138307072;931.3061768982118;934.7429456899373;934.8364036293622;935.6397786852077;937.5359197197363;923.6074668265994;926.4395041000165;927.5594092805931;929.4934260827865;934.2059249637788;668.3383450384084;674.8380388706724;678.647103506179;683.2518392360357;684.6542496039518;14637.780433293508;14716.190609516472;14770.852291477162;14804.555863324118;14841.70316593673;11673.1828771986;12336;12411.75176496465;12413.255204687657;12437.191582547106;12313.569025084169;12525.373731313397;12595.181313214613;12642.74714505714;12658.873411265862;2934.090431966097;2953.4388466191353;2954.290970167144;2960.985195074011;2963.303623648441;79000.60499697522;80215.19784802194;80517;80646.59676701638;80844.19155808426;10911.181661375429;11072.612458564072;11085.778284434266;11121.05471034971;11121.833172502418;18360.357387491375;18719.438416847515;18729.250829966648;18908.43274701761;18915.24339026451;6373.968130159319;6418.293987661354;6455.257645370749;6467.223933127961;6469.77355792545;2770.792190585674;2827.6748173959845;2845.374017716099;2848.487272290966;2850.8859645614357;3756.530433695788;3775.9433608495897;3800.277947190025;3844.1350696093155;3848.365019771706;686.4645576450376;699.0353312428815;766.4711349169055;832.8750687396939;834.0575150080491;595.8004068636968;602.0818252165483;602.9366916473795;609.0620444515486;625.627751487864;9633.08485693858;10115.342502737298;10564.735881602868;11006.284591501526;11198.776024479464;570.7545755325167;578.4909279833804;584.2725806371095;584.6696616411714;596.4333882811346;4367.847125350661;4501.437320334958;4581.5647513486165;4583.587477127008;4684.508126646721;77354;78123.60938195273;78461;81722.59138704387;82857;63195;64836.351636483974;65477.34522654808;66118.74337592741;72529.63735181396;58369.70815145982;59840.40159598348;60102.098468522134;61109.69445152746;61158.694206528686;10099.101473345;11081.667549973514;11201.15991300672;11221.943890280496;11293.209475336647;27619.54755655543;27713.445731085667;27797.722022780323;28629.570556442086;28750.856245719475;34701;35393.1151721209;35785.64214357823;50579.747101264256;52242;15035.248237588296;15208.923955380153;15574.844251557794;15637.296321665324;15710.528684139494;15031.098134111551;15498.800479808167;15602.453914112952;15886.443974460839;16499.257533410786;12353.814692779435;14791.482298119514;15053.397864085315;15305;15562.066276023475;14689.853101469276;14900.478483253035;14907.180105094323;14980.625484362543;15385.230738463257;13519.662008449473;13697.246651434267;13770.65573360674;13805.17168969865;13999.580012599637;9655.372400794207;9854.162396196403;10020.799584008133;10257.84613230817;10590.364578125336;11167.609133680282;11566.768664626828;11724.648260552198;11754.412279386168;11783.175177737476 22:29:06 INFO - PID 10943 | __end_tp_report 22:29:06 INFO - PID 10943 | __start_cc_report 22:29:06 INFO - PID 10943 | _x_x_mozilla_cycle_collect,380 22:29:06 INFO - PID 10943 | __end_cc_report 22:29:06 INFO - PID 10943 | __startTimestamp1495949346939__endTimestamp 22:29:06 INFO - PID 10943 | 22:29:06 INFO - PID 10943 | ------- Summary: start ------- 22:29:06 INFO - PID 10943 | Number of tests: 6 22:29:06 INFO - PID 10943 | 22:29:06 INFO - PID 10943 | [#0] dojo.html Cycles:165 Average:5189.82 Median:5327.63 stddev:609.84 (11.4%) stddev-sans-first:579.12 22:29:06 INFO - PID 10943 | Values: 2682.1 2730.9 2750.5 2765.5 2769.9 5160.9 5239.9 5266.9 5301.7 5318.1 5249.6 5251.5 5275.4 5375.0 5403.4 4661.6 4679.7 4700.7 4704.8 4741.0 4671.7 4711.0 4731.4 4757.3 4770.0 4598.3 4642.9 4659.3 4696.2 4722.5 4714.0 4716.5 4719.2 4739.0 4756.3 4689.5 4690.3 4702.0 4730.6 4751.5 5145.9 5206.6 5211.7 5278.0 5279.4 5701.2 5737.2 5748.2 5750.3 5761.7 5717.8 5740.1 5756.1 5756.7 5759.6 5217.4 5313.3 5315.3 5329.3 5339.7 5789.0 5804.7 5819.0 5852.0 5875.6 5611.1 5614.4 5631.7 5653.5 5661.1 5600.7 5701.1 5701.9 5710.7 5725.7 5484.3 5544.1 5656.4 5667.0 5670.6 5528.1 5604.0 5664.7 5680.0 5685.0 4692.7 4731.4 4746.6 4753.0 4782.4 4027.4 4040.8 4068.8 4144.1 4144.9 4692.1 4706.8 4772.8 4802.8 4855.1 5651.5 5686.6 5706.8 5730.5 5734.3 4802.9 4809.2 4824.8 4833.6 4859.4 4927.3 5055.2 5074.9 5079.4 5084.8 5177.8 5218.5 5254.0 5335.9 5346.3 5571.9 5627.5 5641.6 5665.9 5695.8 5264.3 5268.8 5277.3 5285.4 5327.6 5600.7 5618.4 5633.1 5633.1 5634.1 5633.4 5656.6 5697.3 5698.2 5709.0 5465.6 5534.3 5536.1 5548.5 5568.2 5503.4 5511.3 5522.2 5524.0 5534.8 5331.0 5416.9 5464.9 5474.2 5510.1 5513.3 5526.1 5550.9 5597.4 5599.4 5292.6 5308.8 5319.5 5319.7 5351.3 22:29:06 INFO - PID 10943 | 22:29:06 INFO - PID 10943 | [#1] ext.html Cycles:180 Average:30213.04 Median:17006.14 stddev:40260.59 (236.7%) stddev-sans-first:40312.37 22:29:06 INFO - PID 10943 | Values: 661.2 726.4 747.0 1095.8 1107.5 33455.3 34425.3 34582.0 34625.8 34672.3 35836.1 35990.0 36029.5 36067.8 36290.3 6653.9 6712.2 6819.4 6819.6 6828.7 6791.2 6881.9 6892.4 6894.4 6901.3 6860.8 6920.9 6921.9 6921.9 6929.5 6852.8 6874.8 6879.9 6903.1 6910.0 6719.4 6726.2 6766.7 6778.3 6792.3 31589.7 31761.2 31769.4 31771.8 31830.5 3071.4 3072.4 3079.2 3086.8 3104.3 24506.8 24554.0 24556.5 24597.6 24607.3 2973.4 3030.7 3031.1 3032.8 3078.5 127366.0 128791.4 130136.0 140124.0 140592.0 39630.2 39795.2 39886.4 39932.8 40096.8 41814.6 41910.6 41929.6 41931.0 41953.8 11374.6 11476.5 11476.9 11480.8 11486.4 9013.2 9020.1 9089.7 9093.3 9116.7 12772.2 12839.0 12978.4 13012.4 13146.7 5136.8 5221.6 5251.8 5299.2 5340.6 819.8 846.2 848.4 871.5 876.1 20449.4 21519.7 25166.0 27260.6 27490.3 952.5 965.1 979.5 983.5 983.9 10580.4 11201.9 11296.6 11432.7 11456.8 165999.0 167021.0 168100.2 168403.0 168713.0 41041.6 41043.0 41176.6 41184.0 41388.8 1184.9 1190.2 1208.1 1212.6 1212.6 19335.5 19918.9 20179.8 21249.9 24285.4 37488.8 38349.2 38435.6 38459.0 40418.6 161287.0 164558.0 164659.0 165211.2 165360.0 26024.6 26267.3 28109.6 30548.8 30908.0 34583.3 34939.1 35146.0 35147.8 35709.0 26400.3 27161.7 27188.0 27270.5 28077.3 26381.0 26385.6 27299.2 27317.3 27974.3 28934.8 29079.1 29696.1 29995.6 30149.2 25500.6 25874.5 26114.2 26495.7 27310.6 18938.6 21376.8 21504.6 21559.0 21834.9 22:29:06 INFO - PID 10943 | 22:29:06 INFO - PID 10943 | [#2] jquery.html Cycles:180 Average:25253.22 Median:3512.60 stddev:59172.31 (1684.6%) stddev-sans-first:59308.91 22:29:06 INFO - PID 10943 | Values: 414.0 418.8 422.7 430.7 441.0 11979.2 13681.8 17292.2 17897.1 18049.8 18130.4 18323.9 18353.0 18368.5 18420.9 5398.2 5573.1 5573.9 5596.6 5601.8 5087.4 5325.6 5334.4 5340.2 5412.5 5255.4 5279.5 5281.5 5295.7 5308.9 5270.3 5274.2 5319.7 5429.5 5458.9 4917.2 4925.9 4935.7 4944.0 4948.4 20811.6 21610.5 21689.5 21694.7 21795.1 1602.7 1606.4 1630.7 1635.7 1637.5 14335.7 14354.2 14505.4 14553.6 15030.8 1855.6 1877.9 1903.7 1912.1 1922.0 87462.0 89263.6 90929.0 96277.5 96988.5 17290.3 17571.9 17601.6 17685.7 17930.6 32726.7 32974.5 33110.2 33147.3 33287.5 8193.2 8196.5 8215.5 8359.8 8493.5 6491.0 6517.7 6550.7 6719.1 6749.7 9144.3 9236.7 9282.7 9577.0 9644.4 3319.9 3505.6 3519.6 3604.2 3628.7 828.6 856.3 875.1 882.2 892.1 16832.5 16975.8 17037.7 17350.8 17639.7 866.9 880.7 883.4 885.5 899.7 9245.3 9295.0 9494.9 9516.8 9569.2 352200.0 352382.0 353848.0 357084.0 358719.0 73659.0 75210.6 76352.6 77047.6 77749.0 1020.2 1044.6 1074.8 1076.4 1077.9 14233.8 14690.9 14706.2 14779.6 15368.5 36236.3 37153.6 37893.8 37954.4 38364.8 45614.0 45730.3 46482.5 46655.6 47763.3 11285.9 11441.5 11585.2 11623.5 12016.1 12438.1 12442.2 12449.6 12876.8 13029.8 10584.4 10686.9 10744.8 10965.6 11206.6 9955.3 10131.7 10192.4 10343.3 10516.7 10380.0 10756.9 11004.7 11305.8 11634.0 11377.6 11501.5 11597.3 11694.5 11916.8 10938.7 10948.6 10978.5 10988.9 11282.8 22:29:06 INFO - PID 10943 | 22:29:06 INFO - PID 10943 | [#3] mootools.html Cycles:180 Average:6250.16 Median:3416.71 stddev:4151.69 (121.5%) stddev-sans-first:4145.69 22:29:06 INFO - PID 10943 | Values: 1155.7 1205.9 1220.9 1225.2 1244.6 9973.6 10462.7 10509.1 10512.8 10744.9 10417.4 10541.4 10548.2 10565.4 10587.0 2120.8 2147.3 2160.7 2168.2 2170.5 2096.6 2126.1 2128.2 2131.1 2131.5 2033.3 2052.3 2057.5 2059.5 2062.0 1978.8 1980.0 1984.8 1988.1 1991.5 1842.8 1897.9 1976.2 2002.4 2040.5 10306.9 10378.1 10397.9 10432.9 10441.4 5152.9 5391.5 5391.5 5398.2 5399.0 3164.8 3282.9 3339.3 3341.2 3355.8 978.5 985.3 1092.7 1124.3 1144.7 15068.8 15197.2 15232.2 15241.2 15254.9 4470.0 4510.6 4642.4 4683.8 4710.9 11117.4 11129.2 11133.6 11156.2 11160.7 5249.3 5342.0 5344.3 5359.7 5361.2 4900.2 4934.4 4941.0 4958.1 4961.3 3806.1 3846.5 3911.0 3946.5 3957.7 1141.3 1146.9 1149.5 1153.9 1184.5 695.4 718.1 726.4 739.9 743.6 5432.2 5457.4 5528.4 5533.3 5612.6 491.5 513.2 517.6 517.7 519.7 3285.6 3310.3 3321.8 3378.7 3454.7 12965.9 13090.9 13283.1 13293.7 13330.1 12942.4 13154.6 13216.6 13240.6 13276.7 6959.3 6983.4 7157.4 7161.7 7300.9 5768.1 5925.9 5982.2 6061.6 6304.9 12111.6 12131.9 12317.7 12525.6 12567.6 12100.3 12605.9 12660.4 12687.8 12691.6 8359.5 8421.8 8437.5 8459.7 8467.4 9318.5 9638.4 9708.1 9787.3 9813.0 8370.5 8431.8 8479.6 8488.8 8514.8 7873.2 7909.2 7911.9 7932.0 8020.1 6918.0 6961.1 6997.9 7002.6 7010.5 4652.9 4956.3 4963.3 5063.8 5255.4 5219.4 5220.2 5291.7 5327.9 5498.5 22:29:06 INFO - PID 10943 | 22:29:06 INFO - PID 10943 | [#4] prototype.html Cycles:180 Average:4707.86 Median:5348.15 stddev:1386.35 (25.9%) stddev-sans-first:1351.28 22:29:06 INFO - PID 10943 | Values: 359.5 380.3 382.5 386.4 389.9 5313.7 5500.6 5509.8 5539.9 5573.6 5277.4 5341.8 5344.4 5355.5 5363.2 4072.4 4082.0 4082.3 4087.9 4120.9 3977.8 4087.5 4089.9 4105.3 4112.1 4107.9 4108.4 4114.7 4117.3 4118.6 4075.0 4085.7 4094.1 4099.9 4104.4 3608.1 3608.3 3614.8 3617.9 3628.2 5138.9 5255.9 5287.8 5288.5 5301.8 4759.4 4806.4 4812.6 4819.2 4824.0 5427.3 5624.2 5628.8 5666.6 5701.7 4039.5 4063.8 4064.7 4079.6 4081.7 5826.9 5986.3 6003.9 6007.0 6094.7 4063.8 4096.8 4108.2 4115.5 4121.8 4152.0 4159.1 4166.7 4167.5 4172.3 4693.4 4750.5 4759.0 4774.4 4782.8 5676.1 5701.1 5708.2 5711.3 5730.1 1416.8 1424.3 1425.9 1427.5 1430.1 937.9 978.7 992.9 996.1 999.0 4966.9 4970.0 4977.7 4981.8 5016.2 5876.2 5919.2 5925.2 5936.6 5951.0 4827.6 4903.2 4911.8 4935.7 4948.2 3088.5 3112.8 3127.5 3133.6 3142.2 5351.9 5409.8 5421.8 5433.1 5486.6 5844.6 6020.5 6021.3 6031.9 6061.2 5432.7 5436.7 5437.3 5461.3 5465.9 5776.2 5887.8 5897.6 5916.5 5920.6 5814.3 5817.9 5825.6 5839.3 5858.1 5231.8 5282.4 5353.7 5433.3 5448.7 4016.5 4101.8 4103.7 4127.4 4130.0 5900.2 5918.0 5933.1 5940.6 5966.3 5722.2 5731.6 5745.8 5769.4 5779.4 5579.9 5700.5 5717.8 5746.2 5746.7 5655.0 5673.9 5680.3 5694.9 5712.7 5720.9 5751.7 5813.7 5815.5 5817.6 5602.3 5649.8 5662.4 5667.3 5675.7 22:29:06 INFO - PID 10943 | 22:29:06 INFO - PID 10943 | [#5] yui.html Cycles:180 Average:16655.48 Median:2962.14 stddev:21492.36 (725.6%) stddev-sans-first:21519.42 22:29:06 INFO - PID 10943 | Values: 739.6 762.7 769.0 774.9 785.0 12409.0 12697.0 12924.5 13262.8 13296.8 15071.2 15802.8 15841.1 15916.8 15988.5 880.7 898.6 902.9 903.5 904.8 899.8 903.0 908.1 909.0 909.6 931.3 934.7 934.8 935.6 937.5 923.6 926.4 927.6 929.5 934.2 668.3 674.8 678.6 683.3 684.7 14637.8 14716.2 14770.9 14804.6 14841.7 11673.2 12336.0 12411.8 12413.3 12437.2 12313.6 12525.4 12595.2 12642.7 12658.9 2934.1 2953.4 2954.3 2961.0 2963.3 79000.6 80215.2 80517.0 80646.6 80844.2 10911.2 11072.6 11085.8 11121.1 11121.8 18360.4 18719.4 18729.3 18908.4 18915.2 6374.0 6418.3 6455.3 6467.2 6469.8 2770.8 2827.7 2845.4 2848.5 2850.9 3756.5 3775.9 3800.3 3844.1 3848.4 686.5 699.0 766.5 832.9 834.1 595.8 602.1 602.9 609.1 625.6 9633.1 10115.3 10564.7 11006.3 11198.8 570.8 578.5 584.3 584.7 596.4 4367.8 4501.4 4581.6 4583.6 4684.5 77354.0 78123.6 78461.0 81722.6 82857.0 63195.0 64836.4 65477.3 66118.7 72529.6 58369.7 59840.4 60102.1 61109.7 61158.7 10099.1 11081.7 11201.2 11221.9 11293.2 27619.5 27713.4 27797.7 28629.6 28750.9 34701.0 35393.1 35785.6 50579.7 52242.0 15035.2 15208.9 15574.8 15637.3 15710.5 15031.1 15498.8 15602.5 15886.4 16499.3 12353.8 14791.5 15053.4 15305.0 15562.1 14689.9 14900.5 14907.2 14980.6 15385.2 13519.7 13697.2 13770.7 13805.2 13999.6 9655.4 9854.2 10020.8 10257.8 10590.4 11167.6 11566.8 11724.6 11754.4 11783.2 22:29:06 INFO - PID 10943 | -------- Summary: end -------- 22:29:06 INFO - PID 10943 | 22:29:07 INFO - TEST-INFO | 10943: exit 0 22:29:07 INFO - TEST-OK | dromaeo_css | took 1148368ms 22:29:07 INFO - TEST-START | kraken 22:29:07 INFO - operating with platform_type : linux_ 22:29:07 INFO - Initialising browser for kraken test... 22:29:07 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:34289/getInfo.html -profile /tmp/tmpr1gwX5/profile 22:29:07 INFO - TEST-INFO | started process 11351 (/builds/slave/test/build/application/firefox/firefox http://localhost:34289/getInfo.html) 22:29:42 INFO - TEST-INFO | 11351: killed by SIGTERM 22:29:42 INFO - Browser initialized. 22:29:42 INFO - Running cycle 1/1 for kraken test... 22:29:42 INFO - TEST-INFO | started process 11550 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpr1gwX5/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 22:29:55 INFO - PID 11550 | RSS: Main: 183328768 22:29:55 INFO - PID 11550 | 22:29:57 INFO - PID 11550 | Cycle 1(1): loaded http://localhost:34289/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:34289/tests/kraken/driver.html?testName=audio-beat-detection) 22:29:58 INFO - PID 11550 | RSS: Main: 186171392 22:29:58 INFO - PID 11550 | 22:30:01 INFO - PID 11550 | Cycle 1(1): loaded http://localhost:34289/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:34289/tests/kraken/driver.html?testName=audio-dft) 22:30:02 INFO - PID 11550 | RSS: Main: 185524224 22:30:02 INFO - PID 11550 | 22:30:04 INFO - PID 11550 | Cycle 1(1): loaded http://localhost:34289/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:34289/tests/kraken/driver.html?testName=audio-fft) 22:30:05 INFO - PID 11550 | RSS: Main: 181567488 22:30:05 INFO - PID 11550 | 22:30:07 INFO - PID 11550 | Cycle 1(1): loaded http://localhost:34289/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:34289/tests/kraken/driver.html?testName=audio-oscillator) 22:30:08 INFO - PID 11550 | RSS: Main: 182005760 22:30:08 INFO - PID 11550 | 22:30:10 INFO - PID 11550 | Cycle 1(1): loaded http://localhost:34289/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:34289/tests/kraken/driver.html?testName=imaging-gaussian-blur) 22:30:11 INFO - PID 11550 | RSS: Main: 182530048 22:30:11 INFO - PID 11550 | 22:30:14 INFO - PID 11550 | Cycle 1(1): loaded http://localhost:34289/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:34289/tests/kraken/driver.html?testName=imaging-darkroom) 22:30:14 INFO - PID 11550 | RSS: Main: 185409536 22:30:14 INFO - PID 11550 | 22:30:18 INFO - PID 11550 | Cycle 1(1): loaded http://localhost:34289/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:34289/tests/kraken/driver.html?testName=imaging-desaturate) 22:30:19 INFO - PID 11550 | RSS: Main: 183250944 22:30:19 INFO - PID 11550 | 22:30:21 INFO - PID 11550 | Cycle 1(1): loaded http://localhost:34289/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:34289/tests/kraken/driver.html?testName=json-parse-financial) 22:30:22 INFO - PID 11550 | RSS: Main: 183320576 22:30:22 INFO - PID 11550 | 22:30:24 INFO - PID 11550 | Cycle 1(1): loaded http://localhost:34289/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:34289/tests/kraken/driver.html?testName=json-stringify-tinderbox) 22:30:24 INFO - PID 11550 | RSS: Main: 183226368 22:30:24 INFO - PID 11550 | 22:30:26 INFO - PID 11550 | Cycle 1(1): loaded http://localhost:34289/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:34289/tests/kraken/driver.html?testName=stanford-crypto-aes) 22:30:27 INFO - PID 11550 | RSS: Main: 183144448 22:30:27 INFO - PID 11550 | 22:30:29 INFO - PID 11550 | Cycle 1(1): loaded http://localhost:34289/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:34289/tests/kraken/driver.html?testName=stanford-crypto-ccm) 22:30:30 INFO - PID 11550 | RSS: Main: 182571008 22:30:30 INFO - PID 11550 | 22:30:32 INFO - PID 11550 | Cycle 1(1): loaded http://localhost:34289/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:34289/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 22:30:33 INFO - PID 11550 | RSS: Main: 182833152 22:30:33 INFO - PID 11550 | 22:30:36 INFO - PID 11550 | Cycle 1(1): loaded http://localhost:34289/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:34289/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 22:30:37 INFO - PID 11550 | RSS: Main: 182652928 22:30:37 INFO - PID 11550 | 22:30:39 INFO - PID 11550 | Cycle 1(1): loaded http://localhost:34289/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:34289/tests/kraken/driver.html?testName=ai-astar) 22:30:39 INFO - PID 11550 | RSS: Main: 184340480 22:30:39 INFO - PID 11550 | 22:30:39 INFO - PID 11550 | __start_tp_report 22:30:39 INFO - PID 11550 | _x_x_mozilla_page_load 22:30:39 INFO - PID 11550 | _x_x_mozilla_page_load_details 22:30:39 INFO - PID 11550 | |i|pagename|runs| 22:30:39 INFO - PID 11550 | |0;ai-astar;104;111;111;110;110;110;112;111;111;111 22:30:39 INFO - PID 11550 | |1;audio-beat-detection;151;124;124;180;124;130;130;125;151;135 22:30:39 INFO - PID 11550 | |2;audio-dft;165;166;163;165;168;176;179;162;162;161 22:30:39 INFO - PID 11550 | |3;audio-fft;74;75;74;115;74;75;74;75;91;74 22:30:39 INFO - PID 11550 | |4;audio-oscillator;83;84;108;83;82;84;95;83;83;104 22:30:39 INFO - PID 11550 | |5;imaging-gaussian-blur;115;115;114;114;114;114;114;114;113;114 22:30:39 INFO - PID 11550 | |6;imaging-darkroom;150;150;151;150;150;151;152;150;150;150 22:30:39 INFO - PID 11550 | |7;imaging-desaturate;94;94;95;94;95;95;94;95;95;95 22:30:39 INFO - PID 11550 | |8;json-parse-financial;55;54;54;56;56;57;58;56;56;57 22:30:39 INFO - PID 11550 | |9;json-stringify-tinderbox;58;57;57;57;57;57;57;57;56;56 22:30:39 INFO - PID 11550 | |10;stanford-crypto-aes;96;87;87;88;88;89;87;88;126;87 22:30:39 INFO - PID 11550 | |11;stanford-crypto-ccm;134;142;144;133;133;146;131;131;140;134 22:30:39 INFO - PID 11550 | |12;stanford-crypto-pbkdf2;186;192;191;183;193;198;193;205;191;194 22:30:39 INFO - PID 11550 | |13;stanford-crypto-sha256-iterative;71;75;72;77;74;71;74;71;72;73 22:30:39 INFO - PID 11550 | __end_tp_report 22:30:39 INFO - PID 11550 | __start_cc_report 22:30:39 INFO - PID 11550 | _x_x_mozilla_cycle_collect,1019 22:30:39 INFO - PID 11550 | __end_cc_report 22:30:39 INFO - PID 11550 | __startTimestamp1495949439416__endTimestamp 22:30:39 INFO - PID 11550 | 22:30:39 INFO - PID 11550 | ------- Summary: start ------- 22:30:39 INFO - PID 11550 | Number of tests: 14 22:30:39 INFO - PID 11550 | 22:30:39 INFO - PID 11550 | [#0] ai-astar Cycles:10 Average:110.10 Median:111.00 stddev:2.23 (2.0%) stddev-sans-first:0.67 22:30:39 INFO - PID 11550 | Values: 104.0 111.0 111.0 110.0 110.0 110.0 112.0 111.0 111.0 111.0 22:30:39 INFO - PID 11550 | 22:30:39 INFO - PID 11550 | [#1] audio-beat-detection Cycles:10 Average:137.40 Median:132.50 stddev:18.23 (13.8%) stddev-sans-first:18.66 22:30:39 INFO - PID 11550 | Values: 151.0 124.0 124.0 180.0 124.0 130.0 130.0 125.0 151.0 135.0 22:30:39 INFO - PID 11550 | 22:30:39 INFO - PID 11550 | [#2] audio-dft Cycles:10 Average:166.70 Median:165.50 stddev:6.11 (3.7%) stddev-sans-first:6.45 22:30:39 INFO - PID 11550 | Values: 165.0 166.0 163.0 165.0 168.0 176.0 179.0 162.0 162.0 161.0 22:30:39 INFO - PID 11550 | 22:30:39 INFO - PID 11550 | [#3] audio-fft Cycles:10 Average:80.10 Median:74.50 stddev:13.34 (17.9%) stddev-sans-first:13.96 22:30:39 INFO - PID 11550 | Values: 74.0 75.0 74.0 115.0 74.0 75.0 74.0 75.0 91.0 74.0 22:30:39 INFO - PID 11550 | 22:30:39 INFO - PID 11550 | [#4] audio-oscillator Cycles:10 Average:88.90 Median:83.00 stddev:9.80 (11.8%) stddev-sans-first:10.16 22:30:39 INFO - PID 11550 | Values: 83.0 84.0 108.0 83.0 82.0 84.0 95.0 83.0 83.0 104.0 22:30:39 INFO - PID 11550 | 22:30:39 INFO - PID 11550 | [#5] imaging-gaussian-blur Cycles:10 Average:114.10 Median:114.00 stddev:0.57 (0.5%) stddev-sans-first:0.50 22:30:39 INFO - PID 11550 | Values: 115.0 115.0 114.0 114.0 114.0 114.0 114.0 114.0 113.0 114.0 22:30:39 INFO - PID 11550 | 22:30:39 INFO - PID 11550 | [#6] imaging-darkroom Cycles:10 Average:150.40 Median:150.00 stddev:0.70 (0.5%) stddev-sans-first:0.73 22:30:39 INFO - PID 11550 | Values: 150.0 150.0 151.0 150.0 150.0 151.0 152.0 150.0 150.0 150.0 22:30:39 INFO - PID 11550 | 22:30:39 INFO - PID 11550 | [#7] imaging-desaturate Cycles:10 Average:94.60 Median:95.00 stddev:0.52 (0.5%) stddev-sans-first:0.50 22:30:39 INFO - PID 11550 | Values: 94.0 94.0 95.0 94.0 95.0 95.0 94.0 95.0 95.0 95.0 22:30:39 INFO - PID 11550 | 22:30:39 INFO - PID 11550 | [#8] json-parse-financial Cycles:10 Average:55.90 Median:56.00 stddev:1.29 (2.3%) stddev-sans-first:1.32 22:30:39 INFO - PID 11550 | Values: 55.0 54.0 54.0 56.0 56.0 57.0 58.0 56.0 56.0 57.0 22:30:39 INFO - PID 11550 | 22:30:39 INFO - PID 11550 | [#9] json-stringify-tinderbox Cycles:10 Average:56.90 Median:57.00 stddev:0.57 (1.0%) stddev-sans-first:0.44 22:30:39 INFO - PID 11550 | Values: 58.0 57.0 57.0 57.0 57.0 57.0 57.0 57.0 56.0 56.0 22:30:39 INFO - PID 11550 | 22:30:39 INFO - PID 11550 | [#10] stanford-crypto-aes Cycles:10 Average:92.30 Median:88.00 stddev:12.15 (13.8%) stddev-sans-first:12.81 22:30:39 INFO - PID 11550 | Values: 96.0 87.0 87.0 88.0 88.0 89.0 87.0 88.0 126.0 87.0 22:30:39 INFO - PID 11550 | 22:30:39 INFO - PID 11550 | [#11] stanford-crypto-ccm Cycles:10 Average:136.80 Median:137.00 stddev:5.63 (4.1%) stddev-sans-first:5.88 22:30:39 INFO - PID 11550 | Values: 134.0 142.0 144.0 133.0 133.0 146.0 131.0 131.0 140.0 134.0 22:30:39 INFO - PID 11550 | 22:30:39 INFO - PID 11550 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:192.60 Median:193.00 stddev:6.02 (3.1%) stddev-sans-first:5.89 22:30:39 INFO - PID 11550 | Values: 186.0 192.0 191.0 183.0 193.0 198.0 193.0 205.0 191.0 194.0 22:30:39 INFO - PID 11550 | 22:30:39 INFO - PID 11550 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:73.00 Median:73.50 stddev:2.00 (2.7%) stddev-sans-first:1.99 22:30:39 INFO - PID 11550 | Values: 71.0 75.0 72.0 77.0 74.0 71.0 74.0 71.0 72.0 73.0 22:30:39 INFO - PID 11550 | -------- Summary: end -------- 22:30:39 INFO - PID 11550 | 22:30:40 INFO - TEST-INFO | 11550: exit 0 22:30:40 INFO - TEST-OK | kraken | took 92862ms 22:30:40 INFO - SUITE-END | took 1241s 22:30:41 INFO - Completed test suite (00:20:41) 22:30:41 INFO - javascript benchmark 22:30:41 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6765.678190274441, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2682.0612785525063, 2730.931726706831, 2750.5049091163596, 2765.516034693928, 2769.9307517312063, 5160.948390516094, 5239.86900327492, 5266.868328291795, 5301.6818990860575, 5318.069337865877, 5249.632525723201, 5251.474852514747, 5275.393329767078, 5374.973125134369, 5403.351597808269, 4661.557152070565, 4679.74261415622, 4700.741459219742, 4704.835330763415, 4740.976295118519, 4671.672982891199, 4710.97644511777, 4731.384919960417, 4757.333973243732, 4770.0, 4598.333241679938, 4642.86071417858, 4659.277811939155, 4696.154692155411, 4722.52774722525, 4713.976430117862, 4716.457607375161, 4719.221328480797, 4738.952610473885, 4756.310335001405, 4689.531046895318, 4690.296455531663, 4701.976490117561, 4730.574248317634, 4751.548602882721, 5145.897082058338, 5206.583473322125, 5211.739413029333, 5278.049951008817, 5279.392869819982, 5701.2018317435595, 5737.168110623978, 5748.223989761413, 5750.252467179282, 5761.740721667535, 5717.828465146011, 5740.138979153118, 5756.107803290497, 5756.683382413966, 5759.5968282220265, 5217.373915130132, 5313.309269794902, 5315.335583052119, 5329.280547126166, 5339.706316152571, 5789.044807606698, 5804.651720896675, 5819.0, 5852.034414321589, 5875.559333050039, 5611.130274807411, 5614.410486898817, 5631.690257035821, 5653.491185793216, 5661.065924122474, 5600.747966341524, 5701.059325211377, 5701.914471282934, 5710.685912274865, 5725.742341594639, 5484.287042684506, 5544.085225937756, 5656.43435656431, 5667.036603777367, 5670.631408958487, 5528.087865502228, 5603.971980140073, 5664.716764161775, 5680.005998950167, 5685.0, 4692.718436893797, 4731.384919960383, 4746.572808447257, 4752.976235118871, 4782.402199725035, 4027.436158937751, 4040.777757223381, 4068.8372465101656, 4144.109016561454, 4144.896377590584, 4692.131955588227, 4706.788194531255, 4772.785224664898, 4802.783874725646, 4855.053264613366, 5651.491365777099, 5686.630369026, 5706.771729130871, 5730.455606717355, 5734.283214598176, 4802.927956080662, 4809.182438985381, 4824.758762061883, 4833.626957147493, 4859.3682821233015, 4927.28554359623, 5055.216441451581, 5074.898502029939, 5079.415867175322, 5084.77118529667, 5177.8187763428095, 5218.530332270114, 5254.0, 5335.919961200662, 5346.278252435872, 5571.916421253765, 5627.549796016391, 5641.605087643826, 5665.85835354103, 5695.800646977336, 5264.31563896691, 5268.81559145428, 5277.28756617867, 5285.418603953639, 5327.627066105335, 5600.69196194197, 5618.353889302783, 5633.0705433603, 5633.126865335879, 5634.098544232903, 5633.352164501135, 5656.5757568181725, 5697.259356283656, 5698.173764803997, 5709.0, 5465.562754979513, 5534.280543529316, 5536.114221724666, 5548.472895074961, 5568.16477528374, 5503.422140675171, 5511.311086114236, 5522.171674248734, 5524.0, 5534.7786088556, 5330.9733451332495, 5416.945830541644, 5464.945350546603, 5474.151506516497, 5510.090835012178, 5513.3108361454815, 5526.115821468546, 5550.861228469159, 5597.412271711411, 5599.440055994368, 5292.629515933848, 5308.840734777963, 5319.547838433622, 5319.707416092152, 5351.3043304370185], "value": 5145.4961835166205, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [661.1603263854904, 726.4079774983388, 746.970121195152, 1095.8191898336775, 1107.457345900509, 33455.330893382146, 34425.311493770176, 34582.0, 34625.826870865676, 34672.30655386894, 35836.104097397576, 35990.0, 36029.459558106646, 36067.819660901725, 36290.274194516096, 6653.933460665404, 6712.160979877503, 6819.420349270318, 6819.556728812611, 6828.726850925957, 6791.219009813861, 6881.862362752742, 6892.4141447976735, 6894.448444124458, 6901.309869013109, 6860.828479288033, 6920.861582768342, 6921.861562768741, 6921.930780692204, 6929.514933954625, 6852.794416167523, 6874.828129296758, 6879.89680154798, 6903.1371078615175, 6909.965450172767, 6719.387347036725, 6726.192856857208, 6766.695498702521, 6778.254392016875, 6792.252852186256, 31589.684103158903, 31761.205969850707, 31769.364612707846, 31771.84114079438, 31830.522542161885, 3071.4010767900268, 3072.3548054908497, 3079.2148002259282, 3086.845657717105, 3104.28601421672, 24506.754932450804, 24554.0, 24556.508869822504, 24597.631035534483, 24607.261782146565, 2973.4177846491575, 3030.681778413279, 3031.1209749172713, 3032.818030918152, 3078.4612692778674, 127366.0, 128791.35604322012, 130136.0, 140123.99999999898, 140592.0, 39630.2258841884, 39795.20409591792, 39886.401703974465, 39932.80033599814, 40096.799516002815, 41814.58185418168, 41910.58089419128, 41929.580704192565, 41931.0, 41953.790231048646, 11374.601888933848, 11476.540938362372, 11476.942615286871, 11480.827787583194, 11486.368249746343, 9013.18881300673, 9020.05289444612, 9089.681861134828, 9093.272538196929, 9116.680916168036, 12772.233665979886, 12839.0, 12978.415971281314, 13012.373453318336, 13146.671333216746, 5136.768845401966, 5221.55616772571, 5251.76367063483, 5299.178627312773, 5340.567329116824, 819.7991492084477, 846.1834329871581, 848.3764433141636, 871.4640496094983, 876.071364353787, 20449.386518404473, 21519.67720484194, 25166.0, 27260.59109113365, 27490.312742181606, 952.4523399045577, 965.0687086961116, 979.4515071559949, 983.5475681186591, 983.8917719050899, 10580.418077005685, 11201.943990279997, 11296.6046188383, 11432.657020289405, 11456.828147577793, 165999.0, 167021.0, 168100.15949920416, 168403.0, 168713.0, 41041.58958410378, 41043.0, 41176.58823411787, 41184.0, 41388.79305603453, 1184.9407529623484, 1190.1847234644297, 1208.0939295528353, 1212.5634771482435, 1212.6422705301957, 19335.51661208481, 19918.90040549788, 20179.79820201779, 21249.893750531766, 24285.392865178514, 37488.812555937046, 38349.23301533898, 38435.61564384432, 38459.0, 40418.59581404148, 161287.0, 164558.0, 164659.0, 165211.17394412952, 165360.0, 26024.609630855175, 26267.343316417242, 28109.578356324262, 30548.84725576358, 30908.0, 34583.308333832676, 34939.126521837155, 35146.0, 35147.82426087853, 35709.0, 26400.339991500365, 27161.728382716712, 27188.0, 27270.454590907673, 28077.298067548476, 26381.0, 26385.604215936393, 27299.181024569294, 27317.317067073483, 27974.3006424841, 28934.829887758082, 29079.12762617125, 29696.109116726533, 29995.550066749453, 30149.246268842577, 25500.617490738026, 25874.482510350063, 26114.216573502825, 26495.73504264933, 27310.590341145296, 18938.621227575648, 21376.786232137478, 21504.569908602054, 21559.0, 21834.89082554577], "value": 14439.222796182212, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [413.9689523285754, 418.84293389978757, 422.666093785909, 430.72003197921345, 441.04953824508175, 11979.221350612204, 13681.794773078387, 17292.221850016747, 17897.10514474276, 18049.819501804977, 18130.3654372097, 18323.908380458113, 18353.0, 18368.540786480346, 18420.907895460536, 5398.24424580559, 5573.052581061209, 5573.888522229553, 5596.608237423382, 5601.80393686221, 5087.364079490064, 5325.627206095555, 5334.413214546416, 5340.198970154469, 5412.485813847678, 5255.395629502599, 5279.524842764151, 5281.471852814726, 5295.708736019517, 5308.893822123555, 5270.288511051017, 5274.235235890794, 5319.6808191508635, 5429.484199001088, 5458.918116228259, 4917.188663870493, 4925.926111108336, 4935.728534930578, 4943.950560494385, 4948.406191257072, 20811.5837683247, 21610.459738506506, 21689.457763555878, 21694.674579881314, 21795.128194872344, 1602.7275363188287, 1606.3735143294007, 1630.657561911988, 1635.681042196772, 1637.4923773630212, 14335.713285734331, 14354.210518421483, 14505.41978320866, 14553.636159096108, 15030.849691503163, 1855.5732181598173, 1877.9248830046781, 1903.714442833572, 1912.1204246046834, 1921.9711704324307, 87462.0, 89263.55368223182, 90929.0, 96277.5186124065, 96988.51505742497, 17290.312311924037, 17571.912140439217, 17601.559961001076, 17685.734713979302, 17930.641387172185, 32726.672733272837, 32974.50538241928, 33110.17224569357, 33147.34821214297, 33287.50068748971, 8193.180681931759, 8196.467229630054, 8215.507069575844, 8359.832803344021, 8493.532855692873, 6490.967545162244, 6517.739290428424, 6550.705218265094, 6719.092922455406, 6749.662516874137, 9144.268458523302, 9236.72289831306, 9282.721518354325, 9576.952115239379, 9644.421334719938, 3319.9170020749675, 3505.614382417932, 3519.5780884621227, 3604.243108947098, 3628.6552777486095, 828.5898480252193, 856.2636132925679, 875.0811647769816, 882.1751662195867, 892.0633334998225, 16832.495025149266, 16975.830241697673, 17037.659246814994, 17350.826491734922, 17639.73540396895, 866.913308669128, 880.6917578847352, 883.4346018548134, 885.5218182181678, 899.7075950316173, 9245.260379169651, 9295.0, 9494.857577136348, 9516.809663806824, 9569.186619137312, 352200.0, 352382.0, 353848.0, 357084.0, 358719.0, 73659.0, 75210.62394687992, 76352.61823690846, 77047.61476192583, 77749.0, 1020.2450186861818, 1044.6448207609449, 1074.8172810622057, 1076.445630500293, 1077.854489643888, 14233.786493202817, 14690.853091468949, 14706.161729783777, 14779.630509237355, 15368.462103826312, 36236.27527449489, 37153.62846371502, 37893.81053094717, 37954.43068354032, 38364.80817595894, 45614.0, 45730.31404529001, 46482.53517464782, 46655.60033199009, 47763.28355074746, 11285.887141128813, 11441.485133169193, 11585.189036767346, 11623.476943537731, 12016.098792590765, 12438.12933094711, 12442.191257568229, 12449.626511204679, 12876.806847897476, 13029.804552931902, 10584.417857017937, 10686.946565267124, 10744.785104298027, 10965.56137754481, 11206.607768728381, 9955.253355998184, 10131.696049118538, 10192.439415832201, 10343.27597068198, 10516.737081572715, 10380.04168811885, 10756.892431075588, 11004.724881878017, 11305.7738845221, 11634.011109055826, 11377.601783937522, 11501.53993840237, 11597.304161750322, 11694.4737486815, 11916.76166476683, 10938.671839844817, 10948.56205751761, 10978.451077446256, 10988.890111098786, 11282.830757538479], "value": 9377.193590528543, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1155.716849371904, 1205.855297364316, 1220.8596011458678, 1225.2464734188466, 1244.6328333141723, 9973.601055957763, 10462.68611941641, 10509.106725928305, 10512.842307365396, 10744.892551074487, 10417.427041512714, 10541.420221887793, 10548.1561475082, 10565.366078035324, 10587.0, 2120.8409369297324, 2147.3128598848375, 2160.708304378912, 2168.230278251222, 2170.4573856535867, 2096.559722458278, 2126.1176611706123, 2128.2125613523017, 2131.136889559723, 2131.467133216696, 2033.298512013353, 2052.261185973056, 2057.4856285928518, 2059.4851287178208, 2062.02054024338, 1978.8317992970542, 1979.980310140279, 1984.7519060117486, 1988.0556735550642, 1991.492169496769, 1842.769653793276, 1897.8956157411337, 1976.1502553901817, 2002.3692536850845, 2040.4796776821963, 10306.948465257701, 10378.11785998191, 10397.948010259975, 10432.947835260775, 10441.373517588969, 5152.871178220537, 5391.487808658171, 5391.514763671288, 5398.190271459273, 5399.0, 3164.7784655074156, 3282.868685252587, 3339.3321335732708, 3341.198112453018, 3355.8154301513405, 978.5107446276861, 985.300436689951, 1092.6885837536263, 1124.3310230412892, 1144.7252659361693, 15068.849311506854, 15197.240137993056, 15232.162231077285, 15241.23793810305, 15254.923725381414, 4469.955300447019, 4510.594046535762, 4642.442906851199, 4683.765811709401, 4710.882227944328, 11117.444127793578, 11129.165312601426, 11133.610323638633, 11156.16328775345, 11160.720981975515, 5249.291345668286, 5342.038433082005, 5344.331958505187, 5359.651622644516, 5361.169018802092, 4900.240462728283, 4934.432540257844, 4941.0, 4958.107540642719, 4961.2806143109765, 3806.1245913440066, 3846.4999550058315, 3910.96089039106, 3946.4869566956113, 3957.722959392815, 1141.2923987128033, 1146.9254498457574, 1149.51720277482, 1153.9249948753304, 1184.5202692909386, 695.3776370148789, 718.1059580821806, 726.3680597879878, 739.8779201431811, 743.6207534157511, 5432.185172224119, 5457.372402173722, 5528.44715528444, 5533.280673512498, 5612.579056570692, 491.5453205784635, 513.2275924733327, 517.5652451940313, 517.6945602094706, 519.6803965561228, 3285.5564498792837, 3310.337932413527, 3321.8339083045753, 3378.7128094112277, 3454.7063499602314, 12965.870341296466, 13090.934545327213, 13283.136596121221, 13293.66765830862, 13330.133541319783, 12942.417591208417, 13154.60536183916, 13216.603501894959, 13240.602781916557, 13276.73446531064, 6959.304069593101, 6983.441324694012, 7157.391621712213, 7161.67772450241, 7300.853982920312, 5768.134779783066, 5925.881482370242, 5982.162497250301, 6061.605995610271, 6304.873902521832, 12111.636650900487, 12131.878681213075, 12317.692057698629, 12525.624231273076, 12567.622971310875, 12100.334481603597, 12605.93697031509, 12660.366981650697, 12687.80968285458, 12691.555795547112, 8359.456635318686, 8421.789455263668, 8437.451565648458, 8459.746207613782, 8467.407281490237, 9318.487483188219, 9638.373505722106, 9708.077732615391, 9787.265955053543, 9813.0, 8370.539620320696, 8431.789205269672, 8479.618417171365, 8488.787780305542, 8514.829703406022, 7873.173316801883, 7909.209079092045, 7911.920880791118, 7932.0, 8020.077691065602, 6917.9654101731185, 6961.129858767654, 6997.895031574429, 7002.579845209304, 7010.474214433836, 4652.906941861212, 4956.281339205723, 4963.305137280856, 5063.8480845574695, 5255.3693556771905, 5219.399769026611, 5220.190870415092, 5291.735413229246, 5327.893442131213, 5498.45015498447], "value": 4594.65721041388, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [359.5344029481821, 380.2660864531455, 382.5199374784645, 386.3837179698381, 389.94930659014335, 5313.654612450188, 5500.5874559408, 5509.760303931614, 5539.889202215953, 5573.637713548622, 5277.393099793515, 5341.798095428527, 5344.412114667383, 5355.518003379695, 5363.168708850125, 4072.3891416287497, 4081.979590102045, 4082.285600019992, 4087.897802554945, 4120.8969775755695, 3977.8209980550946, 4087.509498860141, 4089.8568550100754, 4105.2815757242515, 4112.095339025424, 4107.8973025674295, 4108.4453598764085, 4114.670826333886, 4117.3206420940505, 4118.6499147572495, 4075.025231580933, 4085.7140000199997, 4094.1402305515876, 4099.941058352239, 4104.440312681177, 3608.0979755061235, 3608.314420260142, 3614.8011859347725, 3617.9095522612147, 3628.2380700053022, 5138.897222055538, 5255.921161182585, 5287.762050707727, 5288.471152884719, 5301.840944771663, 4759.428868535763, 4806.375171227718, 4812.5668689818085, 4819.156647586658, 4823.962847987699, 5427.3215848019, 5624.15637654351, 5628.831135065954, 5666.57500687446, 5701.71491425427, 4039.5354534228645, 4063.7561746295023, 4064.695147863922, 4079.571644977294, 4081.7142800004012, 5826.854328641775, 5986.311574168983, 6003.879922401571, 6006.96996515019, 6094.664793436359, 4063.7968101595393, 4096.836126554905, 4108.219438306772, 4115.52671442782, 4121.752694838319, 4151.97924010378, 4159.10579225462, 4166.749995000309, 4167.4790651168605, 4172.332426811757, 4693.389859318267, 4750.548697873696, 4758.95241047592, 4774.427068751703, 4782.832600858953, 5676.120201368794, 5701.144828275792, 5708.1723150143, 5711.257536520309, 5730.111832665943, 1416.8441471438134, 1424.3376829773997, 1425.9287035648176, 1427.4861050021984, 1430.0847457627126, 937.8546325319586, 978.7308490165119, 992.9304948653524, 996.1283876607968, 998.9650362237433, 4966.850994470172, 4969.975150124298, 4977.651564390458, 4981.750912454435, 5016.247562865599, 5876.236089308362, 5919.200907877467, 5925.229720136441, 5936.643801371932, 5951.0, 4827.648258487629, 4903.239997800347, 4911.778969946289, 4935.654504184745, 4948.183549714328, 3088.474959256932, 3112.7860134547545, 3127.5465057566526, 3133.5613014178034, 3142.214446388403, 5351.892962140813, 5409.783608655688, 5421.783128674809, 5433.130699088127, 5486.588505862076, 5844.561657875676, 6020.458158765645, 6021.253836387486, 6031.939680603138, 6061.181740465069, 5432.70120143388, 5436.6737995719595, 5437.293151890229, 5461.344638643309, 5465.863353416196, 5776.220210271559, 5887.764489420547, 5897.643541985281, 5916.526677865846, 5920.615160014585, 5814.331351894586, 5817.94182058174, 5825.57273468003, 5839.270091238595, 5858.121281807763, 5231.843044708665, 5282.418933917343, 5353.707469905902, 5433.2665090213895, 5448.727563621724, 4016.477857878457, 4101.835926563023, 4103.651189648914, 4127.380892866094, 4130.008797888545, 5900.203472531325, 5917.970410147922, 5933.139694744152, 5940.6435613863305, 5966.254218222723, 5722.227499287709, 5731.5701322400155, 5745.764660597992, 5769.365369809401, 5779.422057794187, 5579.8884022320135, 5700.486956173964, 5717.828465146053, 5746.218672211628, 5746.712664366682, 5654.956705955262, 5673.943260567342, 5680.346760122474, 5694.857628559153, 5712.685802280915, 5720.8690578614205, 5751.654900705971, 5813.738381772915, 5815.505682016907, 5817.614777941024, 5602.327720673546, 5649.802256920988, 5662.377138514677, 5667.291588551431, 5675.659460432387], "value": 4281.56276312446, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [739.5784402890355, 762.7254188492142, 769.0463824857179, 774.8798936164897, 784.9607519624021, 12408.999999999978, 12697.0, 12924.547640832572, 13262.801057984127, 13296.800547991776, 15071.171085590287, 15802.84197158031, 15841.128737919438, 15916.761248581251, 15988.520344389657, 880.6521424037518, 898.6046139698544, 902.8916530016407, 903.5166186090443, 904.7738065483629, 899.8245342158282, 903.029243563169, 908.0556221529602, 909.0455022226636, 909.586138307072, 931.3061768982118, 934.7429456899373, 934.8364036293622, 935.6397786852077, 937.5359197197363, 923.6074668265994, 926.4395041000165, 927.5594092805931, 929.4934260827865, 934.2059249637788, 668.3383450384084, 674.8380388706724, 678.647103506179, 683.2518392360357, 684.6542496039518, 14637.780433293508, 14716.190609516472, 14770.852291477162, 14804.555863324118, 14841.70316593673, 11673.1828771986, 12336.0, 12411.75176496465, 12413.255204687657, 12437.191582547106, 12313.569025084169, 12525.373731313397, 12595.181313214613, 12642.74714505714, 12658.873411265862, 2934.090431966097, 2953.4388466191353, 2954.290970167144, 2960.985195074011, 2963.303623648441, 79000.60499697522, 80215.19784802194, 80517.0, 80646.59676701638, 80844.19155808426, 10911.181661375429, 11072.612458564072, 11085.778284434266, 11121.05471034971, 11121.833172502418, 18360.357387491375, 18719.438416847515, 18729.250829966648, 18908.43274701761, 18915.24339026451, 6373.968130159319, 6418.293987661354, 6455.257645370749, 6467.223933127961, 6469.77355792545, 2770.792190585674, 2827.6748173959845, 2845.374017716099, 2848.487272290966, 2850.8859645614357, 3756.530433695788, 3775.9433608495897, 3800.277947190025, 3844.1350696093155, 3848.365019771706, 686.4645576450376, 699.0353312428815, 766.4711349169055, 832.8750687396939, 834.0575150080491, 595.8004068636968, 602.0818252165483, 602.9366916473795, 609.0620444515486, 625.627751487864, 9633.08485693858, 10115.342502737298, 10564.735881602868, 11006.284591501526, 11198.776024479464, 570.7545755325167, 578.4909279833804, 584.2725806371095, 584.6696616411714, 596.4333882811346, 4367.847125350661, 4501.437320334958, 4581.5647513486165, 4583.587477127008, 4684.508126646721, 77354.0, 78123.60938195273, 78461.0, 81722.59138704387, 82857.0, 63195.0, 64836.351636483974, 65477.34522654808, 66118.74337592741, 72529.63735181396, 58369.70815145982, 59840.40159598348, 60102.098468522134, 61109.69445152746, 61158.694206528686, 10099.101473345, 11081.667549973514, 11201.15991300672, 11221.943890280496, 11293.209475336647, 27619.54755655543, 27713.445731085667, 27797.722022780323, 28629.570556442086, 28750.856245719475, 34701.0, 35393.1151721209, 35785.64214357823, 50579.747101264256, 52242.0, 15035.248237588296, 15208.923955380153, 15574.844251557794, 15637.296321665324, 15710.528684139494, 15031.098134111551, 15498.800479808167, 15602.453914112952, 15886.443974460839, 16499.257533410786, 12353.814692779435, 14791.482298119514, 15053.397864085315, 15305.0, 15562.066276023475, 14689.853101469276, 14900.478483253035, 14907.180105094323, 14980.625484362543, 15385.230738463257, 13519.662008449473, 13697.246651434267, 13770.65573360674, 13805.17168969865, 13999.580012599637, 9655.372400794207, 9854.162396196403, 10020.799584008133, 10257.84613230817, 10590.364578125336, 11167.609133680282, 11566.768664626828, 11724.648260552198, 11754.412279386168, 11783.175177737476], "value": 6997.372109179505, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1549.7999999999997, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [104.0, 111.0, 111.0, 110.0, 110.0, 110.0, 112.0, 111.0, 111.0, 111.0], "value": 110.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 124.0, 124.0, 180.0, 124.0, 130.0, 130.0, 125.0, 151.0, 135.0], "value": 137.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 166.0, 163.0, 165.0, 168.0, 176.0, 179.0, 162.0, 162.0, 161.0], "value": 166.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 75.0, 74.0, 115.0, 74.0, 75.0, 74.0, 75.0, 91.0, 74.0], "value": 80.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 84.0, 108.0, 83.0, 82.0, 84.0, 95.0, 83.0, 83.0, 104.0], "value": 88.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 115.0, 114.0, 114.0, 114.0, 114.0, 114.0, 114.0, 113.0, 114.0], "value": 114.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 150.0, 151.0, 150.0, 150.0, 151.0, 152.0, 150.0, 150.0, 150.0], "value": 150.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 95.0, 94.0, 95.0, 95.0, 94.0, 95.0, 95.0, 95.0], "value": 94.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 54.0, 54.0, 56.0, 56.0, 57.0, 58.0, 56.0, 56.0, 57.0], "value": 55.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 57.0, 57.0, 57.0, 57.0, 57.0, 57.0, 57.0, 56.0, 56.0], "value": 56.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 87.0, 87.0, 88.0, 88.0, 89.0, 87.0, 88.0, 126.0, 87.0], "value": 92.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [134.0, 142.0, 144.0, 133.0, 133.0, 146.0, 131.0, 131.0, 140.0, 134.0], "value": 136.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [186.0, 192.0, 191.0, 183.0, 193.0, 198.0, 193.0, 205.0, 191.0, 194.0], "value": 192.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 75.0, 72.0, 77.0, 74.0, 71.0, 74.0, 71.0, 72.0, 73.0], "value": 73.0, "unit": "score"}]}]} 22:30:41 INFO - Return code: 0 22:30:41 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 22:30:41 INFO - # TBPL SUCCESS # 22:30:41 INFO - Running post-action listener: _resource_record_post_action 22:30:41 INFO - [mozharness: 2017-05-28 05:30:41.227741Z] Finished run-tests step (success) 22:30:41 INFO - Running post-run listener: _resource_record_post_run 22:30:41 INFO - Total resource usage - Wall time: 1258s; CPU: 13.0%; Read bytes: 8192; Write bytes: 405012480; Read time: 284; Write time: 432332 22:30:41 INFO - TinderboxPrint: CPU usage
12.7% 22:30:41 INFO - TinderboxPrint: I/O read bytes / time
8,192 / 284 22:30:41 INFO - TinderboxPrint: I/O write bytes / time
405,012,480 / 432,332 22:30:41 INFO - TinderboxPrint: CPU idle
8,766.4 (87.3%) 22:30:41 INFO - TinderboxPrint: CPU user
1,219.3 (12.1%) 22:30:41 INFO - TinderboxPrint: Swap in / out
0 / 0 22:30:41 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 93925376; Read time: 0; Write time: 133396 22:30:41 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 22:30:41 INFO - run-tests - Wall time: 1242s; CPU: 13.0%; Read bytes: 4096; Write bytes: 311087104; Read time: 260; Write time: 298936 22:30:41 INFO - Running post-run listener: _upload_blobber_files 22:30:41 INFO - Blob upload gear active. 22:30:41 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 22:30:41 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 22:30:41 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'] 22:30:41 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 22:30:42 INFO - (blobuploader) - INFO - Open directory for files ... 22:30:42 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 22:30:42 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:30:42 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:30:43 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 22:30:43 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:30:43 INFO - (blobuploader) - INFO - Done attempting. 22:30:43 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 22:30:43 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:30:43 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:30:43 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 22:30:43 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:30:43 INFO - (blobuploader) - INFO - Done attempting. 22:30:43 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 22:30:43 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:30:43 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:30:44 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 22:30:44 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:30:44 INFO - (blobuploader) - INFO - Done attempting. 22:30:44 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 22:30:44 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:30:44 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:30:50 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 22:30:50 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:30:50 INFO - (blobuploader) - INFO - Done attempting. 22:30:50 INFO - (blobuploader) - INFO - Iteration through files over. 22:30:50 INFO - Return code: 0 22:30:50 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 22:30:50 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 22:30:50 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/5f1f30f406c3d9739ab1c5d71f8f1a9b8522a898fed41b3b7ffeb371e00c92f73ebf198d304b4a65b4609a7297388563c33da246d29dd540a1203735ff2b14b0", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/8d8f8025c0ed0da4281b9052d4fddffe07d830be739582a48c201f8a4a1d2e25523590dd813714eb3ab14d5ad9b563991007885631b4ef2d22a51f694f1a51b2", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/8269bbe7caebb1e3ef5ff938b8665d49d949c9ea9d69c1222afabca7d7e2d57a478002c52ddf2c238e6946745aa626dd2bf601b364a1cc87448633d9eb3dabaf", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/0573b688089d00683dc87944c87c17c271c090b06cc4b4d106593619fe405d0931bfcc2a5ba62465e29a6b3622eef11460236e6220d46b9d2159fead5b90c773"} 22:30:50 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 22:30:50 INFO - Writing to file /builds/slave/test/properties/blobber_files 22:30:50 INFO - Contents: 22:30:50 INFO - blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/5f1f30f406c3d9739ab1c5d71f8f1a9b8522a898fed41b3b7ffeb371e00c92f73ebf198d304b4a65b4609a7297388563c33da246d29dd540a1203735ff2b14b0", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/8d8f8025c0ed0da4281b9052d4fddffe07d830be739582a48c201f8a4a1d2e25523590dd813714eb3ab14d5ad9b563991007885631b4ef2d22a51f694f1a51b2", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/8269bbe7caebb1e3ef5ff938b8665d49d949c9ea9d69c1222afabca7d7e2d57a478002c52ddf2c238e6946745aa626dd2bf601b364a1cc87448633d9eb3dabaf", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/0573b688089d00683dc87944c87c17c271c090b06cc4b4d106593619fe405d0931bfcc2a5ba62465e29a6b3622eef11460236e6220d46b9d2159fead5b90c773"} 22:30:50 INFO - Running post-run listener: copy_logs_to_upload_dir 22:30:50 INFO - Copying logs to upload dir... 22:30:50 INFO - mkdir: /builds/slave/test/build/upload/logs 22:30:50 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1320.699516 ========= master_lag: -0.16 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 22 mins, 0 secs) (at 2017-05-27 22:30:50.217472) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-27 22:30:50.221199) ========= 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=ba164b0a7b0ec7655860e956000001c1-1495938088.707465-1433112007 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/5f1f30f406c3d9739ab1c5d71f8f1a9b8522a898fed41b3b7ffeb371e00c92f73ebf198d304b4a65b4609a7297388563c33da246d29dd540a1203735ff2b14b0", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/8d8f8025c0ed0da4281b9052d4fddffe07d830be739582a48c201f8a4a1d2e25523590dd813714eb3ab14d5ad9b563991007885631b4ef2d22a51f694f1a51b2", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/8269bbe7caebb1e3ef5ff938b8665d49d949c9ea9d69c1222afabca7d7e2d57a478002c52ddf2c238e6946745aa626dd2bf601b364a1cc87448633d9eb3dabaf", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/0573b688089d00683dc87944c87c17c271c090b06cc4b4d106593619fe405d0931bfcc2a5ba62465e29a6b3622eef11460236e6220d46b9d2159fead5b90c773"} build_url:https://queue.taskcluster.net/v1/task/QjHREwbRSoanfsUt133rMw/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011219 build_url: 'https://queue.taskcluster.net/v1/task/QjHREwbRSoanfsUt133rMw/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/5f1f30f406c3d9739ab1c5d71f8f1a9b8522a898fed41b3b7ffeb371e00c92f73ebf198d304b4a65b4609a7297388563c33da246d29dd540a1203735ff2b14b0", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/8d8f8025c0ed0da4281b9052d4fddffe07d830be739582a48c201f8a4a1d2e25523590dd813714eb3ab14d5ad9b563991007885631b4ef2d22a51f694f1a51b2", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/8269bbe7caebb1e3ef5ff938b8665d49d949c9ea9d69c1222afabca7d7e2d57a478002c52ddf2c238e6946745aa626dd2bf601b364a1cc87448633d9eb3dabaf", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/0573b688089d00683dc87944c87c17c271c090b06cc4b4d106593619fe405d0931bfcc2a5ba62465e29a6b3622eef11460236e6220d46b9d2159fead5b90c773"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-27 22:30:50.248140) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-27 22:30:50.248459) ========= 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=ba164b0a7b0ec7655860e956000001c1-1495938088.707465-1433112007 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004511 ========= master_lag: 0.07 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-27 22:30:50.327502) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-27 22:30:50.330861) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-27 22:30:50.331150) ========= ========= Total master_lag: -0.01 =========