builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-063 starttime: 1495888365.39 results: success (0) revision: 66c73b65bf2d02c59f361b89135dc56553c3e4eb ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-05-27 05:32:45.387470) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-05-27 05:32:45.387976) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-27 05:32:45.388322) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-27 05:32:45.411699) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-27 05:32:45.412183) ========= 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=769a0cfe1e83e11e6f11f5a3000001a8-1495887323.97418-2031241851 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-05-27 05:32:46-- 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% 226M=0s 2017-05-27 05:32:46 (226 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.153833 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-27 05:32:45.585901) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-27 05:32:45.586216) ========= 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=769a0cfe1e83e11e6f11f5a3000001a8-1495887323.97418-2031241851 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017363 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-27 05:32:45.656553) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-05-27 05:32:45.656917) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 66c73b65bf2d02c59f361b89135dc56553c3e4eb --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 66c73b65bf2d02c59f361b89135dc56553c3e4eb --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=769a0cfe1e83e11e6f11f5a3000001a8-1495887323.97418-2031241851 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-05-27 05:32:46,362 truncating revision to first 12 chars 2017-05-27 05:32:46,362 Setting DEBUG logging. 2017-05-27 05:32:46,362 attempt 1/10 2017-05-27 05:32:46,362 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/66c73b65bf2d?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-05-27 05:32:47,811 unpacking tar archive at: mozilla-central-66c73b65bf2d/testing/mozharness/ program finished with exit code 0 elapsedTime=1.758035 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-05-27 05:32:47.434118) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-27 05:32:47.434697) ========= script_repo_revision: 66c73b65bf2d02c59f361b89135dc56553c3e4eb ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-27 05:32:47.435418) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-27 05:32:47.435962) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-27 05:32:47.452049) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 57 secs) (at 2017-05-27 05:32:47.452383) ========= /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=769a0cfe1e83e11e6f11f5a3000001a8-1495887323.97418-2031241851 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 05:32:48 INFO - MultiFileLogger online at 20170527 05:32:48 in /builds/slave/test 05:32:48 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 05:32:48 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:32:48 INFO - {'append_to_log': False, 05:32:48 INFO - 'base_work_dir': '/builds/slave/test', 05:32:48 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 05:32:48 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:32:48 INFO - 'branch': 'Firefox-Non-PGO', 05:32:48 INFO - 'buildbot_json_path': 'buildprops.json', 05:32:48 INFO - 'config_files': ('talos/linux_config.py',), 05:32:48 INFO - 'default_actions': ('clobber', 05:32:48 INFO - 'read-buildbot-config', 05:32:48 INFO - 'download-and-extract', 05:32:48 INFO - 'populate-webroot', 05:32:48 INFO - 'create-virtualenv', 05:32:48 INFO - 'install', 05:32:48 INFO - 'run-tests'), 05:32:48 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:32:48 INFO - 'download_minidump_stackwalk': True, 05:32:48 INFO - 'download_symbols': 'ondemand', 05:32:48 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:32:48 INFO - 'tooltool.py': '/tools/tooltool.py', 05:32:48 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:32:48 INFO - '/tools/misc-python/virtualenv.py')}, 05:32:48 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:32:48 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:32:48 INFO - 'gecko_profile': False, 05:32:48 INFO - 'gecko_profile_interval': 0, 05:32:48 INFO - 'installer_path': 'installer.exe', 05:32:48 INFO - 'log_level': 'info', 05:32:48 INFO - 'log_name': 'talos', 05:32:48 INFO - 'log_to_console': True, 05:32:48 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 05:32:48 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 05:32:48 INFO - 'opt_config_files': (), 05:32:48 INFO - 'pip_index': False, 05:32:48 INFO - 'suite': 'dromaeojs-e10s', 05:32:48 INFO - 'system_bits': '32', 05:32:48 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:32:48 INFO - 'title': 'talos-linux64-ix-063', 05:32:48 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:32:48 INFO - 'use_talos_json': True, 05:32:48 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:32:48 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:32:48 INFO - 'work_dir': 'build'} 05:32:48 INFO - [mozharness: 2017-05-27 12:32:48.251977Z] Running clobber step. 05:32:48 INFO - Running pre-action listener: _resource_record_pre_action 05:32:48 INFO - Running main action method: clobber 05:32:48 INFO - rmtree: /builds/slave/test/build 05:32:48 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:32:49 INFO - Running post-action listener: _resource_record_post_action 05:32:49 INFO - [mozharness: 2017-05-27 12:32:49.775462Z] Finished clobber step (success) 05:32:49 INFO - [mozharness: 2017-05-27 12:32:49.775560Z] Running read-buildbot-config step. 05:32:49 INFO - Running pre-action listener: _resource_record_pre_action 05:32:49 INFO - Running main action method: read_buildbot_config 05:32:49 INFO - Using buildbot properties: 05:32:49 INFO - { 05:32:49 INFO - "project": "", 05:32:49 INFO - "product": "firefox", 05:32:49 INFO - "who": "archaeopteryx@coole-files.de", 05:32:49 INFO - "installer_path": "public/build/target.tar.bz2", 05:32:49 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 05:32:49 INFO - "repository": "https://hg.mozilla.org/mozilla-central/", 05:32:49 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-e10s", 05:32:49 INFO - "stage_platform": "linux64", 05:32:49 INFO - "basedir": "/builds/slave/test", 05:32:49 INFO - "buildnumber": 908, 05:32:49 INFO - "platform": "ubuntu64_hw", 05:32:49 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 05:32:49 INFO - "slavebuilddir": "test", 05:32:49 INFO - "taskId": "SHXW4DE4SiCqd7MOWMEDlw", 05:32:49 INFO - "branch": "mozilla-central", 05:32:49 INFO - "script_repo_revision": "production", 05:32:49 INFO - "revision": "66c73b65bf2d02c59f361b89135dc56553c3e4eb", 05:32:49 INFO - "slavename": "talos-linux64-ix-063", 05:32:49 INFO - "repo_path": "mozilla-central" 05:32:49 INFO - } 05:32:49 INFO - Finding installer, test and symbols from parent task. 05:32:49 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/SHXW4DE4SiCqd7MOWMEDlw'}, attempt #1 05:32:50 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/SHXW4DE4SiCqd7MOWMEDlw'}, attempt #1 05:32:50 INFO - Task dependencies: Q8LbqfWYRpSDg2F3Fudimw 05:32:50 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Q8LbqfWYRpSDg2F3Fudimw'}, attempt #1 05:32:51 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/Q8LbqfWYRpSDg2F3Fudimw/artifacts/public/build/target.tar.bz2 05:32:51 INFO - Set test_url: https://queue.taskcluster.net/v1/task/Q8LbqfWYRpSDg2F3Fudimw/artifacts/public/build/test_packages.json 05:32:51 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/Q8LbqfWYRpSDg2F3Fudimw/artifacts/public/build/target.crashreporter-symbols.zip 05:32:51 INFO - Running post-action listener: _resource_record_post_action 05:32:51 INFO - [mozharness: 2017-05-27 12:32:51.121731Z] Finished read-buildbot-config step (success) 05:32:51 INFO - [mozharness: 2017-05-27 12:32:51.122044Z] Running download-and-extract step. 05:32:51 INFO - Running pre-action listener: _resource_record_pre_action 05:32:51 INFO - Running main action method: download_and_extract 05:32:51 INFO - mkdir: /builds/slave/test/build/tests 05:32:51 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')]} 05:32:51 INFO - trying https://queue.taskcluster.net/v1/task/Q8LbqfWYRpSDg2F3Fudimw/artifacts/public/build/target.test_packages.json 05:32:51 INFO - Downloading https://queue.taskcluster.net/v1/task/Q8LbqfWYRpSDg2F3Fudimw/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 05:32:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Q8LbqfWYRpSDg2F3Fudimw/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 05:32:51 INFO - Downloaded 986 bytes. 05:32:51 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 05:32:51 INFO - Using the following test package requirements: 05:32:51 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 05:32:51 INFO - u'common': [u'target.common.tests.zip'], 05:32:51 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 05:32:51 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 05:32:51 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 05:32:51 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 05:32:51 INFO - u'mozbase': [u'target.common.tests.zip'], 05:32:51 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 05:32:51 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 05:32:51 INFO - u'web-platform': [u'target.common.tests.zip', 05:32:51 INFO - u'target.web-platform.tests.zip'], 05:32:51 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 05:32:51 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 05:32:51 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Q8LbqfWYRpSDg2F3Fudimw/artifacts/public/build/target.common.tests.zip 05:32:51 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Q8LbqfWYRpSDg2F3Fudimw/artifacts/public/build/target.common.tests.zip'}, attempt #1 05:32:51 INFO - Fetch https://queue.taskcluster.net/v1/task/Q8LbqfWYRpSDg2F3Fudimw/artifacts/public/build/target.common.tests.zip into memory 05:32:53 INFO - Content-Length response header: 63526716 05:32:53 INFO - Bytes received: 63526716 05:33:03 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 05:33:03 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Q8LbqfWYRpSDg2F3Fudimw/artifacts/public/build/target.common.tests.zip 05:33:03 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Q8LbqfWYRpSDg2F3Fudimw/artifacts/public/build/target.common.tests.zip'}, attempt #1 05:33:03 INFO - Fetch https://queue.taskcluster.net/v1/task/Q8LbqfWYRpSDg2F3Fudimw/artifacts/public/build/target.common.tests.zip into memory 05:33:05 INFO - Content-Length response header: 63526716 05:33:05 INFO - Bytes received: 63526716 05:33:16 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Q8LbqfWYRpSDg2F3Fudimw/artifacts/public/build/target.talos.tests.zip 05:33:16 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Q8LbqfWYRpSDg2F3Fudimw/artifacts/public/build/target.talos.tests.zip'}, attempt #1 05:33:16 INFO - Fetch https://queue.taskcluster.net/v1/task/Q8LbqfWYRpSDg2F3Fudimw/artifacts/public/build/target.talos.tests.zip into memory 05:33:17 INFO - Content-Length response header: 14441221 05:33:17 INFO - Bytes received: 14441221 05:33:17 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')]} 05:33:17 INFO - trying https://queue.taskcluster.net/v1/task/Q8LbqfWYRpSDg2F3Fudimw/artifacts/public/build/target.tar.bz2 05:33:17 INFO - Downloading https://queue.taskcluster.net/v1/task/Q8LbqfWYRpSDg2F3Fudimw/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 05:33:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Q8LbqfWYRpSDg2F3Fudimw/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 05:33:19 INFO - Downloaded 54134621 bytes. 05:33:19 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Q8LbqfWYRpSDg2F3Fudimw/artifacts/public/build/target.tar.bz2 05:33:19 INFO - mkdir: /builds/slave/test/properties 05:33:19 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:33:19 INFO - Writing to file /builds/slave/test/properties/build_url 05:33:19 INFO - Contents: 05:33:19 INFO - build_url:https://queue.taskcluster.net/v1/task/Q8LbqfWYRpSDg2F3Fudimw/artifacts/public/build/target.tar.bz2 05:33:19 INFO - Running post-action listener: _resource_record_post_action 05:33:19 INFO - Running post-action listener: set_extra_try_arguments 05:33:19 INFO - [mozharness: 2017-05-27 12:33:19.974449Z] Finished download-and-extract step (success) 05:33:19 INFO - [mozharness: 2017-05-27 12:33:19.974675Z] Running populate-webroot step. 05:33:19 INFO - Running pre-action listener: _resource_record_pre_action 05:33:19 INFO - Running main action method: populate_webroot 05:33:19 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:33:19 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:33:19 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:33:19 INFO - '--tppagecycles', 05:33:19 INFO - '7'], 05:33:19 INFO - 'tests': ['tsvgm']}}, 05:33:19 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 05:33:19 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:33:19 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 05:33:19 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 05:33:19 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:33:19 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 05:33:19 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 05:33:19 INFO - 'talos_options': ['--disable-e10s'], 05:33:19 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:33:19 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 05:33:19 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:33:19 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 05:33:19 INFO - 'talos_options': ['--disable-e10s'], 05:33:19 INFO - 'tests': ['damp', 'tps']}, 05:33:19 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 05:33:19 INFO - 'tests': ['damp', 'tps']}, 05:33:19 INFO - 'g3': {'talos_options': ['--disable-e10s'], 05:33:19 INFO - 'tests': ['dromaeo_dom']}, 05:33:19 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:33:19 INFO - 'g4': {'talos_options': ['--disable-e10s'], 05:33:19 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 05:33:19 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 05:33:19 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 05:33:19 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 05:33:19 INFO - 'other': {'talos_options': ['--disable-e10s'], 05:33:19 INFO - 'tests': ['a11yr', 05:33:19 INFO - 'ts_paint', 05:33:19 INFO - 'tpaint', 05:33:19 INFO - 'sessionrestore', 05:33:19 INFO - 'sessionrestore_no_auto_restore', 05:33:19 INFO - 'tabpaint']}, 05:33:19 INFO - 'other-e10s': {'tests': ['a11yr', 05:33:19 INFO - 'ts_paint', 05:33:19 INFO - 'tpaint', 05:33:19 INFO - 'sessionrestore', 05:33:19 INFO - 'sessionrestore_no_auto_restore', 05:33:19 INFO - 'tabpaint']}, 05:33:19 INFO - 'other-e10s_l64': {'tests': ['a11yr', 05:33:19 INFO - 'ts_paint', 05:33:19 INFO - 'tpaint', 05:33:19 INFO - 'sessionrestore', 05:33:19 INFO - 'sessionrestore_no_auto_restore', 05:33:19 INFO - 'tabpaint']}, 05:33:19 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 05:33:19 INFO - 'ts_paint', 05:33:19 INFO - 'tpaint', 05:33:19 INFO - 'sessionrestore', 05:33:19 INFO - 'sessionrestore_no_auto_restore', 05:33:19 INFO - 'tabpaint']}, 05:33:19 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 05:33:19 INFO - 'tests': ['a11yr', 05:33:19 INFO - 'ts_paint', 05:33:19 INFO - 'tpaint', 05:33:19 INFO - 'sessionrestore', 05:33:19 INFO - 'sessionrestore_no_auto_restore', 05:33:19 INFO - 'tabpaint']}, 05:33:19 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 05:33:19 INFO - 'tests': ['a11yr', 05:33:19 INFO - 'ts_paint', 05:33:19 INFO - 'tpaint', 05:33:19 INFO - 'sessionrestore', 05:33:19 INFO - 'sessionrestore_no_auto_restore', 05:33:19 INFO - 'tabpaint']}, 05:33:19 INFO - 'perf-reftest': {'tests': ['bloom_basic', 'bloom_basic_ref']}, 05:33:19 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic', 05:33:19 INFO - 'bloom_basic_ref']}, 05:33:19 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 05:33:19 INFO - 'tests': ['tsvgx', 05:33:19 INFO - 'tsvgr_opacity', 05:33:19 INFO - 'tart', 05:33:19 INFO - 'tscrollx', 05:33:19 INFO - 'cart', 05:33:19 INFO - 'tsvg_static']}, 05:33:19 INFO - 'svgr-e10s': {'tests': ['tsvgx', 05:33:19 INFO - 'tsvgr_opacity', 05:33:19 INFO - 'tart', 05:33:19 INFO - 'tscrollx', 05:33:19 INFO - 'cart', 05:33:19 INFO - 'tsvg_static']}, 05:33:19 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 05:33:19 INFO - 'talos_options': ['--disable-e10s'], 05:33:19 INFO - 'tests': ['tp5o']}, 05:33:19 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 05:33:19 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 05:33:19 INFO - 'talos_options': ['--disable-e10s', 05:33:19 INFO - '--xperf_path', 05:33:19 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:33:19 INFO - 'tests': ['tp5n']}, 05:33:19 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 05:33:19 INFO - 'talos_options': ['--xperf_path', 05:33:19 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:33:19 INFO - 'tests': ['tp5n']}}, 05:33:19 INFO - 'talos.zip': {'path': '', 05:33:19 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:33:19 INFO - Running post-action listener: _resource_record_post_action 05:33:19 INFO - [mozharness: 2017-05-27 12:33:19.989022Z] Finished populate-webroot step (success) 05:33:19 INFO - [mozharness: 2017-05-27 12:33:19.989111Z] Running create-virtualenv step. 05:33:19 INFO - Running pre-action listener: _resource_record_pre_action 05:33:19 INFO - Running main action method: create_virtualenv 05:33:19 INFO - Creating virtualenv /builds/slave/test/build/venv 05:33:19 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 05:33:19 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:33:20 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:33:20 INFO - Using real prefix '/usr' 05:33:20 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:33:20 INFO - Installing distribute.............................................................................................................................................................................................done. 05:33:22 INFO - Installing pip.................done. 05:33:22 INFO - Return code: 0 05:33:22 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 05:33:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 05:33:22 INFO - Reading from file tmpfile_stdout 05:33:22 INFO - Output received: 05:33:22 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) 05:33:22 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:33:22 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')]} 05:33:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:33:22 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')]} 05:33:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:33:22 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 0x154c1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1719a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18bf5c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18bc7a0>, '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 0x18bd6a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18bdb30>, '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': '769a0cfe1e83e11e6f11f5a3000001a8-1495887323.97418-2031241851', '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 05:33:22 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 05:33:22 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 05:33:22 INFO - Using env: {'DISPLAY': ':0', 05:33:22 INFO - 'HOME': '/home/cltbld', 05:33:22 INFO - 'LANG': 'en_US.UTF-8', 05:33:22 INFO - 'LANGUAGE': 'en_US:en', 05:33:22 INFO - 'LOGNAME': 'cltbld', 05:33:22 INFO - 'MAIL': '/var/mail/cltbld', 05:33:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:33:22 INFO - 'MOZ_NO_REMOTE': '1', 05:33:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:33:22 INFO - 'NO_EM_RESTART': '1', 05:33:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:33:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:33:22 INFO - 'PWD': '/builds/slave/test', 05:33:22 INFO - 'SHELL': '/bin/bash', 05:33:22 INFO - 'SHLVL': '1', 05:33:22 INFO - 'TERM': 'linux', 05:33:22 INFO - 'TMOUT': '86400', 05:33:22 INFO - 'USER': 'cltbld', 05:33:22 INFO - 'XDG_SESSION_COOKIE': '769a0cfe1e83e11e6f11f5a3000001a8-1495887323.97418-2031241851', 05:33:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:33:22 INFO - '_': '/tools/buildbot/bin/python'} 05:33:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:33:22 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 05:33:22 INFO - Cleaning up... 05:33:23 INFO - Return code: 0 05:33:23 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 05:33:23 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')]} 05:33:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:33:23 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')]} 05:33:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:33:23 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 0x154c1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1719a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18bf5c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18bc7a0>, '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 0x18bd6a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18bdb30>, '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': '769a0cfe1e83e11e6f11f5a3000001a8-1495887323.97418-2031241851', '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 05:33:23 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 05:33:23 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 05:33:23 INFO - Using env: {'DISPLAY': ':0', 05:33:23 INFO - 'HOME': '/home/cltbld', 05:33:23 INFO - 'LANG': 'en_US.UTF-8', 05:33:23 INFO - 'LANGUAGE': 'en_US:en', 05:33:23 INFO - 'LOGNAME': 'cltbld', 05:33:23 INFO - 'MAIL': '/var/mail/cltbld', 05:33:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:33:23 INFO - 'MOZ_NO_REMOTE': '1', 05:33:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:33:23 INFO - 'NO_EM_RESTART': '1', 05:33:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:33:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:33:23 INFO - 'PWD': '/builds/slave/test', 05:33:23 INFO - 'SHELL': '/bin/bash', 05:33:23 INFO - 'SHLVL': '1', 05:33:23 INFO - 'TERM': 'linux', 05:33:23 INFO - 'TMOUT': '86400', 05:33:23 INFO - 'USER': 'cltbld', 05:33:23 INFO - 'XDG_SESSION_COOKIE': '769a0cfe1e83e11e6f11f5a3000001a8-1495887323.97418-2031241851', 05:33:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:33:23 INFO - '_': '/tools/buildbot/bin/python'} 05:33:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:33:23 INFO - Downloading/unpacking psutil>=3.1.1 05:33:23 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 05:33:23 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 05:33:23 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 05:33:23 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 05:33:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:33:24 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:33:24 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:33:24 INFO - Installing collected packages: psutil 05:33:24 INFO - Running setup.py install for psutil 05:33:24 INFO - building 'psutil._psutil_linux' extension 05:33:24 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 05:33:24 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 05:33:24 INFO - building 'psutil._psutil_posix' extension 05:33:24 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 05:33:24 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 05:33:24 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:33:24 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:33:24 INFO - Successfully installed psutil 05:33:24 INFO - Cleaning up... 05:33:24 INFO - Return code: 0 05:33:24 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 05:33:24 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')]} 05:33:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:33:24 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')]} 05:33:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:33:24 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 0x154c1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1719a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18bf5c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18bc7a0>, '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 0x18bd6a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18bdb30>, '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': '769a0cfe1e83e11e6f11f5a3000001a8-1495887323.97418-2031241851', '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 05:33:24 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 05:33:24 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 05:33:24 INFO - Using env: {'DISPLAY': ':0', 05:33:24 INFO - 'HOME': '/home/cltbld', 05:33:24 INFO - 'LANG': 'en_US.UTF-8', 05:33:24 INFO - 'LANGUAGE': 'en_US:en', 05:33:24 INFO - 'LOGNAME': 'cltbld', 05:33:24 INFO - 'MAIL': '/var/mail/cltbld', 05:33:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:33:24 INFO - 'MOZ_NO_REMOTE': '1', 05:33:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:33:24 INFO - 'NO_EM_RESTART': '1', 05:33:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:33:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:33:24 INFO - 'PWD': '/builds/slave/test', 05:33:24 INFO - 'SHELL': '/bin/bash', 05:33:24 INFO - 'SHLVL': '1', 05:33:24 INFO - 'TERM': 'linux', 05:33:24 INFO - 'TMOUT': '86400', 05:33:24 INFO - 'USER': 'cltbld', 05:33:24 INFO - 'XDG_SESSION_COOKIE': '769a0cfe1e83e11e6f11f5a3000001a8-1495887323.97418-2031241851', 05:33:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:33:24 INFO - '_': '/tools/buildbot/bin/python'} 05:33:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:33:25 INFO - Downloading/unpacking mozsystemmonitor==0.3 05:33:25 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 05:33:25 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 05:33:25 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 05:33:25 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 05:33:26 INFO - Downloading mozsystemmonitor-0.3.tar.gz 05:33:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:33:26 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 05:33:26 INFO - Installing collected packages: mozsystemmonitor 05:33:26 INFO - Running setup.py install for mozsystemmonitor 05:33:26 INFO - Successfully installed mozsystemmonitor 05:33:26 INFO - Cleaning up... 05:33:26 INFO - Return code: 0 05:33:26 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 05:33: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')]} 05:33:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:33: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')]} 05:33:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:33: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', '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 0x154c1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1719a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18bf5c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18bc7a0>, '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 0x18bd6a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18bdb30>, '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': '769a0cfe1e83e11e6f11f5a3000001a8-1495887323.97418-2031241851', '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 05:33: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', 'jsonschema==2.5.1'] in /builds/slave/test/build 05:33: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 jsonschema==2.5.1 05:33:26 INFO - Using env: {'DISPLAY': ':0', 05:33:26 INFO - 'HOME': '/home/cltbld', 05:33:26 INFO - 'LANG': 'en_US.UTF-8', 05:33:26 INFO - 'LANGUAGE': 'en_US:en', 05:33:26 INFO - 'LOGNAME': 'cltbld', 05:33:26 INFO - 'MAIL': '/var/mail/cltbld', 05:33:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:33:26 INFO - 'MOZ_NO_REMOTE': '1', 05:33:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:33:26 INFO - 'NO_EM_RESTART': '1', 05:33:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:33:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:33:26 INFO - 'PWD': '/builds/slave/test', 05:33:26 INFO - 'SHELL': '/bin/bash', 05:33:26 INFO - 'SHLVL': '1', 05:33:26 INFO - 'TERM': 'linux', 05:33:26 INFO - 'TMOUT': '86400', 05:33:26 INFO - 'USER': 'cltbld', 05:33:26 INFO - 'XDG_SESSION_COOKIE': '769a0cfe1e83e11e6f11f5a3000001a8-1495887323.97418-2031241851', 05:33:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:33:26 INFO - '_': '/tools/buildbot/bin/python'} 05:33:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:33:26 INFO - Downloading/unpacking jsonschema==2.5.1 05:33: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 05:33: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 05:33: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 05:33: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 05:33:27 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:33:27 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 05:33:27 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 05:33:27 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 05:33:27 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 05:33:27 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 05:33:28 INFO - Downloading functools32-3.2.3-2.tar.gz 05:33:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:33:28 INFO - warning: no files found matching '*.txt' 05:33:28 INFO - no previously-included directories found matching 'build' 05:33:28 INFO - no previously-included directories found matching 'dist' 05:33:28 INFO - no previously-included directories found matching '.git*' 05:33:28 INFO - Installing collected packages: jsonschema, functools32 05:33:28 INFO - Running setup.py install for functools32 05:33:28 INFO - warning: no files found matching '*.txt' 05:33:28 INFO - no previously-included directories found matching 'build' 05:33:28 INFO - no previously-included directories found matching 'dist' 05:33:28 INFO - no previously-included directories found matching '.git*' 05:33:28 INFO - Successfully installed jsonschema functools32 05:33:28 INFO - Cleaning up... 05:33:28 INFO - Return code: 0 05:33:28 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 05:33: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')]} 05:33:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:33: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')]} 05:33:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:33: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', '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 0x154c1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1719a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18bf5c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18bc7a0>, '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 0x18bd6a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18bdb30>, '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': '769a0cfe1e83e11e6f11f5a3000001a8-1495887323.97418-2031241851', '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 05:33: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', 'functools32==3.2.3-2'] in /builds/slave/test/build 05:33: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 functools32==3.2.3-2 05:33:28 INFO - Using env: {'DISPLAY': ':0', 05:33:28 INFO - 'HOME': '/home/cltbld', 05:33:28 INFO - 'LANG': 'en_US.UTF-8', 05:33:28 INFO - 'LANGUAGE': 'en_US:en', 05:33:28 INFO - 'LOGNAME': 'cltbld', 05:33:28 INFO - 'MAIL': '/var/mail/cltbld', 05:33:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:33:28 INFO - 'MOZ_NO_REMOTE': '1', 05:33:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:33:28 INFO - 'NO_EM_RESTART': '1', 05:33:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:33:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:33:28 INFO - 'PWD': '/builds/slave/test', 05:33:28 INFO - 'SHELL': '/bin/bash', 05:33:28 INFO - 'SHLVL': '1', 05:33:28 INFO - 'TERM': 'linux', 05:33:28 INFO - 'TMOUT': '86400', 05:33:28 INFO - 'USER': 'cltbld', 05:33:28 INFO - 'XDG_SESSION_COOKIE': '769a0cfe1e83e11e6f11f5a3000001a8-1495887323.97418-2031241851', 05:33:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:33:28 INFO - '_': '/tools/buildbot/bin/python'} 05:33:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:33:28 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 05:33:28 INFO - Cleaning up... 05:33:28 INFO - Return code: 0 05:33:28 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:33: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')]} 05:33:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:33: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')]} 05:33:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:33: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', '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 0x154c1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1719a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18bf5c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18bc7a0>, '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 0x18bd6a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18bdb30>, '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': '769a0cfe1e83e11e6f11f5a3000001a8-1495887323.97418-2031241851', '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 05:33: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 05:33: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 blobuploader==1.2.4 05:33:28 INFO - Using env: {'DISPLAY': ':0', 05:33:28 INFO - 'HOME': '/home/cltbld', 05:33:28 INFO - 'LANG': 'en_US.UTF-8', 05:33:28 INFO - 'LANGUAGE': 'en_US:en', 05:33:28 INFO - 'LOGNAME': 'cltbld', 05:33:28 INFO - 'MAIL': '/var/mail/cltbld', 05:33:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:33:28 INFO - 'MOZ_NO_REMOTE': '1', 05:33:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:33:28 INFO - 'NO_EM_RESTART': '1', 05:33:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:33:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:33:28 INFO - 'PWD': '/builds/slave/test', 05:33:28 INFO - 'SHELL': '/bin/bash', 05:33:28 INFO - 'SHLVL': '1', 05:33:28 INFO - 'TERM': 'linux', 05:33:28 INFO - 'TMOUT': '86400', 05:33:28 INFO - 'USER': 'cltbld', 05:33:28 INFO - 'XDG_SESSION_COOKIE': '769a0cfe1e83e11e6f11f5a3000001a8-1495887323.97418-2031241851', 05:33:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:33:28 INFO - '_': '/tools/buildbot/bin/python'} 05:33:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:33:28 INFO - Downloading/unpacking blobuploader==1.2.4 05:33: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 05:33: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 05:33: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 05:33: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 05:33:29 INFO - Downloading blobuploader-1.2.4.tar.gz 05:33:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:33:29 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:33:29 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 05:33:29 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 05:33:29 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 05:33:29 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 05:33:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:33:30 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:33: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 05:33: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 05:33: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 05:33: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 05:33:30 INFO - Downloading docopt-0.6.1.tar.gz 05:33:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:33:30 INFO - Installing collected packages: blobuploader, requests, docopt 05:33:30 INFO - Running setup.py install for blobuploader 05:33:30 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:33:30 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:33:30 INFO - Running setup.py install for requests 05:33:30 INFO - Running setup.py install for docopt 05:33:30 INFO - Successfully installed blobuploader requests docopt 05:33:30 INFO - Cleaning up... 05:33:31 INFO - Return code: 0 05:33:31 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:33: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')]} 05:33:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:33: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')]} 05:33:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:33:31 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 0x154c1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1719a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18bf5c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18bc7a0>, '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 0x18bd6a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18bdb30>, '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': '769a0cfe1e83e11e6f11f5a3000001a8-1495887323.97418-2031241851', '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 05:33:31 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 05:33:31 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 05:33:31 INFO - Using env: {'DISPLAY': ':0', 05:33:31 INFO - 'HOME': '/home/cltbld', 05:33:31 INFO - 'LANG': 'en_US.UTF-8', 05:33:31 INFO - 'LANGUAGE': 'en_US:en', 05:33:31 INFO - 'LOGNAME': 'cltbld', 05:33:31 INFO - 'MAIL': '/var/mail/cltbld', 05:33:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:33:31 INFO - 'MOZ_NO_REMOTE': '1', 05:33:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:33:31 INFO - 'NO_EM_RESTART': '1', 05:33:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:33:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:33:31 INFO - 'PWD': '/builds/slave/test', 05:33:31 INFO - 'SHELL': '/bin/bash', 05:33:31 INFO - 'SHLVL': '1', 05:33:31 INFO - 'TERM': 'linux', 05:33:31 INFO - 'TMOUT': '86400', 05:33:31 INFO - 'USER': 'cltbld', 05:33:31 INFO - 'XDG_SESSION_COOKIE': '769a0cfe1e83e11e6f11f5a3000001a8-1495887323.97418-2031241851', 05:33:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:33:31 INFO - '_': '/tools/buildbot/bin/python'} 05:33:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:33:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:33:31 INFO - Running setup.py (path:/tmp/pip-uAWWyI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:33:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:33:31 INFO - Running setup.py (path:/tmp/pip-MHHMna-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:33:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:33:31 INFO - Running setup.py (path:/tmp/pip-FivJbi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:33:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:33:31 INFO - Running setup.py (path:/tmp/pip-FWwKdU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:33:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:33:31 INFO - Running setup.py (path:/tmp/pip-SFUmcF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:33:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:33:31 INFO - Running setup.py (path:/tmp/pip-KtpuYl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:33:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:33:31 INFO - Running setup.py (path:/tmp/pip-QefGL2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:33:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:33:31 INFO - Running setup.py (path:/tmp/pip-dr5Rgy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:33:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:33:31 INFO - Running setup.py (path:/tmp/pip-1BLvrg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:33:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:33:31 INFO - Running setup.py (path:/tmp/pip-IrRl8O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:33:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:33:31 INFO - Running setup.py (path:/tmp/pip-_VvSZ3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:33:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:33:32 INFO - Running setup.py (path:/tmp/pip-6ITzWk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:33:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:33:32 INFO - Running setup.py (path:/tmp/pip-tipu8T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:33:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:33:32 INFO - Running setup.py (path:/tmp/pip-ekuVnF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:33:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:33:32 INFO - Running setup.py (path:/tmp/pip-CrOeNo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:33:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:33:32 INFO - Running setup.py (path:/tmp/pip-k8zRwA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:33:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:33:32 INFO - Running setup.py (path:/tmp/pip-hq4MO6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:33:32 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:33:32 INFO - Running setup.py install for manifestparser 05:33:32 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:33:32 INFO - Running setup.py install for mozcrash 05:33:32 INFO - Running setup.py install for mozdebug 05:33:32 INFO - Running setup.py install for mozdevice 05:33:32 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:33:32 INFO - Running setup.py install for mozfile 05:33:32 INFO - Running setup.py install for mozhttpd 05:33:33 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:33:33 INFO - Running setup.py install for mozinfo 05:33:33 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:33:33 INFO - Running setup.py install for mozInstall 05:33:33 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:33:33 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:33:33 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:33:33 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:33:33 INFO - Running setup.py install for mozleak 05:33:33 INFO - Running setup.py install for mozlog 05:33:33 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:33:33 INFO - Running setup.py install for moznetwork 05:33:33 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:33:33 INFO - Running setup.py install for mozprocess 05:33:33 INFO - Running setup.py install for mozprofile 05:33:33 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:33:33 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:33:33 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:33:33 INFO - Running setup.py install for mozrunner 05:33:33 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:33:33 INFO - Running setup.py install for mozscreenshot 05:33:34 INFO - Running setup.py install for moztest 05:33:34 INFO - Running setup.py install for mozversion 05:33:34 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:33:34 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:33:34 INFO - Cleaning up... 05:33:34 INFO - Return code: 0 05:33:34 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:33: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')]} 05:33:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:33: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')]} 05:33:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:33:34 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 0x154c1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1719a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18bf5c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18bc7a0>, '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 0x18bd6a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18bdb30>, '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': '769a0cfe1e83e11e6f11f5a3000001a8-1495887323.97418-2031241851', '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 05:33:34 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 05:33:34 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 05:33:34 INFO - Using env: {'DISPLAY': ':0', 05:33:34 INFO - 'HOME': '/home/cltbld', 05:33:34 INFO - 'LANG': 'en_US.UTF-8', 05:33:34 INFO - 'LANGUAGE': 'en_US:en', 05:33:34 INFO - 'LOGNAME': 'cltbld', 05:33:34 INFO - 'MAIL': '/var/mail/cltbld', 05:33:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:33:34 INFO - 'MOZ_NO_REMOTE': '1', 05:33:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:33:34 INFO - 'NO_EM_RESTART': '1', 05:33:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:33:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:33:34 INFO - 'PWD': '/builds/slave/test', 05:33:34 INFO - 'SHELL': '/bin/bash', 05:33:34 INFO - 'SHLVL': '1', 05:33:34 INFO - 'TERM': 'linux', 05:33:34 INFO - 'TMOUT': '86400', 05:33:34 INFO - 'USER': 'cltbld', 05:33:34 INFO - 'XDG_SESSION_COOKIE': '769a0cfe1e83e11e6f11f5a3000001a8-1495887323.97418-2031241851', 05:33:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:33:34 INFO - '_': '/tools/buildbot/bin/python'} 05:33:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:33:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:33:34 INFO - Running setup.py (path:/tmp/pip-KQ2h3L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:33:34 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)) 05:33:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:33:34 INFO - Running setup.py (path:/tmp/pip-cJpz2O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:33:34 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)) 05:33:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:33:34 INFO - Running setup.py (path:/tmp/pip-gseZzw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:33:34 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)) 05:33:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:33:34 INFO - Running setup.py (path:/tmp/pip-9RCrRX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:33:34 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)) 05:33:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:33:34 INFO - Running setup.py (path:/tmp/pip-POyQSz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:33:34 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)) 05:33:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:33:34 INFO - Running setup.py (path:/tmp/pip-GWE3io-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:33:34 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)) 05:33:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:33:34 INFO - Running setup.py (path:/tmp/pip-ESsQ81-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:33:34 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)) 05:33:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:33:34 INFO - Running setup.py (path:/tmp/pip-90Ju73-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:33:35 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)) 05:33:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:33:35 INFO - Running setup.py (path:/tmp/pip-TvN93q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:33:35 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)) 05:33:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:33:35 INFO - Running setup.py (path:/tmp/pip-cwttZu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:33:35 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)) 05:33:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:33:35 INFO - Running setup.py (path:/tmp/pip-24DcrN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:33:35 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)) 05:33:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:33:35 INFO - Running setup.py (path:/tmp/pip-k0aBXH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:33:35 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)) 05:33:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:33:35 INFO - Running setup.py (path:/tmp/pip-zq2cPX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:33:35 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)) 05:33:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:33:35 INFO - Running setup.py (path:/tmp/pip-lCNZNo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:33:35 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)) 05:33:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:33:35 INFO - Running setup.py (path:/tmp/pip-MTUaBb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:33:35 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)) 05:33:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:33:35 INFO - Running setup.py (path:/tmp/pip-ZvgI97-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:33:35 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)) 05:33:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:33:35 INFO - Running setup.py (path:/tmp/pip-hmfv3O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:33:35 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)) 05:33:35 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)) 05:33:35 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)) 05:33:35 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)) 05:33:35 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)) 05:33:35 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)) 05:33:35 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:33:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:33:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:33:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:33:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:33:36 INFO - Downloading blessings-1.6.tar.gz 05:33:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:33:36 INFO - Installing collected packages: blessings 05:33:36 INFO - Running setup.py install for blessings 05:33:36 INFO - Successfully installed blessings 05:33:36 INFO - Cleaning up... 05:33:37 INFO - Return code: 0 05:33:37 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:33:37 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:33:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:33:37 INFO - Reading from file tmpfile_stdout 05:33:37 INFO - Current package versions: 05:33:37 INFO - argparse == 1.2.1 05:33:37 INFO - blessings == 1.6 05:33:37 INFO - blobuploader == 1.2.4 05:33:37 INFO - docopt == 0.6.1 05:33:37 INFO - functools32 == 3.2.3-2 05:33:37 INFO - jsonschema == 2.5.1 05:33:37 INFO - manifestparser == 1.1 05:33:37 INFO - mozInstall == 1.12 05:33:37 INFO - mozcrash == 1.0 05:33:37 INFO - mozdebug == 0.1 05:33:37 INFO - mozdevice == 0.51 05:33:37 INFO - mozfile == 1.2 05:33:37 INFO - mozhttpd == 0.7 05:33:37 INFO - mozinfo == 0.9 05:33:37 INFO - mozleak == 0.1 05:33:37 INFO - mozlog == 3.4 05:33:37 INFO - moznetwork == 0.27 05:33:37 INFO - mozprocess == 0.25 05:33:37 INFO - mozprofile == 0.28 05:33:37 INFO - mozrunner == 6.13 05:33:37 INFO - mozscreenshot == 0.1 05:33:37 INFO - mozsystemmonitor == 0.3 05:33:37 INFO - moztest == 0.8 05:33:37 INFO - mozversion == 1.4 05:33:37 INFO - psutil == 3.1.1 05:33:37 INFO - requests == 1.2.3 05:33:37 INFO - wsgiref == 0.1.2 05:33:37 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:33: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')]} 05:33:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:33: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')]} 05:33:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:33:37 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 0x154c1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1719a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18bf5c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18bc7a0>, '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 0x18bd6a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18bdb30>, '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': '769a0cfe1e83e11e6f11f5a3000001a8-1495887323.97418-2031241851', '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 05:33:37 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 05:33:37 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 05:33:37 INFO - Using env: {'DISPLAY': ':0', 05:33:37 INFO - 'HOME': '/home/cltbld', 05:33:37 INFO - 'LANG': 'en_US.UTF-8', 05:33:37 INFO - 'LANGUAGE': 'en_US:en', 05:33:37 INFO - 'LOGNAME': 'cltbld', 05:33:37 INFO - 'MAIL': '/var/mail/cltbld', 05:33:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:33:37 INFO - 'MOZ_NO_REMOTE': '1', 05:33:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:33:37 INFO - 'NO_EM_RESTART': '1', 05:33:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:33:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:33:37 INFO - 'PWD': '/builds/slave/test', 05:33:37 INFO - 'SHELL': '/bin/bash', 05:33:37 INFO - 'SHLVL': '1', 05:33:37 INFO - 'TERM': 'linux', 05:33:37 INFO - 'TMOUT': '86400', 05:33:37 INFO - 'USER': 'cltbld', 05:33:37 INFO - 'XDG_SESSION_COOKIE': '769a0cfe1e83e11e6f11f5a3000001a8-1495887323.97418-2031241851', 05:33:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:33:37 INFO - '_': '/tools/buildbot/bin/python'} 05:33:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:33:37 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)) 05:33:37 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)) 05:33:37 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)) 05:33:37 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)) 05:33:37 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)) 05:33:37 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)) 05:33:37 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)) 05:33:37 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)) 05:33:37 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)) 05:33:37 INFO - Downloading/unpacking marionette-driver>=1.4.0 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 05:33:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:33:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:33:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:33:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:33:38 INFO - Downloading marionette_driver-1.4.0.tar.gz 05:33:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/marionette-driver/setup.py) egg_info for package marionette-driver 05:33:38 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)) 05:33:38 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)) 05:33:38 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)) 05:33:38 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)) 05:33:38 INFO - Installing collected packages: marionette-driver 05:33:38 INFO - Running setup.py install for marionette-driver 05:33:38 INFO - Successfully installed marionette-driver 05:33:38 INFO - Cleaning up... 05:33:38 INFO - Return code: 0 05:33:38 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:33:38 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')]} 05:33:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:33:38 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')]} 05:33:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:33:38 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 0x154c1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1719a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18bf5c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18bc7a0>, '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 0x18bd6a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18bdb30>, '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': '769a0cfe1e83e11e6f11f5a3000001a8-1495887323.97418-2031241851', '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 05:33:38 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 05:33:38 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 05:33:38 INFO - Using env: {'DISPLAY': ':0', 05:33:38 INFO - 'HOME': '/home/cltbld', 05:33:38 INFO - 'LANG': 'en_US.UTF-8', 05:33:38 INFO - 'LANGUAGE': 'en_US:en', 05:33:38 INFO - 'LOGNAME': 'cltbld', 05:33:38 INFO - 'MAIL': '/var/mail/cltbld', 05:33:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:33:38 INFO - 'MOZ_NO_REMOTE': '1', 05:33:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:33:38 INFO - 'NO_EM_RESTART': '1', 05:33:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:33:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:33:38 INFO - 'PWD': '/builds/slave/test', 05:33:38 INFO - 'SHELL': '/bin/bash', 05:33:38 INFO - 'SHLVL': '1', 05:33:38 INFO - 'TERM': 'linux', 05:33:38 INFO - 'TMOUT': '86400', 05:33:38 INFO - 'USER': 'cltbld', 05:33:38 INFO - 'XDG_SESSION_COOKIE': '769a0cfe1e83e11e6f11f5a3000001a8-1495887323.97418-2031241851', 05:33:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:33:38 INFO - '_': '/tools/buildbot/bin/python'} 05:33:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:33:39 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 05:33:39 INFO - Cleaning up... 05:33:39 INFO - Return code: 0 05:33:39 INFO - Running post-action listener: _resource_record_post_action 05:33:39 INFO - Running post-action listener: _start_resource_monitoring 05:33:39 INFO - Starting resource monitoring. 05:33:39 INFO - [mozharness: 2017-05-27 12:33:39.054059Z] Finished create-virtualenv step (success) 05:33:39 INFO - [mozharness: 2017-05-27 12:33:39.054560Z] Running install step. 05:33:39 INFO - Running pre-action listener: _resource_record_pre_action 05:33:39 INFO - Running main action method: install 05:33:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:33:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:33:39 INFO - Reading from file tmpfile_stdout 05:33:39 INFO - Detecting whether we're running mozinstall >=1.0... 05:33:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:33:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:33:39 INFO - Reading from file tmpfile_stdout 05:33:39 INFO - Output received: 05:33:39 INFO - Usage: mozinstall [options] installer 05:33:39 INFO - Options: 05:33:39 INFO - -h, --help show this help message and exit 05:33:39 INFO - -d DEST, --destination=DEST 05:33:39 INFO - Directory to install application into. [default: 05:33:39 INFO - "/builds/slave/test"] 05:33:39 INFO - --app=APP Application being installed. [default: firefox] 05:33:39 INFO - mkdir: /builds/slave/test/build/application 05:33:39 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'] 05:33:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 05:33:54 INFO - Reading from file tmpfile_stdout 05:33:54 INFO - Output received: 05:33:54 INFO - /builds/slave/test/build/application/firefox/firefox 05:33:54 INFO - Running post-action listener: _resource_record_post_action 05:33:54 INFO - [mozharness: 2017-05-27 12:33:54.932417Z] Finished install step (success) 05:33:54 INFO - [mozharness: 2017-05-27 12:33:54.932696Z] Running run-tests step. 05:33:54 INFO - Running pre-action listener: _resource_record_pre_action 05:33:54 INFO - Running main action method: run_tests 05:33:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:33:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:33:54 INFO - Python 2.7.3 05:33:54 INFO - Return code: 0 05:33:54 INFO - grabbing minidump binary from tooltool 05:33:54 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')]} 05:33:54 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 0x18bc7a0>, '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 0x18bd6a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18bdb30>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:33:54 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 05:33:54 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 05:33:54 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 05:33:55 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:33:55 INFO - Return code: 0 05:33:55 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 05:33:55 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:33:55 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:33:55 INFO - ENV: RUST_BACKTRACE is now 1 05:33:55 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 05:33:55 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:33:55 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/Q8LbqfWYRpSDg2F3Fudimw/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-063', '--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 05:33:55 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/Q8LbqfWYRpSDg2F3Fudimw/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-063 --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 05:33:55 INFO - Using env: {'DISPLAY': ':0', 05:33:55 INFO - 'HOME': '/home/cltbld', 05:33:55 INFO - 'LANG': 'en_US.UTF-8', 05:33:55 INFO - 'LANGUAGE': 'en_US:en', 05:33:55 INFO - 'LOGNAME': 'cltbld', 05:33:55 INFO - 'MAIL': '/var/mail/cltbld', 05:33:55 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:33:55 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 05:33:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:33:55 INFO - 'MOZ_NO_REMOTE': '1', 05:33:55 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:33:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:33:55 INFO - 'NO_EM_RESTART': '1', 05:33:55 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:33:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:33:55 INFO - 'PWD': '/builds/slave/test', 05:33:55 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:33:55 INFO - 'RUST_BACKTRACE': '1', 05:33:55 INFO - 'SHELL': '/bin/bash', 05:33:55 INFO - 'SHLVL': '1', 05:33:55 INFO - 'TERM': 'linux', 05:33:55 INFO - 'TMOUT': '86400', 05:33:55 INFO - 'USER': 'cltbld', 05:33:55 INFO - 'XDG_SESSION_COOKIE': '769a0cfe1e83e11e6f11f5a3000001a8-1495887323.97418-2031241851', 05:33:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:33:55 INFO - '_': '/tools/buildbot/bin/python'} 05:33:55 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/Q8LbqfWYRpSDg2F3Fudimw/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-063', '--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 05:33:55 INFO - mozversion application_buildid: 20170527120216 05:33:55 INFO - mozversion application_changeset: 66c73b65bf2d02c59f361b89135dc56553c3e4eb 05:33:55 INFO - mozversion application_display_name: Nightly 05:33:55 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:33:55 INFO - mozversion application_name: Firefox 05:33:55 INFO - mozversion application_remotingname: firefox 05:33:55 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 05:33:55 INFO - mozversion application_vendor: Mozilla 05:33:55 INFO - mozversion application_version: 55.0a1 05:33:55 INFO - mozversion platform_buildid: 20170527120216 05:33:55 INFO - mozversion platform_changeset: 66c73b65bf2d02c59f361b89135dc56553c3e4eb 05:33:55 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 05:33:55 INFO - mozversion platform_version: 55.0a1 05:33:55 INFO - using testdate: 1495888435 05:33:55 INFO - actual date: 1495888435 05:33:55 INFO - starting webserver on 'localhost:60719' 05:33:55 INFO - SUITE-START | Running 2 tests 05:33:55 INFO - TEST-START | dromaeo_css 05:33:55 INFO - operating with platform_type : linux_ 05:33:55 INFO - Initialising browser for dromaeo_css test... 05:33:55 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:60719/getInfo.html -profile /tmp/tmppuphZo/profile 05:33:55 INFO - TEST-INFO | started process 19939 (/builds/slave/test/build/application/firefox/firefox http://localhost:60719/getInfo.html) 05:34:30 INFO - TEST-INFO | 19939: killed by SIGTERM 05:34:30 INFO - Browser initialized. 05:34:30 INFO - Running cycle 1/1 for dromaeo_css test... 05:34:30 INFO - TEST-INFO | started process 20137 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmppuphZo/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:34:42 INFO - PID 20137 | RSS: Main: 183984128 05:34:42 INFO - PID 20137 | 05:37:46 INFO - PID 20137 | Cycle 1(1): loaded http://localhost:60719/tests/dromaeo/cssquery-dojo.html (next: http://localhost:60719/tests/dromaeo/cssquery-ext.html) 05:37:48 INFO - PID 20137 | RSS: Main: 180314112 05:37:48 INFO - PID 20137 | 05:40:50 INFO - PID 20137 | Cycle 1(1): loaded http://localhost:60719/tests/dromaeo/cssquery-ext.html (next: http://localhost:60719/tests/dromaeo/cssquery-jquery.html) 05:40:50 INFO - PID 20137 | RSS: Main: 183455744 05:40:50 INFO - PID 20137 | 05:43:52 INFO - PID 20137 | Cycle 1(1): loaded http://localhost:60719/tests/dromaeo/cssquery-jquery.html (next: http://localhost:60719/tests/dromaeo/cssquery-mootools.html) 05:43:53 INFO - PID 20137 | RSS: Main: 182591488 05:43:53 INFO - PID 20137 | 05:46:54 INFO - PID 20137 | Cycle 1(1): loaded http://localhost:60719/tests/dromaeo/cssquery-mootools.html (next: http://localhost:60719/tests/dromaeo/cssquery-prototype.html) 05:46:55 INFO - PID 20137 | RSS: Main: 184758272 05:46:55 INFO - PID 20137 | 05:49:58 INFO - PID 20137 | Cycle 1(1): loaded http://localhost:60719/tests/dromaeo/cssquery-prototype.html (next: http://localhost:60719/tests/dromaeo/cssquery-yui.html) 05:49:58 INFO - PID 20137 | RSS: Main: 184037376 05:49:58 INFO - PID 20137 | 05:53:00 INFO - PID 20137 | Cycle 1(1): loaded http://localhost:60719/tests/dromaeo/cssquery-yui.html (next: http://localhost:60719/tests/dromaeo/cssquery-dojo.html) 05:53:00 INFO - PID 20137 | RSS: Main: 181321728 05:53:00 INFO - PID 20137 | 05:53:00 INFO - PID 20137 | __start_tp_report 05:53:00 INFO - PID 20137 | _x_x_mozilla_page_load 05:53:00 INFO - PID 20137 | _x_x_mozilla_page_load_details 05:53:00 INFO - PID 20137 | |i|pagename|runs| 05:53:00 INFO - PID 20137 | |0;dojo.html;2695.3396417877616;2702.405470796424;2721.578155385916;2731.8087733858633;2742.561190209567;5191.922121168185;5195.142801437763;5233.685978841268;5235.267062611238;5246.291750613666;5215.452377500355;5228.79084836606;5300.09898317286;5320.068987927107;5321.4412486688925;4493.168763778695;4651.604613607848;4710.74090924999;4733.952660473386;4746.050789842028;4787.976060119695;4824.734639594821;4832.395950506187;4840.225563909775;4840.5159484051665;4650.604698600623;4686.648501362377;4717.905641887143;4778.784954677048;4805.975970120162;4740.502247264057;4745.21703918853;4753.405824271966;4765.356676848615;4794.256890182028;4694.178518759203;4719.150552900476;4728.550787675165;4734.739589322586;4762.476127625959;5174.560162386202;5192.0394726975255;5280.6039547034125;5284.471552844685;5312.415634280226;5577.637453565505;5675.404082571312;5677.347105082927;5705.6006079574445;5727.684977326246;5737.942620573825;5743.282089738783;5744.540436765049;5748.42515748426;5777.335606405275;5337.733113344356;5344.278522399504;5346.251524786533;5348.1175606025345;5348.3849357323625;5788.623739456922;5810;5876.059830427112;5889.882202355929;5906.350301466835;5578.888422231533;5605.831825045255;5630.943690563124;5651.265335506358;5658.519025882846;5570.526505247019;5672.8865422691315;5688.317401911797;5694.971525142348;5708.885822283531;5573.637713548606;5668.064769313017;5671.035923892866;5676.8864622707315;5680.318361796528;5610.158476228598;5625.578081643893;5688.488036076773;5702.8289151325525;5708.457696518824;4740.739259340769;4741.028089241697;4746.691465054761;4781.019890922353;4782;4060.3503439449546;4068.7355321903983;4076.490438695163;4080.3063479208013;4115.753054816721;4739.810407583658;4758.78585463655;4779.761011949388;4843.660943733976;4858.489858564871;5725.026745453283;5728;5738.8278351649515;5779.306483222041;5793.159991801165;4793.1372352976105;4793.904121917542;4794.208955522369;4794.904101917942;4830.830920917751;4991.301217829507;5057.393112826484;5069.493050694901;5077.23841423782;5077.822276220315;5247.265382846328;5313.468653134656;5328.6802791832615;5338.519533242027;5340.465953404629;5580.832575022756;5673.290838645169;5673.631213971079;5803.593748437569;5848.795292164754;5185.7407129644125;5199.818006369759;5216.817411390583;5324.9467505326;5328.17413300939;5643.774249030157;5645.717714114196;5649.265595472727;5663.490285874126;5664.915026274692;5619.915701264566;5759.94240057594;5762.625429347079;5767.279090113736;5770;5461.590380721541;5529.474699903502;5558.138488534284;5575.9163612545035;5606.103023516218;5509.944900551103;5517.062099443024;5533.225348451139;5542.224088627515;5565.415631358811;5411.080116380146;5442.374126975448;5448.019356515865;5451.236826844324;5456.48163424474;5514.751836167302;5524.254225679482;5592.664440133605;5614.21401003868;5614.803481878114;5470.288862447856;5475.397706252389;5494.725263736717;5528.91706624409;5531.419200983839 05:53:00 INFO - PID 20137 | |1;ext.html;645.519088279232;713.9647511108892;738.8559230949963;1041;1047.9109275711564;32379.514307285408;33236.83381583092;33252.66747332526;33281.833590832015;33295.66704332956;35053.123671908215;35282.8235858821;35442;35447;35503.46744798824;6766.898496522556;6816.897746533806;6925.065116209323;6947.444204463631;7012.684429200698;6821.317868213164;6827.317268273157;6827.658617069152;6830.863382732342;6835.692393842289;6762;6898.517103802736;6912.654367281641;6917.619530925797;6918.481113916451;6848.2809305023;6864.38220560152;6870.20992585854;6896.241413444517;6901.516893817435;6874;6874.484413668994;6901.75843845468;6902.585844849325;6907.689153988083;32523.83738081318;32843;32877.83561082203;33098.338033239444;33114;3035;3058.7247147756807;3065.4941934580766;3077.9538306925415;3079.0916679579577;24369.26892193237;24664.876675616506;24775.132870349633;24835.50328993428;24909.377265568506;3051.282948507121;3060.7551395888277;3089.212250876012;3140.576022236992;3174.5714328565577;123105.38447307795;125502.37248813789;142586;143813.2809335957;144413;38709.22581548353;39241.21517569633;39300.803495982334;39321.80339098286;39339.21321573552;40489.79755101265;40537.433395647444;40687.796561017596;40771;40797.18405631871;12177.086718496148;12362.134650574553;12373.505059797508;12390.62828115158;12445.75108497825;9821.607135714634;9825;9901.950490247502;9913.553890074963;9917.206623470105;12452.937735311265;12640;12683.746325073447;12708.555200567936;12753.872461275454;5355.116405793001;5382.192671099288;5404.405515393303;5444.346678398539;5513.917291240635;828.6022709099545;877.9429337093069;892.7768057985504;917.3211823250747;917.9036201198778;20186.697199542017;20810.79189208119;21059.262925797524;21808.345749627537;21885.452863678536;958.1137447860701;973.3721749471551;974.3763991045737;979.6130528441369;986.7878406142714;10579.94710026445;11419.48612312448;11426.714332141762;11491.195616306779;11521.654350369503;178030;178503;178829.1058544699;179449.1027544854;179539;40093.79953100216;40266.39600405996;40478.392824107665;40494.19011619751;40582.79708601438;1168.1571841666937;1215.392303848076;1219.9268043917216;1222.6515443098674;1232.9383530823422;19433;19750.25993761458;20170.495737606678;21019.369418917457;21252.78747212508;29141.834326627544;29159.708402915698;36741.816290918374;37439.251214976095;37447.62552374441;162569;163257;163332;164779;164957;30081.69918300789;30097.3980520384;30098.398032039673;30101.69898300989;30511.237219069702;35330.817107005656;35645.46531802077;35992.64007359893;36113.45829812502;36277.27445451129;27299.181024569294;27787.305317367227;27817.860910695315;28025.859870700515;28544.42911141807;26811.32971675724;27269.181924542296;27927;28012;28956;29924;30264;30672.386552268385;30825;31362.52956205613;26631.866840665672;26869.370157023783;27114.864425678534;27392;28617.42765144727;20190.394288171377;22186.667199992335;22375;22446;22543.774562254166 05:53:00 INFO - PID 20137 | |2;jquery.html;409.3552654569053;409.6313318013789;427.6471910673693;429.5554101504941;432.58904041160895;17115.743263851036;17533.298668053296;17780;17838.126996665356;18195.09024548774;18616;18770.249190032384;18775.155118019688;18933.810661893378;18989.33537326194;5451.972740136293;5518.392976772552;5660.745266463019;5662.320521537401;5676.233708449368;5196.090684130281;5333.573314134879;5335.626506144571;5338.492843179892;5339.092354299778;5275.736213189344;5293.814716484924;5306.602004849632;5308.840734777944;5331.040412725708;5299.390570084432;5502.532284755801;5513.283273174502;5528.06022976095;5532.502074813266;4914.385701787277;4965.82619608312;4971.950280497185;4988.201887697951;4998.40019197695;22030.228941987112;22659.77340226593;22717.797207516498;22740.772592274032;22797.20209792666;1621.683771664526;1634.485137181784;1658.9336426542923;1661.9085950272731;1671.3982966132182;14381.424743010371;14511.927440362731;14651.706965860729;14845.628859278497;14875.33061012257;2021.9191232350688;2087.499000239947;2117.809397154248;2127.5213077057538;2136.0174319812904;89350.55324723334;90577;94308;94786.52606736922;94915.99999999932;10746.462676866126;10988.120950323955;11069.335839849473;11121.944390277997;11292.887071129348;15383.153926534149;15418.691626167638;15505.658415643638;15528.767068493982;15529.611759706098;7766.611669416619;7943.9602801986775;8092;8126.878096828552;8146.063202731643;7415.406767458699;7509.662065207079;7515.8496830063095;7709.691612335556;7710.074791025113;6777.525573209828;6899.17209934801;6980.232174460805;6999.685014174374;7040.542364746275;1958.5495336072784;1998.8001199880187;2001.3495613925531;2006.889621070826;2117.9894100529705;824.3611201318906;852.5609311204735;872.3500991761051;889.9065598112235;896.7982204004178;16999.830001699826;17041.48875533736;17085;17457.254274572697;17749.55626109332;879.3229213505565;881.378628067211;882.289756745813;886.8492356299445;911.2300106410073;9037.367384283169;9249.90750092504;9465.432074075577;9624.085711857362;9734.269929755297;372141;373391;374806;377812;378402;71505.6424717873;73069.26930730624;73363.26636733564;73750;74936.37977151736;1005.2008653120787;1020.321486211661;1052.3265110329396;1052.9362449598873;1056.250062455665;14295.57113286603;14592.562223133324;14819.481318153812;14854.034487758261;15413.76879346833;36930;37587;38016.239675206896;38114;38161.04597385087;45227.54772452365;45327.546724533655;46161.76919115383;47007.76496117497;47672;7704.114026886979;7773.494722842997;7789.844203116019;7996.440249182501;8222.259996600334;11515.481803318704;11524.078073754246;11734.589289374831;11906.583269585522;11947;9494.192993595621;9563.995780443232;9752.366096203725;9896.257780666334;10165.085142337226;9153.86269205949;9175.77060573491;9237.337279289792;9246.445213287225;9382.906170938204;9343.672971446238;9530.237580993642;9618.759531011781;9894.950525247328;10126.392416455037;7544.283293087148;7732.458727888994;7806.726764563213;7842.607869606611;7882.251186137308;9377.249820014245;9398.530073496435;9437.575309111244;9588.232941364813;9647.855282170913 05:53:00 INFO - PID 20137 | |3;mootools.html;1288.5618889577543;1342.161149281699;1354.4785257675799;1357.3349058961112;1360.2994457854206;10038.54826532806;10198.592056317757;10435;10447.686569402911;10470.685879423629;10275.075243228108;10412.791744165112;10432.061114499713;10456.477176141181;10481.790364192731;2017.3241963942096;2031.5936812637458;2050.3233932802214;2055.5580550181708;2058.691196320549;1912.005757006356;1979.2083166733278;1991.3926252492984;1998.5203551147692;2007.65869802134;1940.8447324214028;1951.6779731344382;1959.098814545311;1965.980340196594;1968.0258272155231;1907.5898681783415;1908.3797765726194;1911.139987005846;1912.2159914435015;1916.176044300943;1871.5414723392719;1894.1192345559243;1967.478618166187;1968.4389948864505;1970.4876732049627;10094.444805535693;10210.132138768213;10214.642487512976;10216.33593816407;10233.385996840214;5462.453754624546;5634.577406694514;5657.547396208293;5665.093585026417;5681.829545113612;3234.7897386670024;3331.916702082443;3382.6279109297957;3410.6248312685584;3411.573553305837;1027.9126274266696;1060.0618452669444;1066.2749330455288;1071.9892801072046;1079.169039839327;14873.925630371887;15297.61755956099;15463;15478.61303467411;15647.765283520755;4649.628029757611;4747.620190384761;4833.275008748646;4856.854294371175;4869.683470574401;11055.226134170693;11081.224314298082;11173.05029072538;11222;11253.381064041392;5456.399796022434;5517.2551705519245;5553;5558.555315574825;5559.221708960748;5151.793928242903;5210.036143313499;5218.9739051304505;5239.292695486137;5310.256564081032;3644.6173151818675;3720.330340538729;3721.1255354992095;3752.4371344298575;3820.178661587772;1059.3326204491275;1070.882202957674;1072.0780129088978;1072.1637123044038;1080.4651697409674;714.3499415531945;729.3071581997124;740.3336996702902;747.9925200748032;754.4304050441991;5602.439756024446;5678.894617119095;5787.102999035156;5869.090291004901;5884.47039766423;524.5672320335663;540.9972950135224;543.8585967648361;545.7516829842413;552.0642510943911;3474.42671959129;3476.2526056897887;3485.755997080231;3535;3680.4663323817895;13165.60503184906;13228.669283267995;13521.797173042412;13698.794518082237;13706;13398.799018014737;13583.45666173342;13625.523106691417;13723.245221512912;14113.08264962774;6821.829454263683;7425.665845036986;7528.284812942762;7550.735724249735;7590.127135379392;6194.938050619436;6203.720832562455;6326.873462530815;6579.440747536513;6870.072540207008;11973.820392693942;12244.877551224374;12321.137520373488;12331.69170770738;12520.812187817372;12092.576759813364;12409;12526.874731252936;12586.685332866751;12608;8485.915140848512;8653.524056176971;8689.13108689126;8693.826123477369;8757.299416046828;9822.263330250116;9992.350497217658;10010.549525271235;10037.046480584333;10052.145567626541;8247.422680412314;8440.198181172778;8544.145585441654;8545.273651739422;8728.607212675572;8325;8368.163183681583;8409.95795021021;8477.279431248413;8629.95685021596;7389.519681220703;7447.180810110992;7490.662920168496;7504.474686771873;7515.8872616911885;5482.945170548403;5526.751296191762;5555.194496798023;5631.690257035739;5781.768729250783;5575.553955683455;5663.546916246608;5669.177969194526;5743.023685973311;5789.392113828156 05:53:00 INFO - PID 20137 | |4;prototype.html;367.4378201351931;369.68761396619857;369.9149195684994;373.132467014192;375.47246119202515;5435.809746658868;5525.198846167308;5529.30883639545;5530.4746049125315;5581.190727344532;5328.706921119337;5429.592780541465;5434.646747961379;5442.401335853053;5467.808626698056;4019.839206431739;4088;4108.506979162505;4108.794560271989;4109.876703698894;4045.939310910339;4064.61386168315;4100.425940368351;4108.4864391951005;4127.607877251671;3989.461422707941;3995.6004399559956;4001.7198796084285;4003.978985358744;4014.498187726534;3972.483577134983;4011.3352958522178;4063.2686116499017;4068.2880495913246;4089.5092588889224;3605.549306336708;3610.7472476926628;3611.277744451094;3613.313470440608;3621.4567814827724;5261.921071183935;5286.04851126797;5322.92015619766;5333.679979201261;5351.357837059578;4725.692829966041;4804.975975120102;4826.927596086027;4839.540243676845;4853.126437241295;5765.1352297155345;5813.157092221646;5821.50517206038;5826.242588463515;5834.183214349994;4016.357382818764;4031.9798401007806;4039.272930872442;4050.3191175662064;4055.634992850628;6043.576949613529;6112.877742445171;6130.141780150738;6164.229471316085;6199.411055949678;4137.606927341898;4145.253854306194;4147.419361289422;4148.605882441163;4150.8547200847825;4135.441715368447;4176.979115104405;4190.664746820247;4191.371294305878;4201.852935147316;4680.859574212779;4788.797153309517;4817.566419022235;4817.78319975602;4836.540528649773;5774.740136693859;5793.391693872083;5811.389804070596;5834.5624078194305;5836.387179346192;1428.428628548589;1429.2353590828857;1439.201243309973;1441.502681574855;1445.0390490324028;903.7198468474794;910.1217325281135;961.1349785193382;969.1471505075489;974.6734843827255;4987.700737955734;5003.424606170337;5014.924776128361;5019.623528235397;5028.974855125701;5951.315598706205;5985.910211346833;5988.041913293852;5988.4909782668965;5990.251218597676;4826.61387089032;4934.1135435770475;4947.406311242602;4966.304717339575;4984.800607975713;3149.401613693391;3183.968160318367;3186;3190.8564114614896;3199.6800319967815;5422.647527910752;5526.668399895939;5539.307586551681;5549.306336707911;5551.861203469864;6044.9395506044375;6086.939130608637;6118.5716999810475;6141.140240366352;6160.353162917919;5281.947180528223;5336.1195402758885;5421.891562168735;5489.204065410573;5519.116941289374;6001.309849367379;6020.193941817525;6025.608335458356;6028.6985650716415;6040.516758659209;5761.596688231783;5907.49786268172;5931.169636251015;5965.224520812267;5993.891130140938;5509.118541033576;5515.972420137874;5535.529479994246;5546.7781288748;5562.833115006556;4501.3022981437925;4546.954530454653;4549.408576884984;4550.067236216634;4556;5938.18885240006;6018.0581718974145;6028.547858910511;6029.306629737636;6050.273967123973;5806.983777838946;5831.70841457917;5832.679202643895;5853.765849365977;5874.676892770768;5641.717914104361;5790.681512516852;5828.125781132694;5834.970825146017;5836.970815145897;5721.427857214412;5727.599068065196;5743.396943320891;5750.1249375312345;5768.221290125779;5796.246487956539;5877.324107727666;5879;5892.410758924073;5898.734556944862;5603.215549822947;5615.7192140392;5634.52106570946;5651.095824668033;5662.094064949588 05:53:00 INFO - PID 20137 | |5;yui.html;735.1031741275649;763.7632333976468;774.4114473000521;780.4107898536604;781.894444250026;13876.236806975612;14196.574102776933;14202.857971420282;14369.640758981031;14512.129272243646;13680.315984200775;13754.312284385765;13877.236751978637;14001.509947151852;14175.574732758034;849.4308813095241;881.1849039638341;903.8101998580306;907.1971305394708;909.0182602789005;889.9866502002475;903.5753195997903;905.0813424374265;905.8414777413959;906.3429013964856;930.5626355612851;948.6964171465133;949.1410273702311;949.7150854743584;952.105021279998;935.7473482159813;939.7079016352516;941.8963913969458;946.2713710442989;950.1353768071091;687.3676217879563;689.7861662884521;693.1231991530718;693.8646963842053;693.8924466707668;14370.065945713495;15078.170700611461;15238.314275857612;15288;15294.00588961714;15575.454859079991;16002.43991460305;16026.118563479004;16038.35846566136;16081.758773618405;12651.114421990464;12806.231626102464;12920.095593308472;12933.48266069356;12952.935235323857;3051.3744682340066;3074.938501229963;3076.7538596912195;3078.0304204175836;3090.9536356954663;81008.18991810124;81887;82044.58977705073;82214.58892705558;82554.17445825585;11861.229020113666;12425;13362.265075420944;13378.799318010238;13472.663183420296;22466.887665561568;23012.309630711105;23170.536589268122;23382.298531044096;23400.06399744025;6385.45723613498;6539.607623542603;6570.178727659043;6570.474362051024;6575.967120164464;3015.8190508569555;3084.5373194021076;3090.227443139215;3090.891818786332;3095.613048368954;3547.6629720176543;3605.3330133925306;3694.4273637586216;3810.8666196682984;3823.5794062653085;764.2357642357642;781.1602527283193;785.4972817396871;786.4966421490251;792.2038351456749;561.3656568078046;582.0251079441917;586.8063539032195;604;612.9172561704202;9452.8582071269;9783.559739811582;10214.795704085876;10292.588296468057;10488.737781555523;584.5966283264619;587.5857520448074;587.917691523187;592.0408937521244;595.6783336997972;4411.933820992687;4608.3778689876435;4644.674872758875;4651.744154071558;4652.604528615106;73689;74176.62911685515;74552;76726;83370.16629833746;64434.67782661151;66198.33801662018;66475.33524664788;66992.6650366745;68340;57966;58670.11994820081;60861.69569152126;60916.69541652352;61292.69353653203;9008.513595256709;9270.304727145356;9396.342256042011;9427.717168484956;9671.226301895973;27669;28190.577141342485;28514;28706.99525516597;29019.56470652984;34552.48171277483;35014.82492587521;35394.46908296326;35623.28753424969;35817;14396.20820854821;14726.558203253919;14851.777223341875;14933.775993360325;15091.698166036398;16208.67582648364;16366.263518141473;16441.424550140688;16501.91749041247;16621.0858402789;13245.735085298433;13504.459821607026;13578.117422367515;13702.45190192421;13842.169469831842;13530.323483825967;13623.455061797416;14111.153330800185;14132.010759246754;14133.222672753098;13321.067525273138;13387.933060334635;13436.529721459701;13455.529056482976;13587.45650173982;9720.659776907774;9786.510674466106;9923.950380248052;10137.898621013695;10372.377657340583;10470.057694807503;10626.309289896131;10877;11034.779304413707;11043.558257669603 05:53:00 INFO - PID 20137 | __end_tp_report 05:53:00 INFO - PID 20137 | __start_cc_report 05:53:00 INFO - PID 20137 | _x_x_mozilla_cycle_collect,377 05:53:00 INFO - PID 20137 | __end_cc_report 05:53:00 INFO - PID 20137 | __startTimestamp1495889580796__endTimestamp 05:53:00 INFO - PID 20137 | 05:53:00 INFO - PID 20137 | ------- Summary: start ------- 05:53:00 INFO - PID 20137 | Number of tests: 6 05:53:00 INFO - PID 20137 | 05:53:00 INFO - PID 20137 | [#0] dojo.html Cycles:165 Average:5209.58 Median:5346.25 stddev:616.71 (11.5%) stddev-sans-first:586.21 05:53:00 INFO - PID 20137 | Values: 2695.3 2702.4 2721.6 2731.8 2742.6 5191.9 5195.1 5233.7 5235.3 5246.3 5215.5 5228.8 5300.1 5320.1 5321.4 4493.2 4651.6 4710.7 4734.0 4746.1 4788.0 4824.7 4832.4 4840.2 4840.5 4650.6 4686.6 4717.9 4778.8 4806.0 4740.5 4745.2 4753.4 4765.4 4794.3 4694.2 4719.2 4728.6 4734.7 4762.5 5174.6 5192.0 5280.6 5284.5 5312.4 5577.6 5675.4 5677.3 5705.6 5727.7 5737.9 5743.3 5744.5 5748.4 5777.3 5337.7 5344.3 5346.3 5348.1 5348.4 5788.6 5810.0 5876.1 5889.9 5906.4 5578.9 5605.8 5630.9 5651.3 5658.5 5570.5 5672.9 5688.3 5695.0 5708.9 5573.6 5668.1 5671.0 5676.9 5680.3 5610.2 5625.6 5688.5 5702.8 5708.5 4740.7 4741.0 4746.7 4781.0 4782.0 4060.4 4068.7 4076.5 4080.3 4115.8 4739.8 4758.8 4779.8 4843.7 4858.5 5725.0 5728.0 5738.8 5779.3 5793.2 4793.1 4793.9 4794.2 4794.9 4830.8 4991.3 5057.4 5069.5 5077.2 5077.8 5247.3 5313.5 5328.7 5338.5 5340.5 5580.8 5673.3 5673.6 5803.6 5848.8 5185.7 5199.8 5216.8 5324.9 5328.2 5643.8 5645.7 5649.3 5663.5 5664.9 5619.9 5759.9 5762.6 5767.3 5770.0 5461.6 5529.5 5558.1 5575.9 5606.1 5509.9 5517.1 5533.2 5542.2 5565.4 5411.1 5442.4 5448.0 5451.2 5456.5 5514.8 5524.3 5592.7 5614.2 5614.8 5470.3 5475.4 5494.7 5528.9 5531.4 05:53:00 INFO - PID 20137 | 05:53:00 INFO - PID 20137 | [#1] ext.html Cycles:180 Average:30497.43 Median:17225.87 stddev:41454.29 (240.7%) stddev-sans-first:41509.98 05:53:00 INFO - PID 20137 | Values: 645.5 714.0 738.9 1041.0 1047.9 32379.5 33236.8 33252.7 33281.8 33295.7 35053.1 35282.8 35442.0 35447.0 35503.5 6766.9 6816.9 6925.1 6947.4 7012.7 6821.3 6827.3 6827.7 6830.9 6835.7 6762.0 6898.5 6912.7 6917.6 6918.5 6848.3 6864.4 6870.2 6896.2 6901.5 6874.0 6874.5 6901.8 6902.6 6907.7 32523.8 32843.0 32877.8 33098.3 33114.0 3035.0 3058.7 3065.5 3078.0 3079.1 24369.3 24664.9 24775.1 24835.5 24909.4 3051.3 3060.8 3089.2 3140.6 3174.6 123105.4 125502.4 142586.0 143813.3 144413.0 38709.2 39241.2 39300.8 39321.8 39339.2 40489.8 40537.4 40687.8 40771.0 40797.2 12177.1 12362.1 12373.5 12390.6 12445.8 9821.6 9825.0 9902.0 9913.6 9917.2 12452.9 12640.0 12683.7 12708.6 12753.9 5355.1 5382.2 5404.4 5444.3 5513.9 828.6 877.9 892.8 917.3 917.9 20186.7 20810.8 21059.3 21808.3 21885.5 958.1 973.4 974.4 979.6 986.8 10579.9 11419.5 11426.7 11491.2 11521.7 178030.0 178503.0 178829.1 179449.1 179539.0 40093.8 40266.4 40478.4 40494.2 40582.8 1168.2 1215.4 1219.9 1222.7 1232.9 19433.0 19750.3 20170.5 21019.4 21252.8 29141.8 29159.7 36741.8 37439.3 37447.6 162569.0 163257.0 163332.0 164779.0 164957.0 30081.7 30097.4 30098.4 30101.7 30511.2 35330.8 35645.5 35992.6 36113.5 36277.3 27299.2 27787.3 27817.9 28025.9 28544.4 26811.3 27269.2 27927.0 28012.0 28956.0 29924.0 30264.0 30672.4 30825.0 31362.5 26631.9 26869.4 27114.9 27392.0 28617.4 20190.4 22186.7 22375.0 22446.0 22543.8 05:53:00 INFO - PID 20137 | 05:53:00 INFO - PID 20137 | [#2] jquery.html Cycles:180 Average:24748.94 Median:4993.30 stddev:62464.85 (1251.0%) stddev-sans-first:62613.35 05:53:00 INFO - PID 20137 | Values: 409.4 409.6 427.6 429.6 432.6 17115.7 17533.3 17780.0 17838.1 18195.1 18616.0 18770.2 18775.2 18933.8 18989.3 5452.0 5518.4 5660.7 5662.3 5676.2 5196.1 5333.6 5335.6 5338.5 5339.1 5275.7 5293.8 5306.6 5308.8 5331.0 5299.4 5502.5 5513.3 5528.1 5532.5 4914.4 4965.8 4972.0 4988.2 4998.4 22030.2 22659.8 22717.8 22740.8 22797.2 1621.7 1634.5 1658.9 1661.9 1671.4 14381.4 14511.9 14651.7 14845.6 14875.3 2021.9 2087.5 2117.8 2127.5 2136.0 89350.6 90577.0 94308.0 94786.5 94916.0 10746.5 10988.1 11069.3 11121.9 11292.9 15383.2 15418.7 15505.7 15528.8 15529.6 7766.6 7944.0 8092.0 8126.9 8146.1 7415.4 7509.7 7515.8 7709.7 7710.1 6777.5 6899.2 6980.2 6999.7 7040.5 1958.5 1998.8 2001.3 2006.9 2118.0 824.4 852.6 872.4 889.9 896.8 16999.8 17041.5 17085.0 17457.3 17749.6 879.3 881.4 882.3 886.8 911.2 9037.4 9249.9 9465.4 9624.1 9734.3 372141.0 373391.0 374806.0 377812.0 378402.0 71505.6 73069.3 73363.3 73750.0 74936.4 1005.2 1020.3 1052.3 1052.9 1056.3 14295.6 14592.6 14819.5 14854.0 15413.8 36930.0 37587.0 38016.2 38114.0 38161.0 45227.5 45327.5 46161.8 47007.8 47672.0 7704.1 7773.5 7789.8 7996.4 8222.3 11515.5 11524.1 11734.6 11906.6 11947.0 9494.2 9564.0 9752.4 9896.3 10165.1 9153.9 9175.8 9237.3 9246.4 9382.9 9343.7 9530.2 9618.8 9895.0 10126.4 7544.3 7732.5 7806.7 7842.6 7882.3 9377.2 9398.5 9437.6 9588.2 9647.9 05:53:00 INFO - PID 20137 | 05:53:00 INFO - PID 20137 | [#3] mootools.html Cycles:180 Average:6377.35 Median:3396.63 stddev:4197.21 (123.6%) stddev-sans-first:4191.57 05:53:00 INFO - PID 20137 | Values: 1288.6 1342.2 1354.5 1357.3 1360.3 10038.5 10198.6 10435.0 10447.7 10470.7 10275.1 10412.8 10432.1 10456.5 10481.8 2017.3 2031.6 2050.3 2055.6 2058.7 1912.0 1979.2 1991.4 1998.5 2007.7 1940.8 1951.7 1959.1 1966.0 1968.0 1907.6 1908.4 1911.1 1912.2 1916.2 1871.5 1894.1 1967.5 1968.4 1970.5 10094.4 10210.1 10214.6 10216.3 10233.4 5462.5 5634.6 5657.5 5665.1 5681.8 3234.8 3331.9 3382.6 3410.6 3411.6 1027.9 1060.1 1066.3 1072.0 1079.2 14873.9 15297.6 15463.0 15478.6 15647.8 4649.6 4747.6 4833.3 4856.9 4869.7 11055.2 11081.2 11173.1 11222.0 11253.4 5456.4 5517.3 5553.0 5558.6 5559.2 5151.8 5210.0 5219.0 5239.3 5310.3 3644.6 3720.3 3721.1 3752.4 3820.2 1059.3 1070.9 1072.1 1072.2 1080.5 714.3 729.3 740.3 748.0 754.4 5602.4 5678.9 5787.1 5869.1 5884.5 524.6 541.0 543.9 545.8 552.1 3474.4 3476.3 3485.8 3535.0 3680.5 13165.6 13228.7 13521.8 13698.8 13706.0 13398.8 13583.5 13625.5 13723.2 14113.1 6821.8 7425.7 7528.3 7550.7 7590.1 6194.9 6203.7 6326.9 6579.4 6870.1 11973.8 12244.9 12321.1 12331.7 12520.8 12092.6 12409.0 12526.9 12586.7 12608.0 8485.9 8653.5 8689.1 8693.8 8757.3 9822.3 9992.4 10010.5 10037.0 10052.1 8247.4 8440.2 8544.1 8545.3 8728.6 8325.0 8368.2 8410.0 8477.3 8630.0 7389.5 7447.2 7490.7 7504.5 7515.9 5482.9 5526.8 5555.2 5631.7 5781.8 5575.6 5663.5 5669.2 5743.0 5789.4 05:53:00 INFO - PID 20137 | 05:53:00 INFO - PID 20137 | [#4] prototype.html Cycles:180 Average:4766.28 Median:5432.12 stddev:1419.01 (26.1%) stddev-sans-first:1384.05 05:53:00 INFO - PID 20137 | Values: 367.4 369.7 369.9 373.1 375.5 5435.8 5525.2 5529.3 5530.5 5581.2 5328.7 5429.6 5434.6 5442.4 5467.8 4019.8 4088.0 4108.5 4108.8 4109.9 4045.9 4064.6 4100.4 4108.5 4127.6 3989.5 3995.6 4001.7 4004.0 4014.5 3972.5 4011.3 4063.3 4068.3 4089.5 3605.5 3610.7 3611.3 3613.3 3621.5 5261.9 5286.0 5322.9 5333.7 5351.4 4725.7 4805.0 4826.9 4839.5 4853.1 5765.1 5813.2 5821.5 5826.2 5834.2 4016.4 4032.0 4039.3 4050.3 4055.6 6043.6 6112.9 6130.1 6164.2 6199.4 4137.6 4145.3 4147.4 4148.6 4150.9 4135.4 4177.0 4190.7 4191.4 4201.9 4680.9 4788.8 4817.6 4817.8 4836.5 5774.7 5793.4 5811.4 5834.6 5836.4 1428.4 1429.2 1439.2 1441.5 1445.0 903.7 910.1 961.1 969.1 974.7 4987.7 5003.4 5014.9 5019.6 5029.0 5951.3 5985.9 5988.0 5988.5 5990.3 4826.6 4934.1 4947.4 4966.3 4984.8 3149.4 3184.0 3186.0 3190.9 3199.7 5422.6 5526.7 5539.3 5549.3 5551.9 6044.9 6086.9 6118.6 6141.1 6160.4 5281.9 5336.1 5421.9 5489.2 5519.1 6001.3 6020.2 6025.6 6028.7 6040.5 5761.6 5907.5 5931.2 5965.2 5993.9 5509.1 5516.0 5535.5 5546.8 5562.8 4501.3 4547.0 4549.4 4550.1 4556.0 5938.2 6018.1 6028.5 6029.3 6050.3 5807.0 5831.7 5832.7 5853.8 5874.7 5641.7 5790.7 5828.1 5835.0 5837.0 5721.4 5727.6 5743.4 5750.1 5768.2 5796.2 5877.3 5879.0 5892.4 5898.7 5603.2 5615.7 5634.5 5651.1 5662.1 05:53:00 INFO - PID 20137 | 05:53:00 INFO - PID 20137 | [#5] yui.html Cycles:180 Average:16582.13 Median:19711.17 stddev:21172.36 (107.4%) stddev-sans-first:21198.32 05:53:00 INFO - PID 20137 | Values: 735.1 763.8 774.4 780.4 781.9 13876.2 14196.6 14202.9 14369.6 14512.1 13680.3 13754.3 13877.2 14001.5 14175.6 849.4 881.2 903.8 907.2 909.0 890.0 903.6 905.1 905.8 906.3 930.6 948.7 949.1 949.7 952.1 935.7 939.7 941.9 946.3 950.1 687.4 689.8 693.1 693.9 693.9 14370.1 15078.2 15238.3 15288.0 15294.0 15575.5 16002.4 16026.1 16038.4 16081.8 12651.1 12806.2 12920.1 12933.5 12952.9 3051.4 3074.9 3076.8 3078.0 3091.0 81008.2 81887.0 82044.6 82214.6 82554.2 11861.2 12425.0 13362.3 13378.8 13472.7 22466.9 23012.3 23170.5 23382.3 23400.1 6385.5 6539.6 6570.2 6570.5 6576.0 3015.8 3084.5 3090.2 3090.9 3095.6 3547.7 3605.3 3694.4 3810.9 3823.6 764.2 781.2 785.5 786.5 792.2 561.4 582.0 586.8 604.0 612.9 9452.9 9783.6 10214.8 10292.6 10488.7 584.6 587.6 587.9 592.0 595.7 4411.9 4608.4 4644.7 4651.7 4652.6 73689.0 74176.6 74552.0 76726.0 83370.2 64434.7 66198.3 66475.3 66992.7 68340.0 57966.0 58670.1 60861.7 60916.7 61292.7 9008.5 9270.3 9396.3 9427.7 9671.2 27669.0 28190.6 28514.0 28707.0 29019.6 34552.5 35014.8 35394.5 35623.3 35817.0 14396.2 14726.6 14851.8 14933.8 15091.7 16208.7 16366.3 16441.4 16501.9 16621.1 13245.7 13504.5 13578.1 13702.5 13842.2 13530.3 13623.5 14111.2 14132.0 14133.2 13321.1 13387.9 13436.5 13455.5 13587.5 9720.7 9786.5 9924.0 10137.9 10372.4 10470.1 10626.3 10877.0 11034.8 11043.6 05:53:00 INFO - PID 20137 | -------- Summary: end -------- 05:53:00 INFO - PID 20137 | 05:53:01 INFO - TEST-INFO | 20137: exit 0 05:53:01 INFO - TEST-OK | dromaeo_css | took 1146429ms 05:53:01 INFO - TEST-START | kraken 05:53:01 INFO - operating with platform_type : linux_ 05:53:01 INFO - Initialising browser for kraken test... 05:53:01 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:60719/getInfo.html -profile /tmp/tmpHx6EIr/profile 05:53:01 INFO - TEST-INFO | started process 20549 (/builds/slave/test/build/application/firefox/firefox http://localhost:60719/getInfo.html) 05:53:36 INFO - TEST-INFO | 20549: killed by SIGTERM 05:53:36 INFO - Browser initialized. 05:53:36 INFO - Running cycle 1/1 for kraken test... 05:53:36 INFO - TEST-INFO | started process 20750 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpHx6EIr/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:53:49 INFO - PID 20750 | RSS: Main: 183390208 05:53:49 INFO - PID 20750 | 05:53:51 INFO - PID 20750 | Cycle 1(1): loaded http://localhost:60719/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:60719/tests/kraken/driver.html?testName=audio-beat-detection) 05:53:52 INFO - PID 20750 | RSS: Main: 186638336 05:53:52 INFO - PID 20750 | 05:53:55 INFO - PID 20750 | Cycle 1(1): loaded http://localhost:60719/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:60719/tests/kraken/driver.html?testName=audio-dft) 05:53:55 INFO - PID 20750 | RSS: Main: 185098240 05:53:55 INFO - PID 20750 | 05:53:58 INFO - PID 20750 | Cycle 1(1): loaded http://localhost:60719/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:60719/tests/kraken/driver.html?testName=audio-fft) 05:53:59 INFO - PID 20750 | RSS: Main: 181673984 05:53:59 INFO - PID 20750 | 05:54:01 INFO - PID 20750 | Cycle 1(1): loaded http://localhost:60719/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:60719/tests/kraken/driver.html?testName=audio-oscillator) 05:54:02 INFO - PID 20750 | RSS: Main: 182423552 05:54:02 INFO - PID 20750 | 05:54:04 INFO - PID 20750 | Cycle 1(1): loaded http://localhost:60719/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:60719/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:54:04 INFO - PID 20750 | RSS: Main: 182550528 05:54:04 INFO - PID 20750 | 05:54:08 INFO - PID 20750 | Cycle 1(1): loaded http://localhost:60719/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:60719/tests/kraken/driver.html?testName=imaging-darkroom) 05:54:08 INFO - PID 20750 | RSS: Main: 183689216 05:54:08 INFO - PID 20750 | 05:54:12 INFO - PID 20750 | Cycle 1(1): loaded http://localhost:60719/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:60719/tests/kraken/driver.html?testName=imaging-desaturate) 05:54:12 INFO - PID 20750 | RSS: Main: 183128064 05:54:12 INFO - PID 20750 | 05:54:15 INFO - PID 20750 | Cycle 1(1): loaded http://localhost:60719/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:60719/tests/kraken/driver.html?testName=json-parse-financial) 05:54:16 INFO - PID 20750 | RSS: Main: 183472128 05:54:16 INFO - PID 20750 | 05:54:18 INFO - PID 20750 | Cycle 1(1): loaded http://localhost:60719/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:60719/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:54:18 INFO - PID 20750 | RSS: Main: 183959552 05:54:18 INFO - PID 20750 | 05:54:20 INFO - PID 20750 | Cycle 1(1): loaded http://localhost:60719/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:60719/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:54:21 INFO - PID 20750 | RSS: Main: 183488512 05:54:21 INFO - PID 20750 | 05:54:23 INFO - PID 20750 | Cycle 1(1): loaded http://localhost:60719/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:60719/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:54:24 INFO - PID 20750 | RSS: Main: 183255040 05:54:24 INFO - PID 20750 | 05:54:26 INFO - PID 20750 | Cycle 1(1): loaded http://localhost:60719/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:60719/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:54:27 INFO - PID 20750 | RSS: Main: 183607296 05:54:27 INFO - PID 20750 | 05:54:30 INFO - PID 20750 | Cycle 1(1): loaded http://localhost:60719/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:60719/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:54:31 INFO - PID 20750 | RSS: Main: 183209984 05:54:31 INFO - PID 20750 | 05:54:33 INFO - PID 20750 | Cycle 1(1): loaded http://localhost:60719/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:60719/tests/kraken/driver.html?testName=ai-astar) 05:54:33 INFO - PID 20750 | RSS: Main: 184770560 05:54:33 INFO - PID 20750 | 05:54:33 INFO - PID 20750 | __start_tp_report 05:54:33 INFO - PID 20750 | _x_x_mozilla_page_load 05:54:33 INFO - PID 20750 | _x_x_mozilla_page_load_details 05:54:33 INFO - PID 20750 | |i|pagename|runs| 05:54:33 INFO - PID 20750 | |0;ai-astar;101;110;111;110;112;110;110;112;109;110 05:54:33 INFO - PID 20750 | |1;audio-beat-detection;151;133;124;170;124;129;128;122;146;129 05:54:33 INFO - PID 20750 | |2;audio-dft;165;165;165;166;168;169;170;163;164;163 05:54:33 INFO - PID 20750 | |3;audio-fft;73;74;75;112;75;76;74;76;99;75 05:54:33 INFO - PID 20750 | |4;audio-oscillator;86;83;112;84;83;84;98;86;85;110 05:54:33 INFO - PID 20750 | |5;imaging-gaussian-blur;115;115;114;114;114;115;116;115;114;115 05:54:33 INFO - PID 20750 | |6;imaging-darkroom;152;151;151;151;152;151;151;151;151;151 05:54:33 INFO - PID 20750 | |7;imaging-desaturate;96;95;94;94;95;95;95;95;95;94 05:54:33 INFO - PID 20750 | |8;json-parse-financial;54;56;58;55;55;56;56;60;55;55 05:54:33 INFO - PID 20750 | |9;json-stringify-tinderbox;56;57;56;57;56;56;56;56;56;63 05:54:33 INFO - PID 20750 | |10;stanford-crypto-aes;88;88;87;87;90;88;88;92;125;87 05:54:33 INFO - PID 20750 | |11;stanford-crypto-ccm;137;136;142;134;132;137;147;133;137;141 05:54:33 INFO - PID 20750 | |12;stanford-crypto-pbkdf2;183;195;191;193;196;207;192;192;192;198 05:54:33 INFO - PID 20750 | |13;stanford-crypto-sha256-iterative;75;75;72;72;73;73;75;72;72;73 05:54:33 INFO - PID 20750 | __end_tp_report 05:54:33 INFO - PID 20750 | __start_cc_report 05:54:33 INFO - PID 20750 | _x_x_mozilla_cycle_collect,1022 05:54:33 INFO - PID 20750 | __end_cc_report 05:54:33 INFO - PID 20750 | __startTimestamp1495889673385__endTimestamp 05:54:33 INFO - PID 20750 | 05:54:33 INFO - PID 20750 | ------- Summary: start ------- 05:54:33 INFO - PID 20750 | Number of tests: 14 05:54:33 INFO - PID 20750 | 05:54:33 INFO - PID 20750 | [#0] ai-astar Cycles:10 Average:109.50 Median:110.00 stddev:3.14 (2.9%) stddev-sans-first:1.01 05:54:33 INFO - PID 20750 | Values: 101.0 110.0 111.0 110.0 112.0 110.0 110.0 112.0 109.0 110.0 05:54:33 INFO - PID 20750 | 05:54:33 INFO - PID 20750 | [#1] audio-beat-detection Cycles:10 Average:135.60 Median:131.00 stddev:15.40 (11.8%) stddev-sans-first:15.29 05:54:33 INFO - PID 20750 | Values: 151.0 133.0 124.0 170.0 124.0 129.0 128.0 122.0 146.0 129.0 05:54:33 INFO - PID 20750 | 05:54:33 INFO - PID 20750 | [#2] audio-dft Cycles:10 Average:165.80 Median:165.50 stddev:2.44 (1.5%) stddev-sans-first:2.57 05:54:33 INFO - PID 20750 | Values: 165.0 165.0 165.0 166.0 168.0 169.0 170.0 163.0 164.0 163.0 05:54:33 INFO - PID 20750 | 05:54:33 INFO - PID 20750 | [#3] audio-fft Cycles:10 Average:80.90 Median:75.00 stddev:13.35 (17.8%) stddev-sans-first:13.85 05:54:33 INFO - PID 20750 | Values: 73.0 74.0 75.0 112.0 75.0 76.0 74.0 76.0 99.0 75.0 05:54:33 INFO - PID 20750 | 05:54:33 INFO - PID 20750 | [#4] audio-oscillator Cycles:10 Average:91.10 Median:84.50 stddev:11.37 (13.5%) stddev-sans-first:11.91 05:54:33 INFO - PID 20750 | Values: 86.0 83.0 112.0 84.0 83.0 84.0 98.0 86.0 85.0 110.0 05:54:33 INFO - PID 20750 | 05:54:33 INFO - PID 20750 | [#5] imaging-gaussian-blur Cycles:10 Average:114.70 Median:115.00 stddev:0.67 (0.6%) stddev-sans-first:0.71 05:54:33 INFO - PID 20750 | Values: 115.0 115.0 114.0 114.0 114.0 115.0 116.0 115.0 114.0 115.0 05:54:33 INFO - PID 20750 | 05:54:33 INFO - PID 20750 | [#6] imaging-darkroom Cycles:10 Average:151.20 Median:151.00 stddev:0.42 (0.3%) stddev-sans-first:0.33 05:54:33 INFO - PID 20750 | Values: 152.0 151.0 151.0 151.0 152.0 151.0 151.0 151.0 151.0 151.0 05:54:33 INFO - PID 20750 | 05:54:33 INFO - PID 20750 | [#7] imaging-desaturate Cycles:10 Average:94.80 Median:95.00 stddev:0.63 (0.7%) stddev-sans-first:0.50 05:54:33 INFO - PID 20750 | Values: 96.0 95.0 94.0 94.0 95.0 95.0 95.0 95.0 95.0 94.0 05:54:33 INFO - PID 20750 | 05:54:33 INFO - PID 20750 | [#8] json-parse-financial Cycles:10 Average:56.00 Median:56.00 stddev:1.76 (3.1%) stddev-sans-first:1.72 05:54:33 INFO - PID 20750 | Values: 54.0 56.0 58.0 55.0 55.0 56.0 56.0 60.0 55.0 55.0 05:54:33 INFO - PID 20750 | 05:54:33 INFO - PID 20750 | [#9] json-stringify-tinderbox Cycles:10 Average:56.90 Median:56.00 stddev:2.18 (3.9%) stddev-sans-first:2.29 05:54:33 INFO - PID 20750 | Values: 56.0 57.0 56.0 57.0 56.0 56.0 56.0 56.0 56.0 63.0 05:54:33 INFO - PID 20750 | 05:54:33 INFO - PID 20750 | [#10] stanford-crypto-aes Cycles:10 Average:92.00 Median:88.00 stddev:11.70 (13.3%) stddev-sans-first:12.32 05:54:33 INFO - PID 20750 | Values: 88.0 88.0 87.0 87.0 90.0 88.0 88.0 92.0 125.0 87.0 05:54:33 INFO - PID 20750 | 05:54:33 INFO - PID 20750 | [#11] stanford-crypto-ccm Cycles:10 Average:137.60 Median:137.00 stddev:4.58 (3.3%) stddev-sans-first:4.85 05:54:33 INFO - PID 20750 | Values: 137.0 136.0 142.0 134.0 132.0 137.0 147.0 133.0 137.0 141.0 05:54:33 INFO - PID 20750 | 05:54:33 INFO - PID 20750 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:193.90 Median:194.00 stddev:6.08 (3.1%) stddev-sans-first:5.01 05:54:33 INFO - PID 20750 | Values: 183.0 195.0 191.0 193.0 196.0 207.0 192.0 192.0 192.0 198.0 05:54:33 INFO - PID 20750 | 05:54:33 INFO - PID 20750 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:73.20 Median:73.00 stddev:1.32 (1.8%) stddev-sans-first:1.22 05:54:33 INFO - PID 20750 | Values: 75.0 75.0 72.0 72.0 73.0 73.0 75.0 72.0 72.0 73.0 05:54:33 INFO - PID 20750 | -------- Summary: end -------- 05:54:33 INFO - PID 20750 | 05:54:34 INFO - TEST-INFO | 20750: exit 0 05:54:34 INFO - TEST-OK | kraken | took 92830ms 05:54:34 INFO - SUITE-END | took 1239s 05:54:35 INFO - Completed test suite (00:20:39) 05:54:35 INFO - javascript benchmark 05:54:35 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6719.371153290956, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2695.3396417877616, 2702.405470796424, 2721.578155385916, 2731.8087733858633, 2742.561190209567, 5191.922121168185, 5195.142801437763, 5233.685978841268, 5235.267062611238, 5246.291750613666, 5215.452377500355, 5228.79084836606, 5300.09898317286, 5320.068987927107, 5321.4412486688925, 4493.168763778695, 4651.604613607848, 4710.74090924999, 4733.952660473386, 4746.050789842028, 4787.976060119695, 4824.734639594821, 4832.395950506187, 4840.225563909775, 4840.5159484051665, 4650.604698600623, 4686.648501362377, 4717.905641887143, 4778.784954677048, 4805.975970120162, 4740.502247264057, 4745.21703918853, 4753.405824271966, 4765.356676848615, 4794.256890182028, 4694.178518759203, 4719.150552900476, 4728.550787675165, 4734.739589322586, 4762.476127625959, 5174.560162386202, 5192.0394726975255, 5280.6039547034125, 5284.471552844685, 5312.415634280226, 5577.637453565505, 5675.404082571312, 5677.347105082927, 5705.6006079574445, 5727.684977326246, 5737.942620573825, 5743.282089738783, 5744.540436765049, 5748.42515748426, 5777.335606405275, 5337.733113344356, 5344.278522399504, 5346.251524786533, 5348.1175606025345, 5348.3849357323625, 5788.623739456922, 5810.0, 5876.059830427112, 5889.882202355929, 5906.350301466835, 5578.888422231533, 5605.831825045255, 5630.943690563124, 5651.265335506358, 5658.519025882846, 5570.526505247019, 5672.8865422691315, 5688.317401911797, 5694.971525142348, 5708.885822283531, 5573.637713548606, 5668.064769313017, 5671.035923892866, 5676.8864622707315, 5680.318361796528, 5610.158476228598, 5625.578081643893, 5688.488036076773, 5702.8289151325525, 5708.457696518824, 4740.739259340769, 4741.028089241697, 4746.691465054761, 4781.019890922353, 4782.0, 4060.3503439449546, 4068.7355321903983, 4076.490438695163, 4080.3063479208013, 4115.753054816721, 4739.810407583658, 4758.78585463655, 4779.761011949388, 4843.660943733976, 4858.489858564871, 5725.026745453283, 5728.0, 5738.8278351649515, 5779.306483222041, 5793.159991801165, 4793.1372352976105, 4793.904121917542, 4794.208955522369, 4794.904101917942, 4830.830920917751, 4991.301217829507, 5057.393112826484, 5069.493050694901, 5077.23841423782, 5077.822276220315, 5247.265382846328, 5313.468653134656, 5328.6802791832615, 5338.519533242027, 5340.465953404629, 5580.832575022756, 5673.290838645169, 5673.631213971079, 5803.593748437569, 5848.795292164754, 5185.7407129644125, 5199.818006369759, 5216.817411390583, 5324.9467505326, 5328.17413300939, 5643.774249030157, 5645.717714114196, 5649.265595472727, 5663.490285874126, 5664.915026274692, 5619.915701264566, 5759.94240057594, 5762.625429347079, 5767.279090113736, 5770.0, 5461.590380721541, 5529.474699903502, 5558.138488534284, 5575.9163612545035, 5606.103023516218, 5509.944900551103, 5517.062099443024, 5533.225348451139, 5542.224088627515, 5565.415631358811, 5411.080116380146, 5442.374126975448, 5448.019356515865, 5451.236826844324, 5456.48163424474, 5514.751836167302, 5524.254225679482, 5592.664440133605, 5614.21401003868, 5614.803481878114, 5470.288862447856, 5475.397706252389, 5494.725263736717, 5528.91706624409, 5531.419200983839], "value": 5164.140397484213, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [645.519088279232, 713.9647511108892, 738.8559230949963, 1041.0, 1047.9109275711564, 32379.514307285408, 33236.83381583092, 33252.66747332526, 33281.833590832015, 33295.66704332956, 35053.123671908215, 35282.8235858821, 35442.0, 35447.0, 35503.46744798824, 6766.898496522556, 6816.897746533806, 6925.065116209323, 6947.444204463631, 7012.684429200698, 6821.317868213164, 6827.317268273157, 6827.658617069152, 6830.863382732342, 6835.692393842289, 6762.0, 6898.517103802736, 6912.654367281641, 6917.619530925797, 6918.481113916451, 6848.2809305023, 6864.38220560152, 6870.20992585854, 6896.241413444517, 6901.516893817435, 6874.0, 6874.484413668994, 6901.75843845468, 6902.585844849325, 6907.689153988083, 32523.83738081318, 32843.0, 32877.83561082203, 33098.338033239444, 33114.0, 3035.0, 3058.7247147756807, 3065.4941934580766, 3077.9538306925415, 3079.0916679579577, 24369.26892193237, 24664.876675616506, 24775.132870349633, 24835.50328993428, 24909.377265568506, 3051.282948507121, 3060.7551395888277, 3089.212250876012, 3140.576022236992, 3174.5714328565577, 123105.38447307795, 125502.37248813789, 142586.0, 143813.2809335957, 144413.0, 38709.22581548353, 39241.21517569633, 39300.803495982334, 39321.80339098286, 39339.21321573552, 40489.79755101265, 40537.433395647444, 40687.796561017596, 40771.0, 40797.18405631871, 12177.086718496148, 12362.134650574553, 12373.505059797508, 12390.62828115158, 12445.75108497825, 9821.607135714634, 9825.0, 9901.950490247502, 9913.553890074963, 9917.206623470105, 12452.937735311265, 12640.0, 12683.746325073447, 12708.555200567936, 12753.872461275454, 5355.116405793001, 5382.192671099288, 5404.405515393303, 5444.346678398539, 5513.917291240635, 828.6022709099545, 877.9429337093069, 892.7768057985504, 917.3211823250747, 917.9036201198778, 20186.697199542017, 20810.79189208119, 21059.262925797524, 21808.345749627537, 21885.452863678536, 958.1137447860701, 973.3721749471551, 974.3763991045737, 979.6130528441369, 986.7878406142714, 10579.94710026445, 11419.48612312448, 11426.714332141762, 11491.195616306779, 11521.654350369503, 178030.0, 178503.0, 178829.1058544699, 179449.1027544854, 179539.0, 40093.79953100216, 40266.39600405996, 40478.392824107665, 40494.19011619751, 40582.79708601438, 1168.1571841666937, 1215.392303848076, 1219.9268043917216, 1222.6515443098674, 1232.9383530823422, 19433.0, 19750.25993761458, 20170.495737606678, 21019.369418917457, 21252.78747212508, 29141.834326627544, 29159.708402915698, 36741.816290918374, 37439.251214976095, 37447.62552374441, 162569.0, 163257.0, 163332.0, 164779.0, 164957.0, 30081.69918300789, 30097.3980520384, 30098.398032039673, 30101.69898300989, 30511.237219069702, 35330.817107005656, 35645.46531802077, 35992.64007359893, 36113.45829812502, 36277.27445451129, 27299.181024569294, 27787.305317367227, 27817.860910695315, 28025.859870700515, 28544.42911141807, 26811.32971675724, 27269.181924542296, 27927.0, 28012.0, 28956.0, 29924.0, 30264.0, 30672.386552268385, 30825.0, 31362.52956205613, 26631.866840665672, 26869.370157023783, 27114.864425678534, 27392.0, 28617.42765144727, 20190.394288171377, 22186.667199992335, 22375.0, 22446.0, 22543.774562254166], "value": 14512.481064831089, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [409.3552654569053, 409.6313318013789, 427.6471910673693, 429.5554101504941, 432.58904041160895, 17115.743263851036, 17533.298668053296, 17780.0, 17838.126996665356, 18195.09024548774, 18616.0, 18770.249190032384, 18775.155118019688, 18933.810661893378, 18989.33537326194, 5451.972740136293, 5518.392976772552, 5660.745266463019, 5662.320521537401, 5676.233708449368, 5196.090684130281, 5333.573314134879, 5335.626506144571, 5338.492843179892, 5339.092354299778, 5275.736213189344, 5293.814716484924, 5306.602004849632, 5308.840734777944, 5331.040412725708, 5299.390570084432, 5502.532284755801, 5513.283273174502, 5528.06022976095, 5532.502074813266, 4914.385701787277, 4965.82619608312, 4971.950280497185, 4988.201887697951, 4998.40019197695, 22030.228941987112, 22659.77340226593, 22717.797207516498, 22740.772592274032, 22797.20209792666, 1621.683771664526, 1634.485137181784, 1658.9336426542923, 1661.9085950272731, 1671.3982966132182, 14381.424743010371, 14511.927440362731, 14651.706965860729, 14845.628859278497, 14875.33061012257, 2021.9191232350688, 2087.499000239947, 2117.809397154248, 2127.5213077057538, 2136.0174319812904, 89350.55324723334, 90577.0, 94308.0, 94786.52606736922, 94915.99999999932, 10746.462676866126, 10988.120950323955, 11069.335839849473, 11121.944390277997, 11292.887071129348, 15383.153926534149, 15418.691626167638, 15505.658415643638, 15528.767068493982, 15529.611759706098, 7766.611669416619, 7943.9602801986775, 8092.0, 8126.878096828552, 8146.063202731643, 7415.406767458699, 7509.662065207079, 7515.8496830063095, 7709.691612335556, 7710.074791025113, 6777.525573209828, 6899.17209934801, 6980.232174460805, 6999.685014174374, 7040.542364746275, 1958.5495336072784, 1998.8001199880187, 2001.3495613925531, 2006.889621070826, 2117.9894100529705, 824.3611201318906, 852.5609311204735, 872.3500991761051, 889.9065598112235, 896.7982204004178, 16999.830001699826, 17041.48875533736, 17085.0, 17457.254274572697, 17749.55626109332, 879.3229213505565, 881.378628067211, 882.289756745813, 886.8492356299445, 911.2300106410073, 9037.367384283169, 9249.90750092504, 9465.432074075577, 9624.085711857362, 9734.269929755297, 372141.0, 373391.0, 374806.0, 377812.0, 378402.0, 71505.6424717873, 73069.26930730624, 73363.26636733564, 73750.0, 74936.37977151736, 1005.2008653120787, 1020.321486211661, 1052.3265110329396, 1052.9362449598873, 1056.250062455665, 14295.57113286603, 14592.562223133324, 14819.481318153812, 14854.034487758261, 15413.76879346833, 36930.0, 37587.0, 38016.239675206896, 38114.0, 38161.04597385087, 45227.54772452365, 45327.546724533655, 46161.76919115383, 47007.76496117497, 47672.0, 7704.114026886979, 7773.494722842997, 7789.844203116019, 7996.440249182501, 8222.259996600334, 11515.481803318704, 11524.078073754246, 11734.589289374831, 11906.583269585522, 11947.0, 9494.192993595621, 9563.995780443232, 9752.366096203725, 9896.257780666334, 10165.085142337226, 9153.86269205949, 9175.77060573491, 9237.337279289792, 9246.445213287225, 9382.906170938204, 9343.672971446238, 9530.237580993642, 9618.759531011781, 9894.950525247328, 10126.392416455037, 7544.283293087148, 7732.458727888994, 7806.726764563213, 7842.607869606611, 7882.251186137308, 9377.249820014245, 9398.530073496435, 9437.575309111244, 9588.232941364813, 9647.855282170913], "value": 8638.980709603837, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1288.5618889577543, 1342.161149281699, 1354.4785257675799, 1357.3349058961112, 1360.2994457854206, 10038.54826532806, 10198.592056317757, 10435.0, 10447.686569402911, 10470.685879423629, 10275.075243228108, 10412.791744165112, 10432.061114499713, 10456.477176141181, 10481.790364192731, 2017.3241963942096, 2031.5936812637458, 2050.3233932802214, 2055.5580550181708, 2058.691196320549, 1912.005757006356, 1979.2083166733278, 1991.3926252492984, 1998.5203551147692, 2007.65869802134, 1940.8447324214028, 1951.6779731344382, 1959.098814545311, 1965.980340196594, 1968.0258272155231, 1907.5898681783415, 1908.3797765726194, 1911.139987005846, 1912.2159914435015, 1916.176044300943, 1871.5414723392719, 1894.1192345559243, 1967.478618166187, 1968.4389948864505, 1970.4876732049627, 10094.444805535693, 10210.132138768213, 10214.642487512976, 10216.33593816407, 10233.385996840214, 5462.453754624546, 5634.577406694514, 5657.547396208293, 5665.093585026417, 5681.829545113612, 3234.7897386670024, 3331.916702082443, 3382.6279109297957, 3410.6248312685584, 3411.573553305837, 1027.9126274266696, 1060.0618452669444, 1066.2749330455288, 1071.9892801072046, 1079.169039839327, 14873.925630371887, 15297.61755956099, 15463.0, 15478.61303467411, 15647.765283520755, 4649.628029757611, 4747.620190384761, 4833.275008748646, 4856.854294371175, 4869.683470574401, 11055.226134170693, 11081.224314298082, 11173.05029072538, 11222.0, 11253.381064041392, 5456.399796022434, 5517.2551705519245, 5553.0, 5558.555315574825, 5559.221708960748, 5151.793928242903, 5210.036143313499, 5218.9739051304505, 5239.292695486137, 5310.256564081032, 3644.6173151818675, 3720.330340538729, 3721.1255354992095, 3752.4371344298575, 3820.178661587772, 1059.3326204491275, 1070.882202957674, 1072.0780129088978, 1072.1637123044038, 1080.4651697409674, 714.3499415531945, 729.3071581997124, 740.3336996702902, 747.9925200748032, 754.4304050441991, 5602.439756024446, 5678.894617119095, 5787.102999035156, 5869.090291004901, 5884.47039766423, 524.5672320335663, 540.9972950135224, 543.8585967648361, 545.7516829842413, 552.0642510943911, 3474.42671959129, 3476.2526056897887, 3485.755997080231, 3535.0, 3680.4663323817895, 13165.60503184906, 13228.669283267995, 13521.797173042412, 13698.794518082237, 13706.0, 13398.799018014737, 13583.45666173342, 13625.523106691417, 13723.245221512912, 14113.08264962774, 6821.829454263683, 7425.665845036986, 7528.284812942762, 7550.735724249735, 7590.127135379392, 6194.938050619436, 6203.720832562455, 6326.873462530815, 6579.440747536513, 6870.072540207008, 11973.820392693942, 12244.877551224374, 12321.137520373488, 12331.69170770738, 12520.812187817372, 12092.576759813364, 12409.0, 12526.874731252936, 12586.685332866751, 12608.0, 8485.915140848512, 8653.524056176971, 8689.13108689126, 8693.826123477369, 8757.299416046828, 9822.263330250116, 9992.350497217658, 10010.549525271235, 10037.046480584333, 10052.145567626541, 8247.422680412314, 8440.198181172778, 8544.145585441654, 8545.273651739422, 8728.607212675572, 8325.0, 8368.163183681583, 8409.95795021021, 8477.279431248413, 8629.95685021596, 7389.519681220703, 7447.180810110992, 7490.662920168496, 7504.474686771873, 7515.8872616911885, 5482.945170548403, 5526.751296191762, 5555.194496798023, 5631.690257035739, 5781.768729250783, 5575.553955683455, 5663.546916246608, 5669.177969194526, 5743.023685973311, 5789.392113828156], "value": 4676.498400109423, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [367.4378201351931, 369.68761396619857, 369.9149195684994, 373.132467014192, 375.47246119202515, 5435.809746658868, 5525.198846167308, 5529.30883639545, 5530.4746049125315, 5581.190727344532, 5328.706921119337, 5429.592780541465, 5434.646747961379, 5442.401335853053, 5467.808626698056, 4019.839206431739, 4088.0, 4108.506979162505, 4108.794560271989, 4109.876703698894, 4045.939310910339, 4064.61386168315, 4100.425940368351, 4108.4864391951005, 4127.607877251671, 3989.461422707941, 3995.6004399559956, 4001.7198796084285, 4003.978985358744, 4014.498187726534, 3972.483577134983, 4011.3352958522178, 4063.2686116499017, 4068.2880495913246, 4089.5092588889224, 3605.549306336708, 3610.7472476926628, 3611.277744451094, 3613.313470440608, 3621.4567814827724, 5261.921071183935, 5286.04851126797, 5322.92015619766, 5333.679979201261, 5351.357837059578, 4725.692829966041, 4804.975975120102, 4826.927596086027, 4839.540243676845, 4853.126437241295, 5765.1352297155345, 5813.157092221646, 5821.50517206038, 5826.242588463515, 5834.183214349994, 4016.357382818764, 4031.9798401007806, 4039.272930872442, 4050.3191175662064, 4055.634992850628, 6043.576949613529, 6112.877742445171, 6130.141780150738, 6164.229471316085, 6199.411055949678, 4137.606927341898, 4145.253854306194, 4147.419361289422, 4148.605882441163, 4150.8547200847825, 4135.441715368447, 4176.979115104405, 4190.664746820247, 4191.371294305878, 4201.852935147316, 4680.859574212779, 4788.797153309517, 4817.566419022235, 4817.78319975602, 4836.540528649773, 5774.740136693859, 5793.391693872083, 5811.389804070596, 5834.5624078194305, 5836.387179346192, 1428.428628548589, 1429.2353590828857, 1439.201243309973, 1441.502681574855, 1445.0390490324028, 903.7198468474794, 910.1217325281135, 961.1349785193382, 969.1471505075489, 974.6734843827255, 4987.700737955734, 5003.424606170337, 5014.924776128361, 5019.623528235397, 5028.974855125701, 5951.315598706205, 5985.910211346833, 5988.041913293852, 5988.4909782668965, 5990.251218597676, 4826.61387089032, 4934.1135435770475, 4947.406311242602, 4966.304717339575, 4984.800607975713, 3149.401613693391, 3183.968160318367, 3186.0, 3190.8564114614896, 3199.6800319967815, 5422.647527910752, 5526.668399895939, 5539.307586551681, 5549.306336707911, 5551.861203469864, 6044.9395506044375, 6086.939130608637, 6118.5716999810475, 6141.140240366352, 6160.353162917919, 5281.947180528223, 5336.1195402758885, 5421.891562168735, 5489.204065410573, 5519.116941289374, 6001.309849367379, 6020.193941817525, 6025.608335458356, 6028.6985650716415, 6040.516758659209, 5761.596688231783, 5907.49786268172, 5931.169636251015, 5965.224520812267, 5993.891130140938, 5509.118541033576, 5515.972420137874, 5535.529479994246, 5546.7781288748, 5562.833115006556, 4501.3022981437925, 4546.954530454653, 4549.408576884984, 4550.067236216634, 4556.0, 5938.18885240006, 6018.0581718974145, 6028.547858910511, 6029.306629737636, 6050.273967123973, 5806.983777838946, 5831.70841457917, 5832.679202643895, 5853.765849365977, 5874.676892770768, 5641.717914104361, 5790.681512516852, 5828.125781132694, 5834.970825146017, 5836.970815145897, 5721.427857214412, 5727.599068065196, 5743.396943320891, 5750.1249375312345, 5768.221290125779, 5796.246487956539, 5877.324107727666, 5879.0, 5892.410758924073, 5898.734556944862, 5603.215549822947, 5615.7192140392, 5634.52106570946, 5651.095824668033, 5662.094064949588], "value": 4323.033227927326, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [735.1031741275649, 763.7632333976468, 774.4114473000521, 780.4107898536604, 781.894444250026, 13876.236806975612, 14196.574102776933, 14202.857971420282, 14369.640758981031, 14512.129272243646, 13680.315984200775, 13754.312284385765, 13877.236751978637, 14001.509947151852, 14175.574732758034, 849.4308813095241, 881.1849039638341, 903.8101998580306, 907.1971305394708, 909.0182602789005, 889.9866502002475, 903.5753195997903, 905.0813424374265, 905.8414777413959, 906.3429013964856, 930.5626355612851, 948.6964171465133, 949.1410273702311, 949.7150854743584, 952.105021279998, 935.7473482159813, 939.7079016352516, 941.8963913969458, 946.2713710442989, 950.1353768071091, 687.3676217879563, 689.7861662884521, 693.1231991530718, 693.8646963842053, 693.8924466707668, 14370.065945713495, 15078.170700611461, 15238.314275857612, 15288.0, 15294.00588961714, 15575.454859079991, 16002.43991460305, 16026.118563479004, 16038.35846566136, 16081.758773618405, 12651.114421990464, 12806.231626102464, 12920.095593308472, 12933.48266069356, 12952.935235323857, 3051.3744682340066, 3074.938501229963, 3076.7538596912195, 3078.0304204175836, 3090.9536356954663, 81008.18991810124, 81887.0, 82044.58977705073, 82214.58892705558, 82554.17445825585, 11861.229020113666, 12425.0, 13362.265075420944, 13378.799318010238, 13472.663183420296, 22466.887665561568, 23012.309630711105, 23170.536589268122, 23382.298531044096, 23400.06399744025, 6385.45723613498, 6539.607623542603, 6570.178727659043, 6570.474362051024, 6575.967120164464, 3015.8190508569555, 3084.5373194021076, 3090.227443139215, 3090.891818786332, 3095.613048368954, 3547.6629720176543, 3605.3330133925306, 3694.4273637586216, 3810.8666196682984, 3823.5794062653085, 764.2357642357642, 781.1602527283193, 785.4972817396871, 786.4966421490251, 792.2038351456749, 561.3656568078046, 582.0251079441917, 586.8063539032195, 604.0, 612.9172561704202, 9452.8582071269, 9783.559739811582, 10214.795704085876, 10292.588296468057, 10488.737781555523, 584.5966283264619, 587.5857520448074, 587.917691523187, 592.0408937521244, 595.6783336997972, 4411.933820992687, 4608.3778689876435, 4644.674872758875, 4651.744154071558, 4652.604528615106, 73689.0, 74176.62911685515, 74552.0, 76726.0, 83370.16629833746, 64434.67782661151, 66198.33801662018, 66475.33524664788, 66992.6650366745, 68340.0, 57966.0, 58670.11994820081, 60861.69569152126, 60916.69541652352, 61292.69353653203, 9008.513595256709, 9270.304727145356, 9396.342256042011, 9427.717168484956, 9671.226301895973, 27669.0, 28190.577141342485, 28514.0, 28706.99525516597, 29019.56470652984, 34552.48171277483, 35014.82492587521, 35394.46908296326, 35623.28753424969, 35817.0, 14396.20820854821, 14726.558203253919, 14851.777223341875, 14933.775993360325, 15091.698166036398, 16208.67582648364, 16366.263518141473, 16441.424550140688, 16501.91749041247, 16621.0858402789, 13245.735085298433, 13504.459821607026, 13578.117422367515, 13702.45190192421, 13842.169469831842, 13530.323483825967, 13623.455061797416, 14111.153330800185, 14132.010759246754, 14133.222672753098, 13321.067525273138, 13387.933060334635, 13436.529721459701, 13455.529056482976, 13587.45650173982, 9720.659776907774, 9786.510674466106, 9923.950380248052, 10137.898621013695, 10372.377657340583, 10470.057694807503, 10626.309289896131, 10877.0, 11034.779304413707, 11043.558257669603], "value": 7031.186647391042, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1553.2, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [101.0, 110.0, 111.0, 110.0, 112.0, 110.0, 110.0, 112.0, 109.0, 110.0], "value": 109.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 133.0, 124.0, 170.0, 124.0, 129.0, 128.0, 122.0, 146.0, 129.0], "value": 135.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 165.0, 165.0, 166.0, 168.0, 169.0, 170.0, 163.0, 164.0, 163.0], "value": 165.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 74.0, 75.0, 112.0, 75.0, 76.0, 74.0, 76.0, 99.0, 75.0], "value": 80.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 83.0, 112.0, 84.0, 83.0, 84.0, 98.0, 86.0, 85.0, 110.0], "value": 91.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 115.0, 114.0, 114.0, 114.0, 115.0, 116.0, 115.0, 114.0, 115.0], "value": 114.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 151.0, 151.0, 151.0, 152.0, 151.0, 151.0, 151.0, 151.0, 151.0], "value": 151.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 95.0, 94.0, 94.0, 95.0, 95.0, 95.0, 95.0, 95.0, 94.0], "value": 94.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 56.0, 58.0, 55.0, 55.0, 56.0, 56.0, 60.0, 55.0, 55.0], "value": 56.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 57.0, 56.0, 57.0, 56.0, 56.0, 56.0, 56.0, 56.0, 63.0], "value": 56.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 88.0, 87.0, 87.0, 90.0, 88.0, 88.0, 92.0, 125.0, 87.0], "value": 92.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [137.0, 136.0, 142.0, 134.0, 132.0, 137.0, 147.0, 133.0, 137.0, 141.0], "value": 137.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [183.0, 195.0, 191.0, 193.0, 196.0, 207.0, 192.0, 192.0, 192.0, 198.0], "value": 193.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 72.0, 72.0, 73.0, 73.0, 75.0, 72.0, 72.0, 73.0], "value": 73.2, "unit": "score"}]}]} 05:54:35 INFO - Return code: 0 05:54:35 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 05:54:35 INFO - # TBPL SUCCESS # 05:54:35 INFO - Running post-action listener: _resource_record_post_action 05:54:35 INFO - [mozharness: 2017-05-27 12:54:35.193901Z] Finished run-tests step (success) 05:54:35 INFO - Running post-run listener: _resource_record_post_run 05:54:35 INFO - Total resource usage - Wall time: 1255s; CPU: 13.0%; Read bytes: 8192; Write bytes: 404328448; Read time: 28; Write time: 218472 05:54:35 INFO - TinderboxPrint: CPU usage
12.7% 05:54:35 INFO - TinderboxPrint: I/O read bytes / time
8,192 / 28 05:54:35 INFO - TinderboxPrint: I/O write bytes / time
404,328,448 / 218,472 05:54:35 INFO - TinderboxPrint: CPU idle
8,749.7 (87.3%) 05:54:35 INFO - TinderboxPrint: CPU user
1,216.2 (12.1%) 05:54:35 INFO - TinderboxPrint: Swap in / out
0 / 0 05:54:35 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 93761536; Read time: 0; Write time: 69508 05:54:35 INFO - run-tests - Wall time: 1240s; CPU: 13.0%; Read bytes: 8192; Write bytes: 310566912; Read time: 28; Write time: 148964 05:54:35 INFO - Running post-run listener: _upload_blobber_files 05:54:35 INFO - Blob upload gear active. 05:54:35 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 05:54:35 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 05:54:35 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'] 05:54:35 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 05:54:36 INFO - (blobuploader) - INFO - Open directory for files ... 05:54:36 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 05:54:36 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:54:36 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:54:37 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 05:54:37 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:54:37 INFO - (blobuploader) - INFO - Done attempting. 05:54:37 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 05:54:37 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:54:37 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:54:38 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 05:54:38 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:54:38 INFO - (blobuploader) - INFO - Done attempting. 05:54:38 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 05:54:38 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:54:38 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:54:38 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 05:54:38 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:54:38 INFO - (blobuploader) - INFO - Done attempting. 05:54:38 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 05:54:38 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:54:38 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:54:45 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 05:54:45 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:54:45 INFO - (blobuploader) - INFO - Done attempting. 05:54:45 INFO - (blobuploader) - INFO - Iteration through files over. 05:54:45 INFO - Return code: 0 05:54:45 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 05:54:45 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 05:54:45 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/ee09166cd3b05a986f35dca719d915fd010ab4a5ff731f8371ea4bc5dbc3001d31cfbe3d3a80563cbf9c541f4c3b5083ebaeec3de4f45b97b83cea74286cb268", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/3f674ec71bc6357d5cc303577340d0a0b75453030821fd37411754db0c9bcb6c97440d10d4cb674df6e0f6571fb8ec95799aeec393d196318b050c20c712ed68", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/b8c71e6f6fa7d2794fb5d27f95448fd4294efbfde22e0645a4017355960b63c9d5eeddf2e7670ba66e40313891d96d12583f946a0c3e746ac1939161e37401e0", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/94097d94f75e0e8d96ac4ae50e4cdabafb7e10fc055a95f9ff4679688b9910f7b63ed6a79055703ef3f12bd39fcafdcef7f025341d0e9bc8ef8f437c4bf873f4"} 05:54:45 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 05:54:45 INFO - Writing to file /builds/slave/test/properties/blobber_files 05:54:45 INFO - Contents: 05:54:45 INFO - blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/ee09166cd3b05a986f35dca719d915fd010ab4a5ff731f8371ea4bc5dbc3001d31cfbe3d3a80563cbf9c541f4c3b5083ebaeec3de4f45b97b83cea74286cb268", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/3f674ec71bc6357d5cc303577340d0a0b75453030821fd37411754db0c9bcb6c97440d10d4cb674df6e0f6571fb8ec95799aeec393d196318b050c20c712ed68", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/b8c71e6f6fa7d2794fb5d27f95448fd4294efbfde22e0645a4017355960b63c9d5eeddf2e7670ba66e40313891d96d12583f946a0c3e746ac1939161e37401e0", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/94097d94f75e0e8d96ac4ae50e4cdabafb7e10fc055a95f9ff4679688b9910f7b63ed6a79055703ef3f12bd39fcafdcef7f025341d0e9bc8ef8f437c4bf873f4"} 05:54:45 INFO - Running post-run listener: copy_logs_to_upload_dir 05:54:45 INFO - Copying logs to upload dir... 05:54:45 INFO - mkdir: /builds/slave/test/build/upload/logs 05:54:45 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1317.009333 ========= master_lag: 0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 57 secs) (at 2017-05-27 05:54:44.461966) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-27 05:54:44.466019) ========= 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=769a0cfe1e83e11e6f11f5a3000001a8-1495887323.97418-2031241851 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/ee09166cd3b05a986f35dca719d915fd010ab4a5ff731f8371ea4bc5dbc3001d31cfbe3d3a80563cbf9c541f4c3b5083ebaeec3de4f45b97b83cea74286cb268", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/3f674ec71bc6357d5cc303577340d0a0b75453030821fd37411754db0c9bcb6c97440d10d4cb674df6e0f6571fb8ec95799aeec393d196318b050c20c712ed68", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/b8c71e6f6fa7d2794fb5d27f95448fd4294efbfde22e0645a4017355960b63c9d5eeddf2e7670ba66e40313891d96d12583f946a0c3e746ac1939161e37401e0", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/94097d94f75e0e8d96ac4ae50e4cdabafb7e10fc055a95f9ff4679688b9910f7b63ed6a79055703ef3f12bd39fcafdcef7f025341d0e9bc8ef8f437c4bf873f4"} build_url:https://queue.taskcluster.net/v1/task/Q8LbqfWYRpSDg2F3Fudimw/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011230 build_url: 'https://queue.taskcluster.net/v1/task/Q8LbqfWYRpSDg2F3Fudimw/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/ee09166cd3b05a986f35dca719d915fd010ab4a5ff731f8371ea4bc5dbc3001d31cfbe3d3a80563cbf9c541f4c3b5083ebaeec3de4f45b97b83cea74286cb268", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/3f674ec71bc6357d5cc303577340d0a0b75453030821fd37411754db0c9bcb6c97440d10d4cb674df6e0f6571fb8ec95799aeec393d196318b050c20c712ed68", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/b8c71e6f6fa7d2794fb5d27f95448fd4294efbfde22e0645a4017355960b63c9d5eeddf2e7670ba66e40313891d96d12583f946a0c3e746ac1939161e37401e0", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/94097d94f75e0e8d96ac4ae50e4cdabafb7e10fc055a95f9ff4679688b9910f7b63ed6a79055703ef3f12bd39fcafdcef7f025341d0e9bc8ef8f437c4bf873f4"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-27 05:54:44.490435) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-27 05:54:44.490784) ========= 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=769a0cfe1e83e11e6f11f5a3000001a8-1495887323.97418-2031241851 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004410 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-27 05:54:44.574416) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-27 05:54:44.574737) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-27 05:54:44.575030) ========= ========= Total master_lag: 0.18 =========