builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-044 starttime: 1495900510.33 results: success (0) revision: 35099b4caec14bf0e3c5e3fed7a17dd3faf51dbe ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-05-27 08:55:10.328860) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-05-27 08:55:10.329442) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-27 08:55:10.329731) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-27 08:55:10.345111) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-27 08:55:10.345409) ========= 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=88e9d754c8c9af9f7805d7f3000001bd-1495900511.454322-1004867611 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-05-27 08:55:12-- 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% 121M=0s 2017-05-27 08:55:12 (121 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.123472 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-27 08:55:10.479433) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-27 08:55:10.479779) ========= 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=88e9d754c8c9af9f7805d7f3000001bd-1495900511.454322-1004867611 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.022528 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-27 08:55:10.529665) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-27 08:55:10.530002) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 35099b4caec14bf0e3c5e3fed7a17dd3faf51dbe --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 35099b4caec14bf0e3c5e3fed7a17dd3faf51dbe --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=88e9d754c8c9af9f7805d7f3000001bd-1495900511.454322-1004867611 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-05-27 08:55:12,324 truncating revision to first 12 chars 2017-05-27 08:55:12,325 Setting DEBUG logging. 2017-05-27 08:55:12,325 attempt 1/10 2017-05-27 08:55:12,325 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/35099b4caec1?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-05-27 08:55:12,743 unpacking tar archive at: mozilla-central-35099b4caec1/testing/mozharness/ program finished with exit code 0 elapsedTime=0.740772 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-27 08:55:11.282841) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-27 08:55:11.283161) ========= script_repo_revision: 35099b4caec14bf0e3c5e3fed7a17dd3faf51dbe ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-27 08:55:11.283519) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-27 08:55:11.283907) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-27 08:55:11.292225) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 56 secs) (at 2017-05-27 08:55:11.292525) ========= /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=88e9d754c8c9af9f7805d7f3000001bd-1495900511.454322-1004867611 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 08:55:13 INFO - MultiFileLogger online at 20170527 08:55:13 in /builds/slave/test 08:55:13 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 08:55:13 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:55:13 INFO - {'append_to_log': False, 08:55:13 INFO - 'base_work_dir': '/builds/slave/test', 08:55:13 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 08:55:13 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:55:13 INFO - 'branch': 'Firefox-Non-PGO', 08:55:13 INFO - 'buildbot_json_path': 'buildprops.json', 08:55:13 INFO - 'config_files': ('talos/linux_config.py',), 08:55:13 INFO - 'default_actions': ('clobber', 08:55:13 INFO - 'read-buildbot-config', 08:55:13 INFO - 'download-and-extract', 08:55:13 INFO - 'populate-webroot', 08:55:13 INFO - 'create-virtualenv', 08:55:13 INFO - 'install', 08:55:13 INFO - 'run-tests'), 08:55:13 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:55:13 INFO - 'download_minidump_stackwalk': True, 08:55:13 INFO - 'download_symbols': 'ondemand', 08:55:13 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:55:13 INFO - 'tooltool.py': '/tools/tooltool.py', 08:55:13 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:55:13 INFO - '/tools/misc-python/virtualenv.py')}, 08:55:13 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:55:13 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:55:13 INFO - 'gecko_profile': False, 08:55:13 INFO - 'gecko_profile_interval': 0, 08:55:13 INFO - 'installer_path': 'installer.exe', 08:55:13 INFO - 'log_level': 'info', 08:55:13 INFO - 'log_name': 'talos', 08:55:13 INFO - 'log_to_console': True, 08:55:13 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 08:55:13 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 08:55:13 INFO - 'opt_config_files': (), 08:55:13 INFO - 'pip_index': False, 08:55:13 INFO - 'suite': 'dromaeojs-e10s', 08:55:13 INFO - 'system_bits': '32', 08:55:13 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:55:13 INFO - 'title': 'talos-linux64-ix-044', 08:55:13 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:55:13 INFO - 'use_talos_json': True, 08:55:13 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:55:13 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:55:13 INFO - 'work_dir': 'build'} 08:55:13 INFO - [mozharness: 2017-05-27 15:55:13.183401Z] Running clobber step. 08:55:13 INFO - Running pre-action listener: _resource_record_pre_action 08:55:13 INFO - Running main action method: clobber 08:55:13 INFO - rmtree: /builds/slave/test/build 08:55:13 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:55:14 INFO - Running post-action listener: _resource_record_post_action 08:55:14 INFO - [mozharness: 2017-05-27 15:55:14.201208Z] Finished clobber step (success) 08:55:14 INFO - [mozharness: 2017-05-27 15:55:14.201309Z] Running read-buildbot-config step. 08:55:14 INFO - Running pre-action listener: _resource_record_pre_action 08:55:14 INFO - Running main action method: read_buildbot_config 08:55:14 INFO - Using buildbot properties: 08:55:14 INFO - { 08:55:14 INFO - "project": "", 08:55:14 INFO - "product": "firefox", 08:55:14 INFO - "who": "ffxbld@noreply.mozilla.org", 08:55:14 INFO - "installer_path": "public/build/target.tar.bz2", 08:55:14 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 08:55:14 INFO - "repository": "https://hg.mozilla.org/mozilla-central/", 08:55:14 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-e10s", 08:55:14 INFO - "stage_platform": "linux64", 08:55:14 INFO - "basedir": "/builds/slave/test", 08:55:14 INFO - "buildnumber": 909, 08:55:14 INFO - "platform": "ubuntu64_hw", 08:55:14 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 08:55:14 INFO - "slavebuilddir": "test", 08:55:14 INFO - "taskId": "Tjls-doXScCami4FV_cG3Q", 08:55:14 INFO - "branch": "mozilla-central", 08:55:14 INFO - "script_repo_revision": "production", 08:55:14 INFO - "revision": "35099b4caec14bf0e3c5e3fed7a17dd3faf51dbe", 08:55:14 INFO - "slavename": "talos-linux64-ix-044", 08:55:14 INFO - "repo_path": "mozilla-central" 08:55:14 INFO - } 08:55:14 INFO - Finding installer, test and symbols from parent task. 08:55:14 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Tjls-doXScCami4FV_cG3Q'}, attempt #1 08:55:14 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Tjls-doXScCami4FV_cG3Q'}, attempt #1 08:55:15 INFO - Task dependencies: VYCP9MoKR1-Ju82qtJdrjg 08:55:15 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/VYCP9MoKR1-Ju82qtJdrjg'}, attempt #1 08:55:15 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/VYCP9MoKR1-Ju82qtJdrjg/artifacts/public/build/target.tar.bz2 08:55:15 INFO - Set test_url: https://queue.taskcluster.net/v1/task/VYCP9MoKR1-Ju82qtJdrjg/artifacts/public/build/test_packages.json 08:55:15 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/VYCP9MoKR1-Ju82qtJdrjg/artifacts/public/build/target.crashreporter-symbols.zip 08:55:15 INFO - Running post-action listener: _resource_record_post_action 08:55:15 INFO - [mozharness: 2017-05-27 15:55:15.547892Z] Finished read-buildbot-config step (success) 08:55:15 INFO - [mozharness: 2017-05-27 15:55:15.548114Z] Running download-and-extract step. 08:55:15 INFO - Running pre-action listener: _resource_record_pre_action 08:55:15 INFO - Running main action method: download_and_extract 08:55:15 INFO - mkdir: /builds/slave/test/build/tests 08:55:15 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')]} 08:55:15 INFO - trying https://queue.taskcluster.net/v1/task/VYCP9MoKR1-Ju82qtJdrjg/artifacts/public/build/target.test_packages.json 08:55:15 INFO - Downloading https://queue.taskcluster.net/v1/task/VYCP9MoKR1-Ju82qtJdrjg/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 08:55:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/VYCP9MoKR1-Ju82qtJdrjg/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 08:55:16 INFO - Downloaded 986 bytes. 08:55:16 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 08:55:16 INFO - Using the following test package requirements: 08:55:16 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 08:55:16 INFO - u'common': [u'target.common.tests.zip'], 08:55:16 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 08:55:16 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 08:55:16 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 08:55:16 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 08:55:16 INFO - u'mozbase': [u'target.common.tests.zip'], 08:55:16 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 08:55:16 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 08:55:16 INFO - u'web-platform': [u'target.common.tests.zip', 08:55:16 INFO - u'target.web-platform.tests.zip'], 08:55:16 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 08:55:16 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 08:55:16 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/VYCP9MoKR1-Ju82qtJdrjg/artifacts/public/build/target.common.tests.zip 08:55:16 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/VYCP9MoKR1-Ju82qtJdrjg/artifacts/public/build/target.common.tests.zip'}, attempt #1 08:55:16 INFO - Fetch https://queue.taskcluster.net/v1/task/VYCP9MoKR1-Ju82qtJdrjg/artifacts/public/build/target.common.tests.zip into memory 08:55:17 INFO - Content-Length response header: 63526724 08:55:17 INFO - Bytes received: 63526724 08:55:28 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 08:55:28 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/VYCP9MoKR1-Ju82qtJdrjg/artifacts/public/build/target.common.tests.zip 08:55:28 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/VYCP9MoKR1-Ju82qtJdrjg/artifacts/public/build/target.common.tests.zip'}, attempt #1 08:55:28 INFO - Fetch https://queue.taskcluster.net/v1/task/VYCP9MoKR1-Ju82qtJdrjg/artifacts/public/build/target.common.tests.zip into memory 08:55:29 INFO - Content-Length response header: 63526724 08:55:29 INFO - Bytes received: 63526724 08:55:41 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/VYCP9MoKR1-Ju82qtJdrjg/artifacts/public/build/target.talos.tests.zip 08:55:41 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/VYCP9MoKR1-Ju82qtJdrjg/artifacts/public/build/target.talos.tests.zip'}, attempt #1 08:55:41 INFO - Fetch https://queue.taskcluster.net/v1/task/VYCP9MoKR1-Ju82qtJdrjg/artifacts/public/build/target.talos.tests.zip into memory 08:55:41 INFO - Content-Length response header: 14441221 08:55:41 INFO - Bytes received: 14441221 08:55:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:55:42 INFO - trying https://queue.taskcluster.net/v1/task/VYCP9MoKR1-Ju82qtJdrjg/artifacts/public/build/target.tar.bz2 08:55:42 INFO - Downloading https://queue.taskcluster.net/v1/task/VYCP9MoKR1-Ju82qtJdrjg/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 08:55:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/VYCP9MoKR1-Ju82qtJdrjg/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 08:55:43 INFO - Downloaded 54020871 bytes. 08:55:43 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/VYCP9MoKR1-Ju82qtJdrjg/artifacts/public/build/target.tar.bz2 08:55:43 INFO - mkdir: /builds/slave/test/properties 08:55:43 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:55:43 INFO - Writing to file /builds/slave/test/properties/build_url 08:55:43 INFO - Contents: 08:55:43 INFO - build_url:https://queue.taskcluster.net/v1/task/VYCP9MoKR1-Ju82qtJdrjg/artifacts/public/build/target.tar.bz2 08:55:43 INFO - Running post-action listener: _resource_record_post_action 08:55:43 INFO - Running post-action listener: set_extra_try_arguments 08:55:43 INFO - [mozharness: 2017-05-27 15:55:43.203205Z] Finished download-and-extract step (success) 08:55:43 INFO - [mozharness: 2017-05-27 15:55:43.203302Z] Running populate-webroot step. 08:55:43 INFO - Running pre-action listener: _resource_record_pre_action 08:55:43 INFO - Running main action method: populate_webroot 08:55:43 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:55:43 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:55:43 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:55:43 INFO - '--tppagecycles', 08:55:43 INFO - '7'], 08:55:43 INFO - 'tests': ['tsvgm']}}, 08:55:43 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 08:55:43 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:55:43 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 08:55:43 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 08:55:43 INFO - 'tests': ['dromaeo_css', 'kraken']}, 08:55:43 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 08:55:43 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 08:55:43 INFO - 'talos_options': ['--disable-e10s'], 08:55:43 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:55:43 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 08:55:43 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:55:43 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 08:55:43 INFO - 'talos_options': ['--disable-e10s'], 08:55:43 INFO - 'tests': ['damp', 'tps']}, 08:55:43 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 08:55:43 INFO - 'tests': ['damp', 'tps']}, 08:55:43 INFO - 'g3': {'talos_options': ['--disable-e10s'], 08:55:43 INFO - 'tests': ['dromaeo_dom']}, 08:55:43 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:55:43 INFO - 'g4': {'talos_options': ['--disable-e10s'], 08:55:43 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 08:55:43 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 08:55:43 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 08:55:43 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 08:55:43 INFO - 'other': {'talos_options': ['--disable-e10s'], 08:55:43 INFO - 'tests': ['a11yr', 08:55:43 INFO - 'ts_paint', 08:55:43 INFO - 'tpaint', 08:55:43 INFO - 'sessionrestore', 08:55:43 INFO - 'sessionrestore_no_auto_restore', 08:55:43 INFO - 'tabpaint']}, 08:55:43 INFO - 'other-e10s': {'tests': ['a11yr', 08:55:43 INFO - 'ts_paint', 08:55:43 INFO - 'tpaint', 08:55:43 INFO - 'sessionrestore', 08:55:43 INFO - 'sessionrestore_no_auto_restore', 08:55:43 INFO - 'tabpaint']}, 08:55:43 INFO - 'other-e10s_l64': {'tests': ['a11yr', 08:55:43 INFO - 'ts_paint', 08:55:43 INFO - 'tpaint', 08:55:43 INFO - 'sessionrestore', 08:55:43 INFO - 'sessionrestore_no_auto_restore', 08:55:43 INFO - 'tabpaint']}, 08:55:43 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 08:55:43 INFO - 'ts_paint', 08:55:43 INFO - 'tpaint', 08:55:43 INFO - 'sessionrestore', 08:55:43 INFO - 'sessionrestore_no_auto_restore', 08:55:43 INFO - 'tabpaint']}, 08:55:43 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 08:55:43 INFO - 'tests': ['a11yr', 08:55:43 INFO - 'ts_paint', 08:55:43 INFO - 'tpaint', 08:55:43 INFO - 'sessionrestore', 08:55:43 INFO - 'sessionrestore_no_auto_restore', 08:55:43 INFO - 'tabpaint']}, 08:55:43 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 08:55:43 INFO - 'tests': ['a11yr', 08:55:43 INFO - 'ts_paint', 08:55:43 INFO - 'tpaint', 08:55:43 INFO - 'sessionrestore', 08:55:43 INFO - 'sessionrestore_no_auto_restore', 08:55:43 INFO - 'tabpaint']}, 08:55:43 INFO - 'perf-reftest': {'tests': ['bloom_basic', 'bloom_basic_ref']}, 08:55:43 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic', 08:55:43 INFO - 'bloom_basic_ref']}, 08:55:43 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 08:55:43 INFO - 'tests': ['tsvgx', 08:55:43 INFO - 'tsvgr_opacity', 08:55:43 INFO - 'tart', 08:55:43 INFO - 'tscrollx', 08:55:43 INFO - 'cart', 08:55:43 INFO - 'tsvg_static']}, 08:55:43 INFO - 'svgr-e10s': {'tests': ['tsvgx', 08:55:43 INFO - 'tsvgr_opacity', 08:55:43 INFO - 'tart', 08:55:43 INFO - 'tscrollx', 08:55:43 INFO - 'cart', 08:55:43 INFO - 'tsvg_static']}, 08:55:43 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 08:55:43 INFO - 'talos_options': ['--disable-e10s'], 08:55:43 INFO - 'tests': ['tp5o']}, 08:55:43 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 08:55:43 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 08:55:43 INFO - 'talos_options': ['--disable-e10s', 08:55:43 INFO - '--xperf_path', 08:55:43 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:55:43 INFO - 'tests': ['tp5n']}, 08:55:43 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 08:55:43 INFO - 'talos_options': ['--xperf_path', 08:55:43 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:55:43 INFO - 'tests': ['tp5n']}}, 08:55:43 INFO - 'talos.zip': {'path': '', 08:55:43 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:55:43 INFO - Running post-action listener: _resource_record_post_action 08:55:43 INFO - [mozharness: 2017-05-27 15:55:43.217267Z] Finished populate-webroot step (success) 08:55:43 INFO - [mozharness: 2017-05-27 15:55:43.217356Z] Running create-virtualenv step. 08:55:43 INFO - Running pre-action listener: _resource_record_pre_action 08:55:43 INFO - Running main action method: create_virtualenv 08:55:43 INFO - Creating virtualenv /builds/slave/test/build/venv 08:55:43 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 08:55:43 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:55:43 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:55:43 INFO - Using real prefix '/usr' 08:55:43 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:55:43 INFO - Installing distribute.............................................................................................................................................................................................done. 08:55:45 INFO - Installing pip.................done. 08:55:45 INFO - Return code: 0 08:55:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 08:55:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 08:55:46 INFO - Reading from file tmpfile_stdout 08:55:46 INFO - Output received: 08:55:46 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) 08:55:46 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:55:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:55:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:55:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:55:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:55:46 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13041f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14d1a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16775c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16747a0>, '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 0x16756a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1675b30>, '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': '88e9d754c8c9af9f7805d7f3000001bd-1495900511.454322-1004867611', '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 08:55:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 08:55:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 08:55:46 INFO - Using env: {'DISPLAY': ':0', 08:55:46 INFO - 'HOME': '/home/cltbld', 08:55:46 INFO - 'LANG': 'en_US.UTF-8', 08:55:46 INFO - 'LANGUAGE': 'en_US:en', 08:55:46 INFO - 'LOGNAME': 'cltbld', 08:55:46 INFO - 'MAIL': '/var/mail/cltbld', 08:55:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:55:46 INFO - 'MOZ_NO_REMOTE': '1', 08:55:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:55:46 INFO - 'NO_EM_RESTART': '1', 08:55:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:55:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:55:46 INFO - 'PWD': '/builds/slave/test', 08:55:46 INFO - 'SHELL': '/bin/bash', 08:55:46 INFO - 'SHLVL': '1', 08:55:46 INFO - 'TERM': 'linux', 08:55:46 INFO - 'TMOUT': '86400', 08:55:46 INFO - 'USER': 'cltbld', 08:55:46 INFO - 'XDG_SESSION_COOKIE': '88e9d754c8c9af9f7805d7f3000001bd-1495900511.454322-1004867611', 08:55:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:55:46 INFO - '_': '/tools/buildbot/bin/python'} 08:55:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:55:46 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 08:55:46 INFO - Cleaning up... 08:55:46 INFO - Return code: 0 08:55:46 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 08:55:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:55:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:55:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:55:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:55:46 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x13041f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14d1a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16775c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16747a0>, '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 0x16756a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1675b30>, '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': '88e9d754c8c9af9f7805d7f3000001bd-1495900511.454322-1004867611', '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 08:55:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 08:55:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 08:55:46 INFO - Using env: {'DISPLAY': ':0', 08:55:46 INFO - 'HOME': '/home/cltbld', 08:55:46 INFO - 'LANG': 'en_US.UTF-8', 08:55:46 INFO - 'LANGUAGE': 'en_US:en', 08:55:46 INFO - 'LOGNAME': 'cltbld', 08:55:46 INFO - 'MAIL': '/var/mail/cltbld', 08:55:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:55:46 INFO - 'MOZ_NO_REMOTE': '1', 08:55:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:55:46 INFO - 'NO_EM_RESTART': '1', 08:55:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:55:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:55:46 INFO - 'PWD': '/builds/slave/test', 08:55:46 INFO - 'SHELL': '/bin/bash', 08:55:46 INFO - 'SHLVL': '1', 08:55:46 INFO - 'TERM': 'linux', 08:55:46 INFO - 'TMOUT': '86400', 08:55:46 INFO - 'USER': 'cltbld', 08:55:46 INFO - 'XDG_SESSION_COOKIE': '88e9d754c8c9af9f7805d7f3000001bd-1495900511.454322-1004867611', 08:55:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:55:46 INFO - '_': '/tools/buildbot/bin/python'} 08:55:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:55:46 INFO - Downloading/unpacking psutil>=3.1.1 08:55:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:55:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:55:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:55:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:55:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:55:47 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:55:47 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:55:47 INFO - Installing collected packages: psutil 08:55:47 INFO - Running setup.py install for psutil 08:55:47 INFO - building 'psutil._psutil_linux' extension 08:55:47 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 08:55:47 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 08:55:47 INFO - building 'psutil._psutil_posix' extension 08:55:47 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 08:55:48 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 08:55:48 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:55:48 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:55:48 INFO - Successfully installed psutil 08:55:48 INFO - Cleaning up... 08:55:48 INFO - Return code: 0 08:55:48 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 08:55:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:55:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:55:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:55:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:55:48 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 0x13041f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14d1a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16775c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16747a0>, '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 0x16756a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1675b30>, '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': '88e9d754c8c9af9f7805d7f3000001bd-1495900511.454322-1004867611', '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 08:55:48 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 08:55:48 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 08:55:48 INFO - Using env: {'DISPLAY': ':0', 08:55:48 INFO - 'HOME': '/home/cltbld', 08:55:48 INFO - 'LANG': 'en_US.UTF-8', 08:55:48 INFO - 'LANGUAGE': 'en_US:en', 08:55:48 INFO - 'LOGNAME': 'cltbld', 08:55:48 INFO - 'MAIL': '/var/mail/cltbld', 08:55:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:55:48 INFO - 'MOZ_NO_REMOTE': '1', 08:55:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:55:48 INFO - 'NO_EM_RESTART': '1', 08:55:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:55:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:55:48 INFO - 'PWD': '/builds/slave/test', 08:55:48 INFO - 'SHELL': '/bin/bash', 08:55:48 INFO - 'SHLVL': '1', 08:55:48 INFO - 'TERM': 'linux', 08:55:48 INFO - 'TMOUT': '86400', 08:55:48 INFO - 'USER': 'cltbld', 08:55:48 INFO - 'XDG_SESSION_COOKIE': '88e9d754c8c9af9f7805d7f3000001bd-1495900511.454322-1004867611', 08:55:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:55:48 INFO - '_': '/tools/buildbot/bin/python'} 08:55:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:55:48 INFO - Downloading/unpacking mozsystemmonitor==0.3 08:55:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:55:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:55:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:55:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:55:49 INFO - Downloading mozsystemmonitor-0.3.tar.gz 08:55:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:55:49 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 08:55:49 INFO - Installing collected packages: mozsystemmonitor 08:55:49 INFO - Running setup.py install for mozsystemmonitor 08:55:49 INFO - Successfully installed mozsystemmonitor 08:55:49 INFO - Cleaning up... 08:55:49 INFO - Return code: 0 08:55:49 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 08:55:49 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')]} 08:55:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:55:49 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')]} 08:55:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:55:49 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 0x13041f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14d1a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16775c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16747a0>, '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 0x16756a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1675b30>, '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': '88e9d754c8c9af9f7805d7f3000001bd-1495900511.454322-1004867611', '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 08:55:49 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 08:55:49 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 08:55:49 INFO - Using env: {'DISPLAY': ':0', 08:55:49 INFO - 'HOME': '/home/cltbld', 08:55:49 INFO - 'LANG': 'en_US.UTF-8', 08:55:49 INFO - 'LANGUAGE': 'en_US:en', 08:55:49 INFO - 'LOGNAME': 'cltbld', 08:55:49 INFO - 'MAIL': '/var/mail/cltbld', 08:55:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:55:49 INFO - 'MOZ_NO_REMOTE': '1', 08:55:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:55:49 INFO - 'NO_EM_RESTART': '1', 08:55:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:55:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:55:49 INFO - 'PWD': '/builds/slave/test', 08:55:49 INFO - 'SHELL': '/bin/bash', 08:55:49 INFO - 'SHLVL': '1', 08:55:49 INFO - 'TERM': 'linux', 08:55:49 INFO - 'TMOUT': '86400', 08:55:49 INFO - 'USER': 'cltbld', 08:55:49 INFO - 'XDG_SESSION_COOKIE': '88e9d754c8c9af9f7805d7f3000001bd-1495900511.454322-1004867611', 08:55:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:55:49 INFO - '_': '/tools/buildbot/bin/python'} 08:55:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:55:49 INFO - Downloading/unpacking jsonschema==2.5.1 08:55:49 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 08:55:49 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 08:55:49 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 08:55:49 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 08:55:50 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:55:50 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 08:55:50 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 08:55:50 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 08:55:50 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 08:55:50 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 08:55:51 INFO - Downloading functools32-3.2.3-2.tar.gz 08:55:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 08:55:51 INFO - warning: no files found matching '*.txt' 08:55:51 INFO - no previously-included directories found matching 'build' 08:55:51 INFO - no previously-included directories found matching 'dist' 08:55:51 INFO - no previously-included directories found matching '.git*' 08:55:51 INFO - Installing collected packages: jsonschema, functools32 08:55:51 INFO - Running setup.py install for functools32 08:55:51 INFO - warning: no files found matching '*.txt' 08:55:51 INFO - no previously-included directories found matching 'build' 08:55:51 INFO - no previously-included directories found matching 'dist' 08:55:51 INFO - no previously-included directories found matching '.git*' 08:55:51 INFO - Successfully installed jsonschema functools32 08:55:51 INFO - Cleaning up... 08:55:51 INFO - Return code: 0 08:55:51 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 08:55: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')]} 08:55:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:55: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')]} 08:55:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:55:51 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 0x13041f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14d1a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16775c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16747a0>, '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 0x16756a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1675b30>, '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': '88e9d754c8c9af9f7805d7f3000001bd-1495900511.454322-1004867611', '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 08:55:51 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 08:55:51 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 08:55:51 INFO - Using env: {'DISPLAY': ':0', 08:55:51 INFO - 'HOME': '/home/cltbld', 08:55:51 INFO - 'LANG': 'en_US.UTF-8', 08:55:51 INFO - 'LANGUAGE': 'en_US:en', 08:55:51 INFO - 'LOGNAME': 'cltbld', 08:55:51 INFO - 'MAIL': '/var/mail/cltbld', 08:55:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:55:51 INFO - 'MOZ_NO_REMOTE': '1', 08:55:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:55:51 INFO - 'NO_EM_RESTART': '1', 08:55:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:55:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:55:51 INFO - 'PWD': '/builds/slave/test', 08:55:51 INFO - 'SHELL': '/bin/bash', 08:55:51 INFO - 'SHLVL': '1', 08:55:51 INFO - 'TERM': 'linux', 08:55:51 INFO - 'TMOUT': '86400', 08:55:51 INFO - 'USER': 'cltbld', 08:55:51 INFO - 'XDG_SESSION_COOKIE': '88e9d754c8c9af9f7805d7f3000001bd-1495900511.454322-1004867611', 08:55:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:55:51 INFO - '_': '/tools/buildbot/bin/python'} 08:55:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:55:51 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 08:55:51 INFO - Cleaning up... 08:55:51 INFO - Return code: 0 08:55:51 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:55: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')]} 08:55:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:55: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')]} 08:55:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:55:51 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 0x13041f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14d1a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16775c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16747a0>, '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 0x16756a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1675b30>, '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': '88e9d754c8c9af9f7805d7f3000001bd-1495900511.454322-1004867611', '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 08:55:51 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 08:55:51 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 08:55:51 INFO - Using env: {'DISPLAY': ':0', 08:55:51 INFO - 'HOME': '/home/cltbld', 08:55:51 INFO - 'LANG': 'en_US.UTF-8', 08:55:51 INFO - 'LANGUAGE': 'en_US:en', 08:55:51 INFO - 'LOGNAME': 'cltbld', 08:55:51 INFO - 'MAIL': '/var/mail/cltbld', 08:55:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:55:51 INFO - 'MOZ_NO_REMOTE': '1', 08:55:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:55:51 INFO - 'NO_EM_RESTART': '1', 08:55:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:55:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:55:51 INFO - 'PWD': '/builds/slave/test', 08:55:51 INFO - 'SHELL': '/bin/bash', 08:55:51 INFO - 'SHLVL': '1', 08:55:51 INFO - 'TERM': 'linux', 08:55:51 INFO - 'TMOUT': '86400', 08:55:51 INFO - 'USER': 'cltbld', 08:55:51 INFO - 'XDG_SESSION_COOKIE': '88e9d754c8c9af9f7805d7f3000001bd-1495900511.454322-1004867611', 08:55:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:55:51 INFO - '_': '/tools/buildbot/bin/python'} 08:55:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:55:51 INFO - Downloading/unpacking blobuploader==1.2.4 08:55:51 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 08:55:51 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 08:55:51 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 08:55:51 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 08:55:52 INFO - Downloading blobuploader-1.2.4.tar.gz 08:55:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:55:52 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:55:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:55:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:55:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:55:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:55:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:55:53 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:55:53 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 08:55:53 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 08:55:53 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 08:55:53 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 08:55:53 INFO - Downloading docopt-0.6.1.tar.gz 08:55:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:55:53 INFO - Installing collected packages: blobuploader, requests, docopt 08:55:53 INFO - Running setup.py install for blobuploader 08:55:53 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:55:53 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:55:53 INFO - Running setup.py install for requests 08:55:54 INFO - Running setup.py install for docopt 08:55:54 INFO - Successfully installed blobuploader requests docopt 08:55:54 INFO - Cleaning up... 08:55:54 INFO - Return code: 0 08:55:54 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:55: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')]} 08:55:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:55: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')]} 08:55:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:55:54 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 0x13041f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14d1a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16775c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16747a0>, '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 0x16756a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1675b30>, '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': '88e9d754c8c9af9f7805d7f3000001bd-1495900511.454322-1004867611', '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 08:55:54 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 08:55:54 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 08:55:54 INFO - Using env: {'DISPLAY': ':0', 08:55:54 INFO - 'HOME': '/home/cltbld', 08:55:54 INFO - 'LANG': 'en_US.UTF-8', 08:55:54 INFO - 'LANGUAGE': 'en_US:en', 08:55:54 INFO - 'LOGNAME': 'cltbld', 08:55:54 INFO - 'MAIL': '/var/mail/cltbld', 08:55:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:55:54 INFO - 'MOZ_NO_REMOTE': '1', 08:55:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:55:54 INFO - 'NO_EM_RESTART': '1', 08:55:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:55:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:55:54 INFO - 'PWD': '/builds/slave/test', 08:55:54 INFO - 'SHELL': '/bin/bash', 08:55:54 INFO - 'SHLVL': '1', 08:55:54 INFO - 'TERM': 'linux', 08:55:54 INFO - 'TMOUT': '86400', 08:55:54 INFO - 'USER': 'cltbld', 08:55:54 INFO - 'XDG_SESSION_COOKIE': '88e9d754c8c9af9f7805d7f3000001bd-1495900511.454322-1004867611', 08:55:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:55:54 INFO - '_': '/tools/buildbot/bin/python'} 08:55:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:55:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:55:54 INFO - Running setup.py (path:/tmp/pip-g8Lecn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:55:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:55:54 INFO - Running setup.py (path:/tmp/pip-ew1kho-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:55:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:55:54 INFO - Running setup.py (path:/tmp/pip-zRpS8J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:55:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:55:54 INFO - Running setup.py (path:/tmp/pip-hukfvy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:55:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:55:54 INFO - Running setup.py (path:/tmp/pip-_N3qKd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:55:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:55:54 INFO - Running setup.py (path:/tmp/pip-4KLRKC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:55:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:55:54 INFO - Running setup.py (path:/tmp/pip-sVw77d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:55:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:55:55 INFO - Running setup.py (path:/tmp/pip-CTFByz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:55:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:55:55 INFO - Running setup.py (path:/tmp/pip-X19I13-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:55:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:55:55 INFO - Running setup.py (path:/tmp/pip-yn5JAY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:55:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:55:55 INFO - Running setup.py (path:/tmp/pip-5nIWYH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:55:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:55:55 INFO - Running setup.py (path:/tmp/pip-gsRYOl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:55:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:55:55 INFO - Running setup.py (path:/tmp/pip-9hiWcZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:55:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:55:55 INFO - Running setup.py (path:/tmp/pip-5rErHu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:55:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:55:55 INFO - Running setup.py (path:/tmp/pip-wHsbOe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:55:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:55:55 INFO - Running setup.py (path:/tmp/pip-PkOlgb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:55:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:55:55 INFO - Running setup.py (path:/tmp/pip-_0j3g6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:55:55 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:55:55 INFO - Running setup.py install for manifestparser 08:55:55 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:55:55 INFO - Running setup.py install for mozcrash 08:55:55 INFO - Running setup.py install for mozdebug 08:55:56 INFO - Running setup.py install for mozdevice 08:55:56 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:55:56 INFO - Running setup.py install for mozfile 08:55:56 INFO - Running setup.py install for mozhttpd 08:55:56 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:55:56 INFO - Running setup.py install for mozinfo 08:55:56 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:55:56 INFO - Running setup.py install for mozInstall 08:55:56 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:55:56 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:55:56 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:55:56 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:55:56 INFO - Running setup.py install for mozleak 08:55:56 INFO - Running setup.py install for mozlog 08:55:56 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:55:56 INFO - Running setup.py install for moznetwork 08:55:56 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:55:56 INFO - Running setup.py install for mozprocess 08:55:56 INFO - Running setup.py install for mozprofile 08:55:57 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:55:57 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:55:57 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:55:57 INFO - Running setup.py install for mozrunner 08:55:57 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:55:57 INFO - Running setup.py install for mozscreenshot 08:55:57 INFO - Running setup.py install for moztest 08:55:57 INFO - Running setup.py install for mozversion 08:55:57 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:55:57 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:55:57 INFO - Cleaning up... 08:55:57 INFO - Return code: 0 08:55:57 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:55:57 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')]} 08:55:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:55:57 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')]} 08:55:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:55:57 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 0x13041f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14d1a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16775c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16747a0>, '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 0x16756a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1675b30>, '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': '88e9d754c8c9af9f7805d7f3000001bd-1495900511.454322-1004867611', '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 08:55:57 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 08:55:57 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 08:55:57 INFO - Using env: {'DISPLAY': ':0', 08:55:57 INFO - 'HOME': '/home/cltbld', 08:55:57 INFO - 'LANG': 'en_US.UTF-8', 08:55:57 INFO - 'LANGUAGE': 'en_US:en', 08:55:57 INFO - 'LOGNAME': 'cltbld', 08:55:57 INFO - 'MAIL': '/var/mail/cltbld', 08:55:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:55:57 INFO - 'MOZ_NO_REMOTE': '1', 08:55:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:55:57 INFO - 'NO_EM_RESTART': '1', 08:55:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:55:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:55:57 INFO - 'PWD': '/builds/slave/test', 08:55:57 INFO - 'SHELL': '/bin/bash', 08:55:57 INFO - 'SHLVL': '1', 08:55:57 INFO - 'TERM': 'linux', 08:55:57 INFO - 'TMOUT': '86400', 08:55:57 INFO - 'USER': 'cltbld', 08:55:57 INFO - 'XDG_SESSION_COOKIE': '88e9d754c8c9af9f7805d7f3000001bd-1495900511.454322-1004867611', 08:55:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:55:57 INFO - '_': '/tools/buildbot/bin/python'} 08:55:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:55:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:55:57 INFO - Running setup.py (path:/tmp/pip-4Kdi2Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:55:57 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)) 08:55:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:55:57 INFO - Running setup.py (path:/tmp/pip-uoylax-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:55:57 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)) 08:55:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:55:57 INFO - Running setup.py (path:/tmp/pip-7RkPhM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:55:57 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)) 08:55:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:55:57 INFO - Running setup.py (path:/tmp/pip-m0mM1g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:55:58 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)) 08:55:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:55:58 INFO - Running setup.py (path:/tmp/pip-Ff69G6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:55:58 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)) 08:55:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:55:58 INFO - Running setup.py (path:/tmp/pip-QIn51Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:55:58 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)) 08:55:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:55:58 INFO - Running setup.py (path:/tmp/pip-E5GGLa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:55:58 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)) 08:55:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:55:58 INFO - Running setup.py (path:/tmp/pip-HaDUAe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:55:58 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)) 08:55:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:55:58 INFO - Running setup.py (path:/tmp/pip-5GPysQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:55:58 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)) 08:55:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:55:58 INFO - Running setup.py (path:/tmp/pip-LXqccd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:55:58 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)) 08:55:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:55:58 INFO - Running setup.py (path:/tmp/pip-acFE94-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:55:58 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)) 08:55:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:55:58 INFO - Running setup.py (path:/tmp/pip-vazQNN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:55:58 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)) 08:55:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:55:58 INFO - Running setup.py (path:/tmp/pip-Fv3fCL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:55:58 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)) 08:55:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:55:58 INFO - Running setup.py (path:/tmp/pip-nwFBnt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:55:58 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)) 08:55:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:55:58 INFO - Running setup.py (path:/tmp/pip-xGoDnd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:55:58 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)) 08:55:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:55:58 INFO - Running setup.py (path:/tmp/pip-oVPBJh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:55:58 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)) 08:55:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:55:58 INFO - Running setup.py (path:/tmp/pip-8snKmr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:55:58 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)) 08:55:58 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)) 08:55:58 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)) 08:55:58 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)) 08:55:58 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)) 08:55:58 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)) 08:55:58 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:55:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:55:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:55:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:55:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:56:00 INFO - Downloading blessings-1.6.tar.gz 08:56:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:56:00 INFO - Installing collected packages: blessings 08:56:00 INFO - Running setup.py install for blessings 08:56:00 INFO - Successfully installed blessings 08:56:00 INFO - Cleaning up... 08:56:00 INFO - Return code: 0 08:56:00 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:56:00 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:56:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:56:00 INFO - Reading from file tmpfile_stdout 08:56:00 INFO - Current package versions: 08:56:00 INFO - argparse == 1.2.1 08:56:00 INFO - blessings == 1.6 08:56:00 INFO - blobuploader == 1.2.4 08:56:00 INFO - docopt == 0.6.1 08:56:00 INFO - functools32 == 3.2.3-2 08:56:00 INFO - jsonschema == 2.5.1 08:56:00 INFO - manifestparser == 1.1 08:56:00 INFO - mozInstall == 1.12 08:56:00 INFO - mozcrash == 1.0 08:56:00 INFO - mozdebug == 0.1 08:56:00 INFO - mozdevice == 0.51 08:56:00 INFO - mozfile == 1.2 08:56:00 INFO - mozhttpd == 0.7 08:56:00 INFO - mozinfo == 0.9 08:56:00 INFO - mozleak == 0.1 08:56:00 INFO - mozlog == 3.4 08:56:00 INFO - moznetwork == 0.27 08:56:00 INFO - mozprocess == 0.25 08:56:00 INFO - mozprofile == 0.28 08:56:00 INFO - mozrunner == 6.13 08:56:00 INFO - mozscreenshot == 0.1 08:56:00 INFO - mozsystemmonitor == 0.3 08:56:00 INFO - moztest == 0.8 08:56:00 INFO - mozversion == 1.4 08:56:00 INFO - psutil == 3.1.1 08:56:00 INFO - requests == 1.2.3 08:56:00 INFO - wsgiref == 0.1.2 08:56:00 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:56:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:56:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:56:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:56:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:56:00 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 0x13041f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14d1a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16775c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16747a0>, '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 0x16756a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1675b30>, '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': '88e9d754c8c9af9f7805d7f3000001bd-1495900511.454322-1004867611', '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 08:56:00 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 08:56:00 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 08:56:00 INFO - Using env: {'DISPLAY': ':0', 08:56:00 INFO - 'HOME': '/home/cltbld', 08:56:00 INFO - 'LANG': 'en_US.UTF-8', 08:56:00 INFO - 'LANGUAGE': 'en_US:en', 08:56:00 INFO - 'LOGNAME': 'cltbld', 08:56:00 INFO - 'MAIL': '/var/mail/cltbld', 08:56:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:56:00 INFO - 'MOZ_NO_REMOTE': '1', 08:56:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:56:00 INFO - 'NO_EM_RESTART': '1', 08:56:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:56:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:56:00 INFO - 'PWD': '/builds/slave/test', 08:56:00 INFO - 'SHELL': '/bin/bash', 08:56:00 INFO - 'SHLVL': '1', 08:56:00 INFO - 'TERM': 'linux', 08:56:00 INFO - 'TMOUT': '86400', 08:56:00 INFO - 'USER': 'cltbld', 08:56:00 INFO - 'XDG_SESSION_COOKIE': '88e9d754c8c9af9f7805d7f3000001bd-1495900511.454322-1004867611', 08:56:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:56:00 INFO - '_': '/tools/buildbot/bin/python'} 08:56:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:56:00 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)) 08:56:00 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)) 08:56:00 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)) 08:56:00 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)) 08:56:00 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)) 08:56:00 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)) 08:56:00 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)) 08:56:00 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)) 08:56:00 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)) 08:56:00 INFO - Downloading/unpacking marionette-driver>=1.4.0 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 08:56:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:56:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:56:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:56:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:56:01 INFO - Downloading marionette_driver-1.4.0.tar.gz 08:56:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/marionette-driver/setup.py) egg_info for package marionette-driver 08:56:01 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)) 08:56:01 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)) 08:56:01 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)) 08:56:01 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)) 08:56:01 INFO - Installing collected packages: marionette-driver 08:56:01 INFO - Running setup.py install for marionette-driver 08:56:01 INFO - Successfully installed marionette-driver 08:56:01 INFO - Cleaning up... 08:56:02 INFO - Return code: 0 08:56:02 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 08:56:02 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')]} 08:56:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:56:02 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')]} 08:56:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:56:02 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 0x13041f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14d1a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16775c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16747a0>, '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 0x16756a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1675b30>, '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': '88e9d754c8c9af9f7805d7f3000001bd-1495900511.454322-1004867611', '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 08:56:02 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 08:56:02 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 08:56:02 INFO - Using env: {'DISPLAY': ':0', 08:56:02 INFO - 'HOME': '/home/cltbld', 08:56:02 INFO - 'LANG': 'en_US.UTF-8', 08:56:02 INFO - 'LANGUAGE': 'en_US:en', 08:56:02 INFO - 'LOGNAME': 'cltbld', 08:56:02 INFO - 'MAIL': '/var/mail/cltbld', 08:56:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:56:02 INFO - 'MOZ_NO_REMOTE': '1', 08:56:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:56:02 INFO - 'NO_EM_RESTART': '1', 08:56:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:56:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:56:02 INFO - 'PWD': '/builds/slave/test', 08:56:02 INFO - 'SHELL': '/bin/bash', 08:56:02 INFO - 'SHLVL': '1', 08:56:02 INFO - 'TERM': 'linux', 08:56:02 INFO - 'TMOUT': '86400', 08:56:02 INFO - 'USER': 'cltbld', 08:56:02 INFO - 'XDG_SESSION_COOKIE': '88e9d754c8c9af9f7805d7f3000001bd-1495900511.454322-1004867611', 08:56:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:56:02 INFO - '_': '/tools/buildbot/bin/python'} 08:56:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:56:02 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 08:56:02 INFO - Cleaning up... 08:56:02 INFO - Return code: 0 08:56:02 INFO - Running post-action listener: _resource_record_post_action 08:56:02 INFO - Running post-action listener: _start_resource_monitoring 08:56:02 INFO - Starting resource monitoring. 08:56:02 INFO - [mozharness: 2017-05-27 15:56:02.296638Z] Finished create-virtualenv step (success) 08:56:02 INFO - [mozharness: 2017-05-27 15:56:02.297128Z] Running install step. 08:56:02 INFO - Running pre-action listener: _resource_record_pre_action 08:56:02 INFO - Running main action method: install 08:56:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:56:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:56:02 INFO - Reading from file tmpfile_stdout 08:56:02 INFO - Detecting whether we're running mozinstall >=1.0... 08:56:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:56:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:56:02 INFO - Reading from file tmpfile_stdout 08:56:02 INFO - Output received: 08:56:02 INFO - Usage: mozinstall [options] installer 08:56:02 INFO - Options: 08:56:02 INFO - -h, --help show this help message and exit 08:56:02 INFO - -d DEST, --destination=DEST 08:56:02 INFO - Directory to install application into. [default: 08:56:02 INFO - "/builds/slave/test"] 08:56:02 INFO - --app=APP Application being installed. [default: firefox] 08:56:02 INFO - mkdir: /builds/slave/test/build/application 08:56:02 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'] 08:56:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 08:56:18 INFO - Reading from file tmpfile_stdout 08:56:18 INFO - Output received: 08:56:18 INFO - /builds/slave/test/build/application/firefox/firefox 08:56:18 INFO - Running post-action listener: _resource_record_post_action 08:56:18 INFO - [mozharness: 2017-05-27 15:56:18.126139Z] Finished install step (success) 08:56:18 INFO - [mozharness: 2017-05-27 15:56:18.126267Z] Running run-tests step. 08:56:18 INFO - Running pre-action listener: _resource_record_pre_action 08:56:18 INFO - Running main action method: run_tests 08:56:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:56:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:56:18 INFO - Python 2.7.3 08:56:18 INFO - Return code: 0 08:56:18 INFO - grabbing minidump binary from tooltool 08:56:18 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')]} 08:56:18 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 0x16747a0>, '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 0x16756a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1675b30>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:56:18 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 08:56:18 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 08:56:18 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 08:56:18 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:56:18 INFO - Return code: 0 08:56:18 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 08:56:18 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:56:18 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:56:18 INFO - ENV: RUST_BACKTRACE is now 1 08:56:18 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 08:56:18 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:56:18 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/VYCP9MoKR1-Ju82qtJdrjg/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-044', '--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 08:56:18 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/VYCP9MoKR1-Ju82qtJdrjg/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-044 --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 08:56:18 INFO - Using env: {'DISPLAY': ':0', 08:56:18 INFO - 'HOME': '/home/cltbld', 08:56:18 INFO - 'LANG': 'en_US.UTF-8', 08:56:18 INFO - 'LANGUAGE': 'en_US:en', 08:56:18 INFO - 'LOGNAME': 'cltbld', 08:56:18 INFO - 'MAIL': '/var/mail/cltbld', 08:56:18 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:56:18 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 08:56:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:56:18 INFO - 'MOZ_NO_REMOTE': '1', 08:56:18 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:56:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:56:18 INFO - 'NO_EM_RESTART': '1', 08:56:18 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:56:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:56:18 INFO - 'PWD': '/builds/slave/test', 08:56:18 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:56:18 INFO - 'RUST_BACKTRACE': '1', 08:56:18 INFO - 'SHELL': '/bin/bash', 08:56:18 INFO - 'SHLVL': '1', 08:56:18 INFO - 'TERM': 'linux', 08:56:18 INFO - 'TMOUT': '86400', 08:56:18 INFO - 'USER': 'cltbld', 08:56:18 INFO - 'XDG_SESSION_COOKIE': '88e9d754c8c9af9f7805d7f3000001bd-1495900511.454322-1004867611', 08:56:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:56:18 INFO - '_': '/tools/buildbot/bin/python'} 08:56:18 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/VYCP9MoKR1-Ju82qtJdrjg/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-044', '--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 08:56:18 INFO - mozversion application_buildid: 20170527151705 08:56:18 INFO - mozversion application_changeset: 35099b4caec14bf0e3c5e3fed7a17dd3faf51dbe 08:56:18 INFO - mozversion application_display_name: Nightly 08:56:18 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:56:18 INFO - mozversion application_name: Firefox 08:56:18 INFO - mozversion application_remotingname: firefox 08:56:18 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 08:56:18 INFO - mozversion application_vendor: Mozilla 08:56:18 INFO - mozversion application_version: 55.0a1 08:56:18 INFO - mozversion platform_buildid: 20170527151705 08:56:18 INFO - mozversion platform_changeset: 35099b4caec14bf0e3c5e3fed7a17dd3faf51dbe 08:56:18 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 08:56:18 INFO - mozversion platform_version: 55.0a1 08:56:18 INFO - using testdate: 1495900578 08:56:18 INFO - actual date: 1495900578 08:56:18 INFO - starting webserver on 'localhost:45129' 08:56:18 INFO - SUITE-START | Running 2 tests 08:56:18 INFO - TEST-START | dromaeo_css 08:56:18 INFO - operating with platform_type : linux_ 08:56:18 INFO - Initialising browser for dromaeo_css test... 08:56:18 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:45129/getInfo.html -profile /tmp/tmp0cprWG/profile 08:56:18 INFO - TEST-INFO | started process 12541 (/builds/slave/test/build/application/firefox/firefox http://localhost:45129/getInfo.html) 08:56:53 INFO - TEST-INFO | 12541: killed by SIGTERM 08:56:53 INFO - Browser initialized. 08:56:53 INFO - Running cycle 1/1 for dromaeo_css test... 08:56:53 INFO - TEST-INFO | started process 12738 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp0cprWG/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:57:05 INFO - PID 12738 | RSS: Main: 183115776 08:57:05 INFO - PID 12738 | 09:00:09 INFO - PID 12738 | Cycle 1(1): loaded http://localhost:45129/tests/dromaeo/cssquery-dojo.html (next: http://localhost:45129/tests/dromaeo/cssquery-ext.html) 09:00:11 INFO - PID 12738 | RSS: Main: 179892224 09:00:11 INFO - PID 12738 | 09:03:13 INFO - PID 12738 | Cycle 1(1): loaded http://localhost:45129/tests/dromaeo/cssquery-ext.html (next: http://localhost:45129/tests/dromaeo/cssquery-jquery.html) 09:03:14 INFO - PID 12738 | RSS: Main: 183107584 09:03:14 INFO - PID 12738 | 09:06:15 INFO - PID 12738 | Cycle 1(1): loaded http://localhost:45129/tests/dromaeo/cssquery-jquery.html (next: http://localhost:45129/tests/dromaeo/cssquery-mootools.html) 09:06:16 INFO - PID 12738 | RSS: Main: 180969472 09:06:16 INFO - PID 12738 | 09:09:18 INFO - PID 12738 | Cycle 1(1): loaded http://localhost:45129/tests/dromaeo/cssquery-mootools.html (next: http://localhost:45129/tests/dromaeo/cssquery-prototype.html) 09:09:18 INFO - PID 12738 | RSS: Main: 184889344 09:09:18 INFO - PID 12738 | 09:12:21 INFO - PID 12738 | Cycle 1(1): loaded http://localhost:45129/tests/dromaeo/cssquery-prototype.html (next: http://localhost:45129/tests/dromaeo/cssquery-yui.html) 09:12:22 INFO - PID 12738 | RSS: Main: 185405440 09:12:22 INFO - PID 12738 | 09:15:24 INFO - PID 12738 | Cycle 1(1): loaded http://localhost:45129/tests/dromaeo/cssquery-yui.html (next: http://localhost:45129/tests/dromaeo/cssquery-dojo.html) 09:15:24 INFO - PID 12738 | RSS: Main: 181420032 09:15:24 INFO - PID 12738 | 09:15:24 INFO - PID 12738 | __start_tp_report 09:15:24 INFO - PID 12738 | _x_x_mozilla_page_load 09:15:24 INFO - PID 12738 | _x_x_mozilla_page_load_details 09:15:24 INFO - PID 12738 | |i|pagename|runs| 09:15:24 INFO - PID 12738 | |0;dojo.html;2732.1530325599065;2735.275152084697;2757.4622948525034;2776.9861150694232;2779.0273404308496;5236.240745091969;5346.438623944483;5350.010248104103;5380.287601554929;5386.649867758593;5298.7350632468315;5306;5336.59975501837;5384.326959130109;5395.406505284415;4474.373587697725;4724.994428072619;4776.785044672989;4782.521747825207;4799.592034677056;4828.420589529243;4866.6106711463;4872.196087645534;4882.609391248691;4898.044881248158;4721.032188401369;4727.834525791615;4772.117158325686;4818.68678535894;4839.177339852234;4766.784469960138;4779.044191161747;4786;4806.951930480685;4829.10661527615;4728.881777955578;4748.311494833264;4759.690620109682;4771.737554434505;4787.114383839001;5221.582273418117;5285.973570132163;5358.276632654581;5362.973185134088;5401.405845357047;5688.715564221772;5741.712914354265;5789.507891829199;5792.102224155263;5792.855178620568;5741.799037033684;5764.769409223626;5774.16274640179;5778.335491418498;5789.363170051291;5375.301210842644;5376.086065368897;5381.623286369995;5384.461553844584;5386.326709161355;5836.095405212199;5839.795607153729;5905.025670764276;5908.4091590841435;5920.289565252111;5630.85922851932;5656.4060773619;5656.717164141776;5696.971515142398;5704.771809127588;5630.746616402272;5737.139429085671;5740.885182296331;5753.568482363839;5756.510696590837;5611.046122159161;5658.74535645897;5712.571557133148;5715.371309155989;5715.799947001919;5661.49046585801;5691.373948865621;5730;5734.111212762028;5740.741666625012;4811.735354555533;4811.759412029384;4817.301491283814;4833.9033219335415;4854.611631069506;4092.3247664135083;4115.691323150776;4116.897077573085;4122.505299364036;4147.709660323749;4731.313959475857;4775.331453596499;4800.927986080212;4826;4853.708777473363;5746.569007324384;5783.479486846204;5787.045137552341;5793.565482588822;5802.47777700009;4809.062232864558;4811;4811;4813.614910807127;4849.345338379274;5074.847754567369;5078.339815823919;5081.7967281309075;5092.28707980883;5097.643164978416;5185.196294574347;5244.921326180034;5310.256564081109;5375.973120134374;5378.811741589026;5688.63023903445;5772.393898640582;5780.554861284679;5834.737436815269;5880.26496687914;5171.715555644476;5271.78912843482;5286.709230992333;5341.332333458317;5350.357957045179;5648.4633959773755;5655.547556195576;5655.7454914528125;5660;5705.543556515386;5690.118031705092;5771.192033115283;5774.191613174243;5780.335261444988;5782;5540.722963851872;5575.024370735024;5628.662280263197;5640.830775076754;5659.830205093854;5540.196671482693;5548.334199896039;5549.056660367828;5550.222968784293;5568.55451563882;5428.07722687152;5449.64577302474;5465.988792073479;5477.698726570077;5513.255710479194;5513.4486551346145;5574.693391863487;5606.299212598426;5608.186812912023;5680.892226015887;5538.252335934597;5545.140503222007;5558.638688485235;5562.833115006556;5567.47109024642 09:15:24 INFO - PID 12738 | |1;ext.html;665.8235567574594;737.7307282841763;752.2665401233796;1200.393801130429;1246.7132559511317;33238.83380583097;34246.14384640385;34418;34449.483257751126;34470;34144.65855341446;34158.65841341586;34477.31045379091;34524.30951380971;34524.48213276797;6564.737410503586;6672.466202703797;6696.430803381694;6795.1166348374645;6802.727890884384;6759.695813688371;6848.589084654936;6853.314668533157;6854.143232095988;6864.107666003412;6797.11637487126;6875;6883.483738719591;6890.827729306782;6893.241743408221;6774.119364482635;6793.45652347811;6814.62519561424;6836.965815170942;6844.315568443166;6762.323767623198;6810.523263371566;6822.079019332426;6834.248232694449;6860.485463590251;32494.512582311283;32534.349313013845;32682.836585817156;32743.017709468517;32803;3083.7378822800088;3122.531620256957;3128.9843550782102;3130.7182353588287;3137.984310078458;25015.87492062528;25095.62356564653;25097.749022509906;25127.24618261455;25187.37031574207;3076.86154123065;3102.255458689921;3110.424571454266;3139.277966067817;3149.7795154339206;122765.38617306946;123537.38231308876;134272.32863835717;149202;150653;39732;39826.60173398287;40189.59810401917;40264.59735402667;40332;42256.57743422588;42294.57705422906;42396.364054539205;44944;45756.77121614371;13485.932570337085;13498.527551535846;13617.842483388824;13620.455181792617;13629.25039122838;10772.461376931122;10780.29928054674;10785.62250321235;10824.945875270574;10851.131909447226;12968.286744229157;12971.805422918475;12996.870031299755;13070.281134537692;13179.275139867208;5372.274742909735;5431.4840090191365;5443.183522471661;5465.125579907275;5503.11950087984;842.5829214538843;877.5656050255037;914.8764916736288;917.2570218123342;939.699296225215;21566.892165539386;21605;21748.782512174992;21754.89122554377;22006;984.5274268351232;996.4469719305855;1022.1669339488293;1022.539857064324;1025.092792878308;11257.662270131908;11455.255408398427;11627.302361858316;11638;11646.650600481998;180163;180482;181390;181520;181578.09210954126;42433;42568.78715606402;42589.57410425918;42694.573054269684;42748.78625606914;1175.1850196195198;1221.096388672394;1228.2139430764319;1230.6123571075082;1260.6218134559595;19404;19853.205871765545;20343.898280508503;21336.78663213348;21559.676604850625;29347;29423.558646620746;29670.40659186761;29776.702232977394;29794.553081703358;151883.21751737327;153126;153254;153596.2320188392;153777;29806.10581682553;29806.70193298039;29998;30922.845385773828;31113.222169445944;36634;36972.44541331936;36975.44536831896;37207.25585488329;37247.441288380156;26786;27502;27694.44611107807;27951.161465156078;28496.43007139887;27580.620968951873;27650.723492764813;28578.142655720363;28746.568801468413;29036;31144.844275778476;31254;31356.216094597818;31401.8429907849;31484.68515314909;27535;27812.304692382044;27934.3016424591;28298.434031318848;29348.11955641334;22450.32649020532;23041.65437518472;23161.189358372376;23378.883105584362;23530.529389411775 09:15:24 INFO - PID 12738 | |2;jquery.html;418.10734082733353;426.1413252296622;428.9815748114249;433.72241765270223;442.1885839484544;14271.92864035681;17130.828691713094;17649.29402823887;17710.380136695236;17774.200160992754;17819.91090044548;17973.7303940441;18183.909080454578;18483.630327393443;18657.720134197996;5122.334096567441;5464.3442786865635;5630.802921897734;5637.7181140942785;5641.915371269434;5277.656952298088;5281.445448227919;5317.494837990404;5327.840164795043;5340.599455040868;5208.270842082112;5265.210218467222;5276.657017293883;5279.973600131994;5298.993191293661;5359.1425371940495;5376.542993845528;5392.352917649888;5411.18832175173;5416.133418653017;4842.370491836039;4853.684510506841;4872.610191184696;4893.363862697826;4893.535114164149;21717.782822171735;22394.192987192215;22442.77557224423;22476.550468990692;22681.54636907269;1577.3138684672203;1579.778830963666;1583.627847455847;1591.2282542966768;1606.6304749907588;14399.78400323996;14513.27433628325;14517.637059073502;14913.227767114528;14917.403303867832;1986.8410527157794;2001.8198362147477;2034.0338339288867;2039.3066357438395;2078.2310545098258;90919.54540227323;91204;94278;94568.52715736446;97263;10603.310784798963;11040.613578524873;11061.612843550438;11074.223617965174;11337.546498139982;14752.704945901021;15465.072095674295;15572.532824015298;15590;15753.842461575237;7877.606119693993;8085.676572937135;8151.755447336589;8158.143394943564;8163.346932245406;7530.472866899265;7550.924490755132;7669.156392796899;7814.726484573012;7829.45193836426;6693.866122677519;6800.4219641330055;6936.93063069373;6939.653017349112;7046.964765176142;2064.9277275295294;2070.7411573553304;2081.875087494755;2096.989515052415;2173.3371321746704;860.8364410761935;897.3090720145451;898.5641963647626;904.4076130134772;914.1681070226063;16639.83360166407;16929.83070169307;17006.91496542534;17242;17808.287668493114;899.7705585075895;902.9954850225707;905.1310741688053;905.8369493491103;911.1025639744846;9247.907520924839;9687;9711.514424278757;9718.271129665303;9804.754881128029;366205;369503;369629;370660;385653;74582.62708686531;76738.6163069181;77340.61329693315;77467;77735.61132194416;1027.6762819711766;1054.1198099586777;1085.0993675249524;1087.6302057300556;1090.225939582905;14871;14901.701965960838;14934.701305974037;15039.774403383739;15475.767863481831;38023.429648555844;38108.23783524369;38513;39304.60695393124;40055.799721002375;45188;45592.54407456016;46505;46784.53215467938;47335.28997065116;7733.806654833674;7812.804679882821;7813.492123011986;7921.207879212033;7956.323712484272;12187.207831490925;12515.374231288217;12609.423822022247;12833.871661283267;13402.865971340161;10203;10260.692179234635;10397.688069357931;10463.162946964072;10851.752048514521;9798.216142708709;9878.802423951336;10354.689359319233;10508.474576271003;10512.57949682004;10081.243906706879;10155.136813370946;10252.23108266868;10303.690889273334;10601.41692206936;7823.804404889924;7980.361571074184;7981.40139489529;8011.399145064027;8034.397420193626;10104.141148002502;10264.794704106025;10331.690049298533;10358.119559837498;10393.636222732168 09:15:24 INFO - PID 12738 | |3;mootools.html;1262.7979523276274;1282.794752839546;1316.1050485669746;1319.9868001319983;1320.947162113515;10177.287589868713;10368.429736364496;10567.841482377771;10577.20670949679;10776.245662803607;10416.479176041206;10473.423961682105;10554.208434367434;10557.683269501907;10582.629607963703;2045.6420126477844;2090.7700152983234;2103.8948052597384;2112.1656945506516;2112.6830975353664;2076.989835694212;2105.378913220596;2113.74635043795;2113.74635043795;2114.1332053857923;1989.910454029565;2038.531137838298;2042.6119037382923;2043.7138800567932;2055.2806517718755;2011.8792872427628;2017.3645301729907;2023.4637820977525;2027.614753196888;2028.3914825552422;1998.5103649605794;2065.8760474371584;2142.121730090671;2144.0566150893715;2147.667111597689;10212.846807297896;10292.845607315896;10296.382217066925;10299.639512617023;10307.896921030844;5332.973335133338;5577.749001294951;5583.525400340935;5596.076647353222;5604.3835178130375;3193.696598823108;3366.394049071166;3404.5914490261325;3418.0429479745712;3444.4661077532774;1091.6888686724246;1099.6591056772347;1104.1111904916538;1107.6566264458045;1111.9054880335182;13831.377588008563;14290.92854535731;14791.40834366624;14945.70108597822;14946.551603451913;4759;4769.451513075971;4827.637927155477;4972.477889821589;4989.326440930428;12332.630021099381;12525.935295499985;12541.498340066477;12557.497700092077;12578.68553286157;5554.250176226238;5646.265985421951;5686.886262274731;5693.345265294462;5706.343770466449;5024.698518088926;5146.30524879144;5150.072986862326;5154.5103215194495;5178.456262092502;4075.9388609170887;4119.237940980928;4159.606531811816;4162.633587975724;4201.264778663722;1239.770642431135;1274.8661390554043;1274.878886505799;1291.251074376878;1294.100600082952;708.1820497325597;726.8328284494596;737.9741709040158;742.8737114690516;751.3988808952926;5531.806386776443;5597.720113994284;5602.6918519481005;5735.369109397963;5753.798617048383;543.6140340358311;560.2101037537053;560.4479587606205;562.1090571444306;562.2325525657449;3420;3434.1414646338417;3553.1958341841614;3773.3585290500682;4034.2133284009337;13135.34323283832;13286.667833304246;13516.12145210558;13546.729065418833;13572.185668859702;13295.20228786276;13332.333383330795;13436.126651767603;13454.26001569923;13481.66295842592;7169.24722904098;7509.699612015458;7563.092428908456;7611.809704757426;7633.351165151024;5740.253767010262;6263;6358.841028974312;6377.936220637735;6500.219973603198;11784.70538236551;12074.879251207376;12078.27530348182;12167.817482737943;12201.755964880831;12025.45885435175;12300.507979680713;13048.869511304765;13074.346282686018;13168.275744834125;8471.279941205066;8632.050474447931;8679.696210632597;8685.609147588248;8693;9441.386309889835;9766.169875560658;9772.511374431393;9830.75423114428;9873.308868379145;8075.9192408077515;8307.792305192419;8330.125336839545;8361.163883611833;8656.350773692124;8070.314023307849;8115.715949941724;8174.305184059422;8177.6320065596;8300.294474969454;6607.834804129935;6738.248055505505;6794.728210871707;6803.863922721419;6813;5237.633365664519;5413.918791218213;5415.512603865671;5457.727113644222;5476.397596264487;5422.295101636762;5441.700706461024;5447.9376521577915;5514.2004409359615;5606.24315717373 09:15:24 INFO - PID 12738 | |4;prototype.html;375.48933450507303;381.35931634853455;382.7492992090182;388.7861676078156;396.59151074393367;5495.752691128904;5531.889362212753;5569.582281328906;5573.665580065189;5580.358258800239;5272.8154514592;5403.189521571766;5423.050966080939;5424.620276580641;5451.48210919963;4227.619514243717;4228.090960443512;4235.3646952957;4241.363795430695;4251.936220956688;4224.197402493532;4229.471316085489;4233.788310584474;4236.766977816219;4237.152569486099;3935.330993731073;4048.2915489789316;4200.663946884242;4206.810693518783;4207.705460617758;4077.9592204077876;4079.9808141974872;4082.5917408259083;4090.2637525245445;4105.712600117993;3535.2045789697368;3537.451694987281;3538.5046093546925;3555.253396786678;3555.5022296878456;5152;5312.2828418163435;5329;5333.2000199969925;5342.732863356817;4746.857594272177;4793.352897358882;4795.448523419816;4796.400449943757;4801.423829140491;5723.5421166307015;5731.283589551306;5733.795902860405;5767.942320576783;5782.219400380979;3906.511686039245;3964.385520244367;3965.801709914522;3987.3819557968563;3991.102002049545;5967.522598192134;6020.4280593343565;6117.204763380777;6182.84542886427;6216.160818289518;4509.88725281864;4551.112533056088;4556.817727290938;4557.453105627346;4563.406757121553;4559.566841150086;4571.38286331341;4593.678442508993;4621.214393553104;4627.8611641650805;5009.0482808266315;5079.974600126976;5095.0828850806465;5105.489451054865;5119.771254898797;5882.205902203234;5885.087811389241;5888.4700376966275;5891.204687367236;5905.143754155623;1575.7006168827886;1576.5743249322618;1579.2340714753336;1583.2716950202805;1587;1130.6834086455806;1150.1776229995594;1159.3913195572393;1164.5167255589006;1166.731651720109;4986.301917731521;4988.478514053249;4989.750512474362;4997.100521906019;5027.396712394536;5998.100284957204;6011.368806275278;6030.547708921848;6043.607165534227;6044.697765111727;4784.928226076611;4934.644441779625;4986.675866068694;4998.550130488201;5000.874978125576;3147.9685203148133;3179.4118088153764;3185.4106990206424;3189.856456459465;3198.8400579971376;5417;5457.945420545744;5529.944700552943;5531.972340138354;5574.16387541872;6145.354737752561;6156.907646385308;6179.373766149369;6195.752169913243;6202.658853763086;5486.393962867606;5518.475744804237;5526.281583394213;5529.751161197675;5534.501894829485;5926.436988486087;5952.8809423812145;5981.970090149522;5982.551308651781;6036.0644100164545;5949.732262048132;5956.642601443928;5964.135200395832;5970;5971.28344598651;5256.159014557652;5381.515663590296;5399.487048730364;5454.618176727591;5523.143912693539;4113.272425581204;4121.587841215975;4136.234796562646;4148.688848336447;4165.91668166641;5874.647521148745;5964.731587078505;6008.218931538872;6024.795040991731;6065.059915713072;5748.367679555329;5773.364929857628;5811.302643682785;5817.621854579439;5822.379929032038;5763.6541807491685;5763.827085187451;5772.682502462405;5802.970985145047;5844.824655260349;5653.614864358258;5728.856778580569;5729.2265544151005;5733.082706766897;5745.253117094751;5873.327635925558;5881.676507791942;5881.676507792113;5882.5293976482635;5884.58656007994;5572.77708891656;5652.5477961762135;5655.519280861173;5664.943350566607;5704.885902281848 09:15:24 INFO - PID 12738 | |5;yui.html;752.0749478141889;769.957652329122;776.3827756933238;780.0989856715493;794.3287921706158;13334.33328333583;13862.168269903801;14272.286385680727;16292.918535407307;16730.41443549476;16894.662106757856;17084.487465376027;17133.571660708487;17167.313307467688;17197.312107515685;877.7410663854179;889.577450710912;898.4743924803997;899.4962820820328;908.5956749246587;888.537960260664;892.8660700894853;893.0444424465824;893.718478679214;894.239896088323;931.1898648176096;934.7336009237368;937.5312343828086;939.7603611079165;941.7316064921499;922.4004397141845;929.5398777605129;929.586334081334;932.3753085432776;932.9906700932971;686.8454597715524;690.8203866994568;691.5850489706136;692.0933577014077;693.1543516909362;14730.410783568752;15148.697026059417;15203.163825989566;15251.923740381228;15310;15583.298751556207;15797.21013949298;15963.521094367188;16038.919805401016;16054.43809466663;12548.937255313756;12736.108472406935;12774.297413642245;12802.615921522369;12918.41867115982;3056.5720799088144;3071.1861356740483;3083.198368424226;3085.0436364727007;3085.182426656938;84565.57717211374;84816;84959;87094.56452717696;87732;12722.936385318015;12784.40194975628;12815.231086134861;12857;12899.226046437243;23672.763272367058;24062.63906041411;24146;24191.879040605036;24280.392990175387;6296.779612713533;6401.391867772554;6626.966865165643;6689.063531105649;6718.361755633207;3072.5083986562045;3138.0899539133397;3153.30627262002;3162.984185079106;3167.889123880653;3583.4087375582735;3663.4687970244167;3665.560132784083;3671.541057367829;3673.9632603674154;809.6639894443857;810.0441479054772;815.5269943432795;825.5830805443213;825.7646570727314;595.6783336998059;606.1877084706515;610.5756499233079;614.5053232148164;634.4068296143121;10154.949225253826;10450.738731531621;10463.84304235437;10748.301360411548;11495;615.8922188616974;619.3434958943534;624.4567226512963;634.3624657219465;644.3427703742251;4273.230818452708;4527.683062185615;5001.799928002912;5010.824621138316;5020.49795020495;71361.2863871365;71985.64007180036;73076.63461682657;73152.26847731454;73474.63262683652;64806.35193648003;65107.674461627386;65966.67016664887;66496.33503664998;67138.66430667815;58572.414275856696;59635.40364596385;61255;61320.69339653273;62310.37689623136;10150.441725705157;11297;11474.426278685865;11608;11682.182247242612;27179.592306115028;27336.589951151145;27459.31351716223;27515.86242068777;28257.15228543147;34998.82500587481;35557.37754092055;35617.1095722609;36028;36485.635143649284;14813.555593332218;14958.40166393332;15054.247287635355;15163.620909477351;15325.540233793005;14388.082217612573;14757.557273281818;14758.409663613334;15047.924760376565;15047.924760376565;15121.243937802847;15433.84566154324;15526.844731552992;15571;15705.214739262763;12904.032197585031;12905.032122590655;13054.804177937149;13090.14914030585;13372.063955523408;14634.34145463478;14663;15106.471273505815;15351.155686437352;15519.5344139676;10943.45282735844;11079.944600276947;11305.26515776472;11311.490982905954;11570.59502917394;11375.54497820078;12306.75386492283;12671.366431678563;12993.090483666052;13124.27816470065 09:15:24 INFO - PID 12738 | __end_tp_report 09:15:24 INFO - PID 12738 | __start_cc_report 09:15:24 INFO - PID 12738 | _x_x_mozilla_cycle_collect,396 09:15:24 INFO - PID 12738 | __end_cc_report 09:15:24 INFO - PID 12738 | __startTimestamp1495901724349__endTimestamp 09:15:24 INFO - PID 12738 | 09:15:24 INFO - PID 12738 | ------- Summary: start ------- 09:15:24 INFO - PID 12738 | Number of tests: 6 09:15:24 INFO - PID 12738 | 09:15:24 INFO - PID 12738 | [#0] dojo.html Cycles:165 Average:5250.40 Median:5386.65 stddev:618.03 (11.5%) stddev-sans-first:587.50 09:15:24 INFO - PID 12738 | Values: 2732.2 2735.3 2757.5 2777.0 2779.0 5236.2 5346.4 5350.0 5380.3 5386.6 5298.7 5306.0 5336.6 5384.3 5395.4 4474.4 4725.0 4776.8 4782.5 4799.6 4828.4 4866.6 4872.2 4882.6 4898.0 4721.0 4727.8 4772.1 4818.7 4839.2 4766.8 4779.0 4786.0 4807.0 4829.1 4728.9 4748.3 4759.7 4771.7 4787.1 5221.6 5286.0 5358.3 5363.0 5401.4 5688.7 5741.7 5789.5 5792.1 5792.9 5741.8 5764.8 5774.2 5778.3 5789.4 5375.3 5376.1 5381.6 5384.5 5386.3 5836.1 5839.8 5905.0 5908.4 5920.3 5630.9 5656.4 5656.7 5697.0 5704.8 5630.7 5737.1 5740.9 5753.6 5756.5 5611.0 5658.7 5712.6 5715.4 5715.8 5661.5 5691.4 5730.0 5734.1 5740.7 4811.7 4811.8 4817.3 4833.9 4854.6 4092.3 4115.7 4116.9 4122.5 4147.7 4731.3 4775.3 4800.9 4826.0 4853.7 5746.6 5783.5 5787.0 5793.6 5802.5 4809.1 4811.0 4811.0 4813.6 4849.3 5074.8 5078.3 5081.8 5092.3 5097.6 5185.2 5244.9 5310.3 5376.0 5378.8 5688.6 5772.4 5780.6 5834.7 5880.3 5171.7 5271.8 5286.7 5341.3 5350.4 5648.5 5655.5 5655.7 5660.0 5705.5 5690.1 5771.2 5774.2 5780.3 5782.0 5540.7 5575.0 5628.7 5640.8 5659.8 5540.2 5548.3 5549.1 5550.2 5568.6 5428.1 5449.6 5466.0 5477.7 5513.3 5513.4 5574.7 5606.3 5608.2 5680.9 5538.3 5545.1 5558.6 5562.8 5567.5 09:15:24 INFO - PID 12738 | 09:15:24 INFO - PID 12738 | [#1] ext.html Cycles:180 Average:30534.62 Median:17012.55 stddev:40770.92 (239.7%) stddev-sans-first:40823.61 09:15:24 INFO - PID 12738 | Values: 665.8 737.7 752.3 1200.4 1246.7 33238.8 34246.1 34418.0 34449.5 34470.0 34144.7 34158.7 34477.3 34524.3 34524.5 6564.7 6672.5 6696.4 6795.1 6802.7 6759.7 6848.6 6853.3 6854.1 6864.1 6797.1 6875.0 6883.5 6890.8 6893.2 6774.1 6793.5 6814.6 6837.0 6844.3 6762.3 6810.5 6822.1 6834.2 6860.5 32494.5 32534.3 32682.8 32743.0 32803.0 3083.7 3122.5 3129.0 3130.7 3138.0 25015.9 25095.6 25097.7 25127.2 25187.4 3076.9 3102.3 3110.4 3139.3 3149.8 122765.4 123537.4 134272.3 149202.0 150653.0 39732.0 39826.6 40189.6 40264.6 40332.0 42256.6 42294.6 42396.4 44944.0 45756.8 13485.9 13498.5 13617.8 13620.5 13629.3 10772.5 10780.3 10785.6 10824.9 10851.1 12968.3 12971.8 12996.9 13070.3 13179.3 5372.3 5431.5 5443.2 5465.1 5503.1 842.6 877.6 914.9 917.3 939.7 21566.9 21605.0 21748.8 21754.9 22006.0 984.5 996.4 1022.2 1022.5 1025.1 11257.7 11455.3 11627.3 11638.0 11646.7 180163.0 180482.0 181390.0 181520.0 181578.1 42433.0 42568.8 42589.6 42694.6 42748.8 1175.2 1221.1 1228.2 1230.6 1260.6 19404.0 19853.2 20343.9 21336.8 21559.7 29347.0 29423.6 29670.4 29776.7 29794.6 151883.2 153126.0 153254.0 153596.2 153777.0 29806.1 29806.7 29998.0 30922.8 31113.2 36634.0 36972.4 36975.4 37207.3 37247.4 26786.0 27502.0 27694.4 27951.2 28496.4 27580.6 27650.7 28578.1 28746.6 29036.0 31144.8 31254.0 31356.2 31401.8 31484.7 27535.0 27812.3 27934.3 28298.4 29348.1 22450.3 23041.7 23161.2 23378.9 23530.5 09:15:24 INFO - PID 12738 | 09:15:24 INFO - PID 12738 | [#2] jquery.html Cycles:180 Average:24887.46 Median:212478.80 stddev:62095.69 (29.2%) stddev-sans-first:62242.70 09:15:24 INFO - PID 12738 | Values: 418.1 426.1 429.0 433.7 442.2 14271.9 17130.8 17649.3 17710.4 17774.2 17819.9 17973.7 18183.9 18483.6 18657.7 5122.3 5464.3 5630.8 5637.7 5641.9 5277.7 5281.4 5317.5 5327.8 5340.6 5208.3 5265.2 5276.7 5280.0 5299.0 5359.1 5376.5 5392.4 5411.2 5416.1 4842.4 4853.7 4872.6 4893.4 4893.5 21717.8 22394.2 22442.8 22476.6 22681.5 1577.3 1579.8 1583.6 1591.2 1606.6 14399.8 14513.3 14517.6 14913.2 14917.4 1986.8 2001.8 2034.0 2039.3 2078.2 90919.5 91204.0 94278.0 94568.5 97263.0 10603.3 11040.6 11061.6 11074.2 11337.5 14752.7 15465.1 15572.5 15590.0 15753.8 7877.6 8085.7 8151.8 8158.1 8163.3 7530.5 7550.9 7669.2 7814.7 7829.5 6693.9 6800.4 6936.9 6939.7 7047.0 2064.9 2070.7 2081.9 2097.0 2173.3 860.8 897.3 898.6 904.4 914.2 16639.8 16929.8 17006.9 17242.0 17808.3 899.8 903.0 905.1 905.8 911.1 9247.9 9687.0 9711.5 9718.3 9804.8 366205.0 369503.0 369629.0 370660.0 385653.0 74582.6 76738.6 77340.6 77467.0 77735.6 1027.7 1054.1 1085.1 1087.6 1090.2 14871.0 14901.7 14934.7 15039.8 15475.8 38023.4 38108.2 38513.0 39304.6 40055.8 45188.0 45592.5 46505.0 46784.5 47335.3 7733.8 7812.8 7813.5 7921.2 7956.3 12187.2 12515.4 12609.4 12833.9 13402.9 10203.0 10260.7 10397.7 10463.2 10851.8 9798.2 9878.8 10354.7 10508.5 10512.6 10081.2 10155.1 10252.2 10303.7 10601.4 7823.8 7980.4 7981.4 8011.4 8034.4 10104.1 10264.8 10331.7 10358.1 10393.6 09:15:24 INFO - PID 12738 | 09:15:24 INFO - PID 12738 | [#3] mootools.html Cycles:180 Average:6375.94 Median:3439.30 stddev:4154.52 (120.8%) stddev-sans-first:4148.41 09:15:24 INFO - PID 12738 | Values: 1262.8 1282.8 1316.1 1320.0 1320.9 10177.3 10368.4 10567.8 10577.2 10776.2 10416.5 10473.4 10554.2 10557.7 10582.6 2045.6 2090.8 2103.9 2112.2 2112.7 2077.0 2105.4 2113.7 2113.7 2114.1 1989.9 2038.5 2042.6 2043.7 2055.3 2011.9 2017.4 2023.5 2027.6 2028.4 1998.5 2065.9 2142.1 2144.1 2147.7 10212.8 10292.8 10296.4 10299.6 10307.9 5333.0 5577.7 5583.5 5596.1 5604.4 3193.7 3366.4 3404.6 3418.0 3444.5 1091.7 1099.7 1104.1 1107.7 1111.9 13831.4 14290.9 14791.4 14945.7 14946.6 4759.0 4769.5 4827.6 4972.5 4989.3 12332.6 12525.9 12541.5 12557.5 12578.7 5554.3 5646.3 5686.9 5693.3 5706.3 5024.7 5146.3 5150.1 5154.5 5178.5 4075.9 4119.2 4159.6 4162.6 4201.3 1239.8 1274.9 1274.9 1291.3 1294.1 708.2 726.8 738.0 742.9 751.4 5531.8 5597.7 5602.7 5735.4 5753.8 543.6 560.2 560.4 562.1 562.2 3420.0 3434.1 3553.2 3773.4 4034.2 13135.3 13286.7 13516.1 13546.7 13572.2 13295.2 13332.3 13436.1 13454.3 13481.7 7169.2 7509.7 7563.1 7611.8 7633.4 5740.3 6263.0 6358.8 6377.9 6500.2 11784.7 12074.9 12078.3 12167.8 12201.8 12025.5 12300.5 13048.9 13074.3 13168.3 8471.3 8632.1 8679.7 8685.6 8693.0 9441.4 9766.2 9772.5 9830.8 9873.3 8075.9 8307.8 8330.1 8361.2 8656.4 8070.3 8115.7 8174.3 8177.6 8300.3 6607.8 6738.2 6794.7 6803.9 6813.0 5237.6 5413.9 5415.5 5457.7 5476.4 5422.3 5441.7 5447.9 5514.2 5606.2 09:15:24 INFO - PID 12738 | 09:15:24 INFO - PID 12738 | [#4] prototype.html Cycles:180 Average:4803.71 Median:5337.97 stddev:1387.95 (26.0%) stddev-sans-first:1351.46 09:15:24 INFO - PID 12738 | Values: 375.5 381.4 382.7 388.8 396.6 5495.8 5531.9 5569.6 5573.7 5580.4 5272.8 5403.2 5423.1 5424.6 5451.5 4227.6 4228.1 4235.4 4241.4 4251.9 4224.2 4229.5 4233.8 4236.8 4237.2 3935.3 4048.3 4200.7 4206.8 4207.7 4078.0 4080.0 4082.6 4090.3 4105.7 3535.2 3537.5 3538.5 3555.3 3555.5 5152.0 5312.3 5329.0 5333.2 5342.7 4746.9 4793.4 4795.4 4796.4 4801.4 5723.5 5731.3 5733.8 5767.9 5782.2 3906.5 3964.4 3965.8 3987.4 3991.1 5967.5 6020.4 6117.2 6182.8 6216.2 4509.9 4551.1 4556.8 4557.5 4563.4 4559.6 4571.4 4593.7 4621.2 4627.9 5009.0 5080.0 5095.1 5105.5 5119.8 5882.2 5885.1 5888.5 5891.2 5905.1 1575.7 1576.6 1579.2 1583.3 1587.0 1130.7 1150.2 1159.4 1164.5 1166.7 4986.3 4988.5 4989.8 4997.1 5027.4 5998.1 6011.4 6030.5 6043.6 6044.7 4784.9 4934.6 4986.7 4998.6 5000.9 3148.0 3179.4 3185.4 3189.9 3198.8 5417.0 5457.9 5529.9 5532.0 5574.2 6145.4 6156.9 6179.4 6195.8 6202.7 5486.4 5518.5 5526.3 5529.8 5534.5 5926.4 5952.9 5982.0 5982.6 6036.1 5949.7 5956.6 5964.1 5970.0 5971.3 5256.2 5381.5 5399.5 5454.6 5523.1 4113.3 4121.6 4136.2 4148.7 4165.9 5874.6 5964.7 6008.2 6024.8 6065.1 5748.4 5773.4 5811.3 5817.6 5822.4 5763.7 5763.8 5772.7 5803.0 5844.8 5653.6 5728.9 5729.2 5733.1 5745.3 5873.3 5881.7 5881.7 5882.5 5884.6 5572.8 5652.5 5655.5 5664.9 5704.9 09:15:24 INFO - PID 12738 | 09:15:24 INFO - PID 12738 | [#5] yui.html Cycles:180 Average:16898.83 Median:3111.64 stddev:21162.38 (680.1%) stddev-sans-first:21187.01 09:15:24 INFO - PID 12738 | Values: 752.1 770.0 776.4 780.1 794.3 13334.3 13862.2 14272.3 16292.9 16730.4 16894.7 17084.5 17133.6 17167.3 17197.3 877.7 889.6 898.5 899.5 908.6 888.5 892.9 893.0 893.7 894.2 931.2 934.7 937.5 939.8 941.7 922.4 929.5 929.6 932.4 933.0 686.8 690.8 691.6 692.1 693.2 14730.4 15148.7 15203.2 15251.9 15310.0 15583.3 15797.2 15963.5 16038.9 16054.4 12548.9 12736.1 12774.3 12802.6 12918.4 3056.6 3071.2 3083.2 3085.0 3085.2 84565.6 84816.0 84959.0 87094.6 87732.0 12722.9 12784.4 12815.2 12857.0 12899.2 23672.8 24062.6 24146.0 24191.9 24280.4 6296.8 6401.4 6627.0 6689.1 6718.4 3072.5 3138.1 3153.3 3163.0 3167.9 3583.4 3663.5 3665.6 3671.5 3674.0 809.7 810.0 815.5 825.6 825.8 595.7 606.2 610.6 614.5 634.4 10154.9 10450.7 10463.8 10748.3 11495.0 615.9 619.3 624.5 634.4 644.3 4273.2 4527.7 5001.8 5010.8 5020.5 71361.3 71985.6 73076.6 73152.3 73474.6 64806.4 65107.7 65966.7 66496.3 67138.7 58572.4 59635.4 61255.0 61320.7 62310.4 10150.4 11297.0 11474.4 11608.0 11682.2 27179.6 27336.6 27459.3 27515.9 28257.2 34998.8 35557.4 35617.1 36028.0 36485.6 14813.6 14958.4 15054.2 15163.6 15325.5 14388.1 14757.6 14758.4 15047.9 15047.9 15121.2 15433.8 15526.8 15571.0 15705.2 12904.0 12905.0 13054.8 13090.1 13372.1 14634.3 14663.0 15106.5 15351.2 15519.5 10943.5 11079.9 11305.3 11311.5 11570.6 11375.5 12306.8 12671.4 12993.1 13124.3 09:15:24 INFO - PID 12738 | -------- Summary: end -------- 09:15:24 INFO - PID 12738 | 09:15:25 INFO - TEST-INFO | 12738: exit 0 09:15:25 INFO - TEST-OK | dromaeo_css | took 1146736ms 09:15:25 INFO - TEST-START | kraken 09:15:25 INFO - operating with platform_type : linux_ 09:15:25 INFO - Initialising browser for kraken test... 09:15:25 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:45129/getInfo.html -profile /tmp/tmpiATHHb/profile 09:15:25 INFO - TEST-INFO | started process 13157 (/builds/slave/test/build/application/firefox/firefox http://localhost:45129/getInfo.html) 09:16:00 INFO - TEST-INFO | 13157: killed by SIGTERM 09:16:00 INFO - Browser initialized. 09:16:00 INFO - Running cycle 1/1 for kraken test... 09:16:00 INFO - TEST-INFO | started process 13354 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpiATHHb/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:16:12 INFO - PID 13354 | RSS: Main: 183066624 09:16:12 INFO - PID 13354 | 09:16:14 INFO - PID 13354 | Cycle 1(1): loaded http://localhost:45129/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:45129/tests/kraken/driver.html?testName=audio-beat-detection) 09:16:15 INFO - PID 13354 | RSS: Main: 186490880 09:16:15 INFO - PID 13354 | 09:16:18 INFO - PID 13354 | Cycle 1(1): loaded http://localhost:45129/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:45129/tests/kraken/driver.html?testName=audio-dft) 09:16:19 INFO - PID 13354 | RSS: Main: 185552896 09:16:19 INFO - PID 13354 | 09:16:22 INFO - PID 13354 | Cycle 1(1): loaded http://localhost:45129/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:45129/tests/kraken/driver.html?testName=audio-fft) 09:16:22 INFO - PID 13354 | RSS: Main: 181829632 09:16:22 INFO - PID 13354 | 09:16:24 INFO - PID 13354 | Cycle 1(1): loaded http://localhost:45129/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:45129/tests/kraken/driver.html?testName=audio-oscillator) 09:16:25 INFO - PID 13354 | RSS: Main: 182169600 09:16:25 INFO - PID 13354 | 09:16:27 INFO - PID 13354 | Cycle 1(1): loaded http://localhost:45129/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:45129/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:16:28 INFO - PID 13354 | RSS: Main: 182493184 09:16:28 INFO - PID 13354 | 09:16:31 INFO - PID 13354 | Cycle 1(1): loaded http://localhost:45129/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:45129/tests/kraken/driver.html?testName=imaging-darkroom) 09:16:32 INFO - PID 13354 | RSS: Main: 183623680 09:16:32 INFO - PID 13354 | 09:16:35 INFO - PID 13354 | Cycle 1(1): loaded http://localhost:45129/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:45129/tests/kraken/driver.html?testName=imaging-desaturate) 09:16:36 INFO - PID 13354 | RSS: Main: 182444032 09:16:36 INFO - PID 13354 | 09:16:39 INFO - PID 13354 | Cycle 1(1): loaded http://localhost:45129/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:45129/tests/kraken/driver.html?testName=json-parse-financial) 09:16:39 INFO - PID 13354 | RSS: Main: 183185408 09:16:39 INFO - PID 13354 | 09:16:41 INFO - PID 13354 | Cycle 1(1): loaded http://localhost:45129/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:45129/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:16:42 INFO - PID 13354 | RSS: Main: 183226368 09:16:42 INFO - PID 13354 | 09:16:43 INFO - PID 13354 | Cycle 1(1): loaded http://localhost:45129/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:45129/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:16:44 INFO - PID 13354 | RSS: Main: 183107584 09:16:44 INFO - PID 13354 | 09:16:46 INFO - PID 13354 | Cycle 1(1): loaded http://localhost:45129/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:45129/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:16:47 INFO - PID 13354 | RSS: Main: 182882304 09:16:47 INFO - PID 13354 | 09:16:50 INFO - PID 13354 | Cycle 1(1): loaded http://localhost:45129/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:45129/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:16:50 INFO - PID 13354 | RSS: Main: 183283712 09:16:50 INFO - PID 13354 | 09:16:53 INFO - PID 13354 | Cycle 1(1): loaded http://localhost:45129/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:45129/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:16:54 INFO - PID 13354 | RSS: Main: 183250944 09:16:54 INFO - PID 13354 | 09:16:56 INFO - PID 13354 | Cycle 1(1): loaded http://localhost:45129/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:45129/tests/kraken/driver.html?testName=ai-astar) 09:16:56 INFO - PID 13354 | RSS: Main: 184737792 09:16:56 INFO - PID 13354 | 09:16:56 INFO - PID 13354 | __start_tp_report 09:16:56 INFO - PID 13354 | _x_x_mozilla_page_load 09:16:56 INFO - PID 13354 | _x_x_mozilla_page_load_details 09:16:56 INFO - PID 13354 | |i|pagename|runs| 09:16:56 INFO - PID 13354 | |0;ai-astar;102;110;110;111;110;111;111;111;109;111 09:16:56 INFO - PID 13354 | |1;audio-beat-detection;152;123;125;171;128;124;130;129;145;126 09:16:56 INFO - PID 13354 | |2;audio-dft;163;165;164;167;168;168;167;163;163;165 09:16:56 INFO - PID 13354 | |3;audio-fft;74;74;74;113;78;74;75;74;108;74 09:16:56 INFO - PID 13354 | |4;audio-oscillator;84;82;103;84;83;82;100;83;83;106 09:16:56 INFO - PID 13354 | |5;imaging-gaussian-blur;115;115;113;114;115;126;113;114;114;116 09:16:56 INFO - PID 13354 | |6;imaging-darkroom;153;150;151;150;152;150;150;149;154;150 09:16:56 INFO - PID 13354 | |7;imaging-desaturate;96;96;95;94;95;95;94;94;94;94 09:16:56 INFO - PID 13354 | |8;json-parse-financial;55;55;57;55;55;57;59;56;55;55 09:16:56 INFO - PID 13354 | |9;json-stringify-tinderbox;56;56;56;56;59;57;56;56;56;56 09:16:56 INFO - PID 13354 | |10;stanford-crypto-aes;88;89;89;87;88;90;88;88;115;89 09:16:56 INFO - PID 13354 | |11;stanford-crypto-ccm;142;140;134;143;138;134;135;144;136;132 09:16:56 INFO - PID 13354 | |12;stanford-crypto-pbkdf2;192;196;194;194;192;195;186;190;193;206 09:16:56 INFO - PID 13354 | |13;stanford-crypto-sha256-iterative;74;74;76;75;76;72;72;75;72;73 09:16:56 INFO - PID 13354 | __end_tp_report 09:16:56 INFO - PID 13354 | __start_cc_report 09:16:56 INFO - PID 13354 | _x_x_mozilla_cycle_collect,1006 09:16:56 INFO - PID 13354 | __end_cc_report 09:16:56 INFO - PID 13354 | __startTimestamp1495901816621__endTimestamp 09:16:56 INFO - PID 13354 | 09:16:56 INFO - PID 13354 | ------- Summary: start ------- 09:16:56 INFO - PID 13354 | Number of tests: 14 09:16:56 INFO - PID 13354 | 09:16:56 INFO - PID 13354 | [#0] ai-astar Cycles:10 Average:109.60 Median:111.00 stddev:2.76 (2.5%) stddev-sans-first:0.73 09:16:56 INFO - PID 13354 | Values: 102.0 110.0 110.0 111.0 110.0 111.0 111.0 111.0 109.0 111.0 09:16:56 INFO - PID 13354 | 09:16:56 INFO - PID 13354 | [#1] audio-beat-detection Cycles:10 Average:135.30 Median:129.50 stddev:15.78 (12.2%) stddev-sans-first:15.53 09:16:56 INFO - PID 13354 | Values: 152.0 123.0 125.0 171.0 128.0 124.0 130.0 129.0 145.0 126.0 09:16:56 INFO - PID 13354 | 09:16:56 INFO - PID 13354 | [#2] audio-dft Cycles:10 Average:165.30 Median:166.00 stddev:2.06 (1.2%) stddev-sans-first:2.01 09:16:56 INFO - PID 13354 | Values: 163.0 165.0 164.0 167.0 168.0 168.0 167.0 163.0 163.0 165.0 09:16:56 INFO - PID 13354 | 09:16:56 INFO - PID 13354 | [#3] audio-fft Cycles:10 Average:81.80 Median:74.00 stddev:15.22 (20.6%) stddev-sans-first:15.88 09:16:56 INFO - PID 13354 | Values: 74.0 74.0 74.0 113.0 78.0 74.0 75.0 74.0 108.0 74.0 09:16:56 INFO - PID 13354 | 09:16:56 INFO - PID 13354 | [#4] audio-oscillator Cycles:10 Average:89.00 Median:83.00 stddev:9.79 (11.8%) stddev-sans-first:10.21 09:16:56 INFO - PID 13354 | Values: 84.0 82.0 103.0 84.0 83.0 82.0 100.0 83.0 83.0 106.0 09:16:56 INFO - PID 13354 | 09:16:56 INFO - PID 13354 | [#5] imaging-gaussian-blur Cycles:10 Average:115.50 Median:115.00 stddev:3.81 (3.3%) stddev-sans-first:4.03 09:16:56 INFO - PID 13354 | Values: 115.0 115.0 113.0 114.0 115.0 126.0 113.0 114.0 114.0 116.0 09:16:56 INFO - PID 13354 | 09:16:56 INFO - PID 13354 | [#6] imaging-darkroom Cycles:10 Average:150.90 Median:150.50 stddev:1.60 (1.1%) stddev-sans-first:1.50 09:16:56 INFO - PID 13354 | Values: 153.0 150.0 151.0 150.0 152.0 150.0 150.0 149.0 154.0 150.0 09:16:56 INFO - PID 13354 | 09:16:56 INFO - PID 13354 | [#7] imaging-desaturate Cycles:10 Average:94.70 Median:95.00 stddev:0.82 (0.9%) stddev-sans-first:0.73 09:16:56 INFO - PID 13354 | Values: 96.0 96.0 95.0 94.0 95.0 95.0 94.0 94.0 94.0 94.0 09:16:56 INFO - PID 13354 | 09:16:56 INFO - PID 13354 | [#8] json-parse-financial Cycles:10 Average:55.90 Median:55.50 stddev:1.37 (2.5%) stddev-sans-first:1.41 09:16:56 INFO - PID 13354 | Values: 55.0 55.0 57.0 55.0 55.0 57.0 59.0 56.0 55.0 55.0 09:16:56 INFO - PID 13354 | 09:16:56 INFO - PID 13354 | [#9] json-stringify-tinderbox Cycles:10 Average:56.40 Median:56.00 stddev:0.97 (1.7%) stddev-sans-first:1.01 09:16:56 INFO - PID 13354 | Values: 56.0 56.0 56.0 56.0 59.0 57.0 56.0 56.0 56.0 56.0 09:16:56 INFO - PID 13354 | 09:16:56 INFO - PID 13354 | [#10] stanford-crypto-aes Cycles:10 Average:91.10 Median:88.50 stddev:8.44 (9.5%) stddev-sans-first:8.88 09:16:56 INFO - PID 13354 | Values: 88.0 89.0 89.0 87.0 88.0 90.0 88.0 88.0 115.0 89.0 09:16:56 INFO - PID 13354 | 09:16:56 INFO - PID 13354 | [#11] stanford-crypto-ccm Cycles:10 Average:137.80 Median:139.00 stddev:4.24 (3.0%) stddev-sans-first:4.21 09:16:56 INFO - PID 13354 | Values: 142.0 140.0 134.0 143.0 138.0 134.0 135.0 144.0 136.0 132.0 09:16:56 INFO - PID 13354 | 09:16:56 INFO - PID 13354 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:193.80 Median:194.00 stddev:5.14 (2.6%) stddev-sans-first:5.41 09:16:56 INFO - PID 13354 | Values: 192.0 196.0 194.0 194.0 192.0 195.0 186.0 190.0 193.0 206.0 09:16:56 INFO - PID 13354 | 09:16:56 INFO - PID 13354 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:73.90 Median:74.50 stddev:1.60 (2.1%) stddev-sans-first:1.69 09:16:56 INFO - PID 13354 | Values: 74.0 74.0 76.0 75.0 76.0 72.0 72.0 75.0 72.0 73.0 09:16:56 INFO - PID 13354 | -------- Summary: end -------- 09:16:56 INFO - PID 13354 | 09:16:57 INFO - TEST-INFO | 13354: exit 0 09:16:57 INFO - TEST-OK | kraken | took 92599ms 09:16:57 INFO - SUITE-END | took 1239s 09:16:58 INFO - Completed test suite (00:20:39) 09:16:58 INFO - javascript benchmark 09:16:58 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6820.648060811053, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2732.1530325599065, 2735.275152084697, 2757.4622948525034, 2776.9861150694232, 2779.0273404308496, 5236.240745091969, 5346.438623944483, 5350.010248104103, 5380.287601554929, 5386.649867758593, 5298.7350632468315, 5306.0, 5336.59975501837, 5384.326959130109, 5395.406505284415, 4474.373587697725, 4724.994428072619, 4776.785044672989, 4782.521747825207, 4799.592034677056, 4828.420589529243, 4866.6106711463, 4872.196087645534, 4882.609391248691, 4898.044881248158, 4721.032188401369, 4727.834525791615, 4772.117158325686, 4818.68678535894, 4839.177339852234, 4766.784469960138, 4779.044191161747, 4786.0, 4806.951930480685, 4829.10661527615, 4728.881777955578, 4748.311494833264, 4759.690620109682, 4771.737554434505, 4787.114383839001, 5221.582273418117, 5285.973570132163, 5358.276632654581, 5362.973185134088, 5401.405845357047, 5688.715564221772, 5741.712914354265, 5789.507891829199, 5792.102224155263, 5792.855178620568, 5741.799037033684, 5764.769409223626, 5774.16274640179, 5778.335491418498, 5789.363170051291, 5375.301210842644, 5376.086065368897, 5381.623286369995, 5384.461553844584, 5386.326709161355, 5836.095405212199, 5839.795607153729, 5905.025670764276, 5908.4091590841435, 5920.289565252111, 5630.85922851932, 5656.4060773619, 5656.717164141776, 5696.971515142398, 5704.771809127588, 5630.746616402272, 5737.139429085671, 5740.885182296331, 5753.568482363839, 5756.510696590837, 5611.046122159161, 5658.74535645897, 5712.571557133148, 5715.371309155989, 5715.799947001919, 5661.49046585801, 5691.373948865621, 5730.0, 5734.111212762028, 5740.741666625012, 4811.735354555533, 4811.759412029384, 4817.301491283814, 4833.9033219335415, 4854.611631069506, 4092.3247664135083, 4115.691323150776, 4116.897077573085, 4122.505299364036, 4147.709660323749, 4731.313959475857, 4775.331453596499, 4800.927986080212, 4826.0, 4853.708777473363, 5746.569007324384, 5783.479486846204, 5787.045137552341, 5793.565482588822, 5802.47777700009, 4809.062232864558, 4811.0, 4811.0, 4813.614910807127, 4849.345338379274, 5074.847754567369, 5078.339815823919, 5081.7967281309075, 5092.28707980883, 5097.643164978416, 5185.196294574347, 5244.921326180034, 5310.256564081109, 5375.973120134374, 5378.811741589026, 5688.63023903445, 5772.393898640582, 5780.554861284679, 5834.737436815269, 5880.26496687914, 5171.715555644476, 5271.78912843482, 5286.709230992333, 5341.332333458317, 5350.357957045179, 5648.4633959773755, 5655.547556195576, 5655.7454914528125, 5660.0, 5705.543556515386, 5690.118031705092, 5771.192033115283, 5774.191613174243, 5780.335261444988, 5782.0, 5540.722963851872, 5575.024370735024, 5628.662280263197, 5640.830775076754, 5659.830205093854, 5540.196671482693, 5548.334199896039, 5549.056660367828, 5550.222968784293, 5568.55451563882, 5428.07722687152, 5449.64577302474, 5465.988792073479, 5477.698726570077, 5513.255710479194, 5513.4486551346145, 5574.693391863487, 5606.299212598426, 5608.186812912023, 5680.892226015887, 5538.252335934597, 5545.140503222007, 5558.638688485235, 5562.833115006556, 5567.47109024642], "value": 5205.214091617289, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [665.8235567574594, 737.7307282841763, 752.2665401233796, 1200.393801130429, 1246.7132559511317, 33238.83380583097, 34246.14384640385, 34418.0, 34449.483257751126, 34470.0, 34144.65855341446, 34158.65841341586, 34477.31045379091, 34524.30951380971, 34524.48213276797, 6564.737410503586, 6672.466202703797, 6696.430803381694, 6795.1166348374645, 6802.727890884384, 6759.695813688371, 6848.589084654936, 6853.314668533157, 6854.143232095988, 6864.107666003412, 6797.11637487126, 6875.0, 6883.483738719591, 6890.827729306782, 6893.241743408221, 6774.119364482635, 6793.45652347811, 6814.62519561424, 6836.965815170942, 6844.315568443166, 6762.323767623198, 6810.523263371566, 6822.079019332426, 6834.248232694449, 6860.485463590251, 32494.512582311283, 32534.349313013845, 32682.836585817156, 32743.017709468517, 32803.0, 3083.7378822800088, 3122.531620256957, 3128.9843550782102, 3130.7182353588287, 3137.984310078458, 25015.87492062528, 25095.62356564653, 25097.749022509906, 25127.24618261455, 25187.37031574207, 3076.86154123065, 3102.255458689921, 3110.424571454266, 3139.277966067817, 3149.7795154339206, 122765.38617306946, 123537.38231308876, 134272.32863835717, 149202.0, 150653.0, 39732.0, 39826.60173398287, 40189.59810401917, 40264.59735402667, 40332.0, 42256.57743422588, 42294.57705422906, 42396.364054539205, 44944.0, 45756.77121614371, 13485.932570337085, 13498.527551535846, 13617.842483388824, 13620.455181792617, 13629.25039122838, 10772.461376931122, 10780.29928054674, 10785.62250321235, 10824.945875270574, 10851.131909447226, 12968.286744229157, 12971.805422918475, 12996.870031299755, 13070.281134537692, 13179.275139867208, 5372.274742909735, 5431.4840090191365, 5443.183522471661, 5465.125579907275, 5503.11950087984, 842.5829214538843, 877.5656050255037, 914.8764916736288, 917.2570218123342, 939.699296225215, 21566.892165539386, 21605.0, 21748.782512174992, 21754.89122554377, 22006.0, 984.5274268351232, 996.4469719305855, 1022.1669339488293, 1022.539857064324, 1025.092792878308, 11257.662270131908, 11455.255408398427, 11627.302361858316, 11638.0, 11646.650600481998, 180163.0, 180482.0, 181390.0, 181520.0, 181578.09210954126, 42433.0, 42568.78715606402, 42589.57410425918, 42694.573054269684, 42748.78625606914, 1175.1850196195198, 1221.096388672394, 1228.2139430764319, 1230.6123571075082, 1260.6218134559595, 19404.0, 19853.205871765545, 20343.898280508503, 21336.78663213348, 21559.676604850625, 29347.0, 29423.558646620746, 29670.40659186761, 29776.702232977394, 29794.553081703358, 151883.21751737327, 153126.0, 153254.0, 153596.2320188392, 153777.0, 29806.10581682553, 29806.70193298039, 29998.0, 30922.845385773828, 31113.222169445944, 36634.0, 36972.44541331936, 36975.44536831896, 37207.25585488329, 37247.441288380156, 26786.0, 27502.0, 27694.44611107807, 27951.161465156078, 28496.43007139887, 27580.620968951873, 27650.723492764813, 28578.142655720363, 28746.568801468413, 29036.0, 31144.844275778476, 31254.0, 31356.216094597818, 31401.8429907849, 31484.68515314909, 27535.0, 27812.304692382044, 27934.3016424591, 28298.434031318848, 29348.11955641334, 22450.32649020532, 23041.65437518472, 23161.189358372376, 23378.883105584362, 23530.529389411775], "value": 14723.550911415956, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [418.10734082733353, 426.1413252296622, 428.9815748114249, 433.72241765270223, 442.1885839484544, 14271.92864035681, 17130.828691713094, 17649.29402823887, 17710.380136695236, 17774.200160992754, 17819.91090044548, 17973.7303940441, 18183.909080454578, 18483.630327393443, 18657.720134197996, 5122.334096567441, 5464.3442786865635, 5630.802921897734, 5637.7181140942785, 5641.915371269434, 5277.656952298088, 5281.445448227919, 5317.494837990404, 5327.840164795043, 5340.599455040868, 5208.270842082112, 5265.210218467222, 5276.657017293883, 5279.973600131994, 5298.993191293661, 5359.1425371940495, 5376.542993845528, 5392.352917649888, 5411.18832175173, 5416.133418653017, 4842.370491836039, 4853.684510506841, 4872.610191184696, 4893.363862697826, 4893.535114164149, 21717.782822171735, 22394.192987192215, 22442.77557224423, 22476.550468990692, 22681.54636907269, 1577.3138684672203, 1579.778830963666, 1583.627847455847, 1591.2282542966768, 1606.6304749907588, 14399.78400323996, 14513.27433628325, 14517.637059073502, 14913.227767114528, 14917.403303867832, 1986.8410527157794, 2001.8198362147477, 2034.0338339288867, 2039.3066357438395, 2078.2310545098258, 90919.54540227323, 91204.0, 94278.0, 94568.52715736446, 97263.0, 10603.310784798963, 11040.613578524873, 11061.612843550438, 11074.223617965174, 11337.546498139982, 14752.704945901021, 15465.072095674295, 15572.532824015298, 15590.0, 15753.842461575237, 7877.606119693993, 8085.676572937135, 8151.755447336589, 8158.143394943564, 8163.346932245406, 7530.472866899265, 7550.924490755132, 7669.156392796899, 7814.726484573012, 7829.45193836426, 6693.866122677519, 6800.4219641330055, 6936.93063069373, 6939.653017349112, 7046.964765176142, 2064.9277275295294, 2070.7411573553304, 2081.875087494755, 2096.989515052415, 2173.3371321746704, 860.8364410761935, 897.3090720145451, 898.5641963647626, 904.4076130134772, 914.1681070226063, 16639.83360166407, 16929.83070169307, 17006.91496542534, 17242.0, 17808.287668493114, 899.7705585075895, 902.9954850225707, 905.1310741688053, 905.8369493491103, 911.1025639744846, 9247.907520924839, 9687.0, 9711.514424278757, 9718.271129665303, 9804.754881128029, 366205.0, 369503.0, 369629.0, 370660.0, 385653.0, 74582.62708686531, 76738.6163069181, 77340.61329693315, 77467.0, 77735.61132194416, 1027.6762819711766, 1054.1198099586777, 1085.0993675249524, 1087.6302057300556, 1090.225939582905, 14871.0, 14901.701965960838, 14934.701305974037, 15039.774403383739, 15475.767863481831, 38023.429648555844, 38108.23783524369, 38513.0, 39304.60695393124, 40055.799721002375, 45188.0, 45592.54407456016, 46505.0, 46784.53215467938, 47335.28997065116, 7733.806654833674, 7812.804679882821, 7813.492123011986, 7921.207879212033, 7956.323712484272, 12187.207831490925, 12515.374231288217, 12609.423822022247, 12833.871661283267, 13402.865971340161, 10203.0, 10260.692179234635, 10397.688069357931, 10463.162946964072, 10851.752048514521, 9798.216142708709, 9878.802423951336, 10354.689359319233, 10508.474576271003, 10512.57949682004, 10081.243906706879, 10155.136813370946, 10252.23108266868, 10303.690889273334, 10601.41692206936, 7823.804404889924, 7980.361571074184, 7981.40139489529, 8011.399145064027, 8034.397420193626, 10104.141148002502, 10264.794704106025, 10331.690049298533, 10358.119559837498, 10393.636222732168], "value": 8744.74733068336, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1262.7979523276274, 1282.794752839546, 1316.1050485669746, 1319.9868001319983, 1320.947162113515, 10177.287589868713, 10368.429736364496, 10567.841482377771, 10577.20670949679, 10776.245662803607, 10416.479176041206, 10473.423961682105, 10554.208434367434, 10557.683269501907, 10582.629607963703, 2045.6420126477844, 2090.7700152983234, 2103.8948052597384, 2112.1656945506516, 2112.6830975353664, 2076.989835694212, 2105.378913220596, 2113.74635043795, 2113.74635043795, 2114.1332053857923, 1989.910454029565, 2038.531137838298, 2042.6119037382923, 2043.7138800567932, 2055.2806517718755, 2011.8792872427628, 2017.3645301729907, 2023.4637820977525, 2027.614753196888, 2028.3914825552422, 1998.5103649605794, 2065.8760474371584, 2142.121730090671, 2144.0566150893715, 2147.667111597689, 10212.846807297896, 10292.845607315896, 10296.382217066925, 10299.639512617023, 10307.896921030844, 5332.973335133338, 5577.749001294951, 5583.525400340935, 5596.076647353222, 5604.3835178130375, 3193.696598823108, 3366.394049071166, 3404.5914490261325, 3418.0429479745712, 3444.4661077532774, 1091.6888686724246, 1099.6591056772347, 1104.1111904916538, 1107.6566264458045, 1111.9054880335182, 13831.377588008563, 14290.92854535731, 14791.40834366624, 14945.70108597822, 14946.551603451913, 4759.0, 4769.451513075971, 4827.637927155477, 4972.477889821589, 4989.326440930428, 12332.630021099381, 12525.935295499985, 12541.498340066477, 12557.497700092077, 12578.68553286157, 5554.250176226238, 5646.265985421951, 5686.886262274731, 5693.345265294462, 5706.343770466449, 5024.698518088926, 5146.30524879144, 5150.072986862326, 5154.5103215194495, 5178.456262092502, 4075.9388609170887, 4119.237940980928, 4159.606531811816, 4162.633587975724, 4201.264778663722, 1239.770642431135, 1274.8661390554043, 1274.878886505799, 1291.251074376878, 1294.100600082952, 708.1820497325597, 726.8328284494596, 737.9741709040158, 742.8737114690516, 751.3988808952926, 5531.806386776443, 5597.720113994284, 5602.6918519481005, 5735.369109397963, 5753.798617048383, 543.6140340358311, 560.2101037537053, 560.4479587606205, 562.1090571444306, 562.2325525657449, 3420.0, 3434.1414646338417, 3553.1958341841614, 3773.3585290500682, 4034.2133284009337, 13135.34323283832, 13286.667833304246, 13516.12145210558, 13546.729065418833, 13572.185668859702, 13295.20228786276, 13332.333383330795, 13436.126651767603, 13454.26001569923, 13481.66295842592, 7169.24722904098, 7509.699612015458, 7563.092428908456, 7611.809704757426, 7633.351165151024, 5740.253767010262, 6263.0, 6358.841028974312, 6377.936220637735, 6500.219973603198, 11784.70538236551, 12074.879251207376, 12078.27530348182, 12167.817482737943, 12201.755964880831, 12025.45885435175, 12300.507979680713, 13048.869511304765, 13074.346282686018, 13168.275744834125, 8471.279941205066, 8632.050474447931, 8679.696210632597, 8685.609147588248, 8693.0, 9441.386309889835, 9766.169875560658, 9772.511374431393, 9830.75423114428, 9873.308868379145, 8075.9192408077515, 8307.792305192419, 8330.125336839545, 8361.163883611833, 8656.350773692124, 8070.314023307849, 8115.715949941724, 8174.305184059422, 8177.6320065596, 8300.294474969454, 6607.834804129935, 6738.248055505505, 6794.728210871707, 6803.863922721419, 6813.0, 5237.633365664519, 5413.918791218213, 5415.512603865671, 5457.727113644222, 5476.397596264487, 5422.295101636762, 5441.700706461024, 5447.9376521577915, 5514.2004409359615, 5606.24315717373], "value": 4729.2198564318305, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [375.48933450507303, 381.35931634853455, 382.7492992090182, 388.7861676078156, 396.59151074393367, 5495.752691128904, 5531.889362212753, 5569.582281328906, 5573.665580065189, 5580.358258800239, 5272.8154514592, 5403.189521571766, 5423.050966080939, 5424.620276580641, 5451.48210919963, 4227.619514243717, 4228.090960443512, 4235.3646952957, 4241.363795430695, 4251.936220956688, 4224.197402493532, 4229.471316085489, 4233.788310584474, 4236.766977816219, 4237.152569486099, 3935.330993731073, 4048.2915489789316, 4200.663946884242, 4206.810693518783, 4207.705460617758, 4077.9592204077876, 4079.9808141974872, 4082.5917408259083, 4090.2637525245445, 4105.712600117993, 3535.2045789697368, 3537.451694987281, 3538.5046093546925, 3555.253396786678, 3555.5022296878456, 5152.0, 5312.2828418163435, 5329.0, 5333.2000199969925, 5342.732863356817, 4746.857594272177, 4793.352897358882, 4795.448523419816, 4796.400449943757, 4801.423829140491, 5723.5421166307015, 5731.283589551306, 5733.795902860405, 5767.942320576783, 5782.219400380979, 3906.511686039245, 3964.385520244367, 3965.801709914522, 3987.3819557968563, 3991.102002049545, 5967.522598192134, 6020.4280593343565, 6117.204763380777, 6182.84542886427, 6216.160818289518, 4509.88725281864, 4551.112533056088, 4556.817727290938, 4557.453105627346, 4563.406757121553, 4559.566841150086, 4571.38286331341, 4593.678442508993, 4621.214393553104, 4627.8611641650805, 5009.0482808266315, 5079.974600126976, 5095.0828850806465, 5105.489451054865, 5119.771254898797, 5882.205902203234, 5885.087811389241, 5888.4700376966275, 5891.204687367236, 5905.143754155623, 1575.7006168827886, 1576.5743249322618, 1579.2340714753336, 1583.2716950202805, 1587.0, 1130.6834086455806, 1150.1776229995594, 1159.3913195572393, 1164.5167255589006, 1166.731651720109, 4986.301917731521, 4988.478514053249, 4989.750512474362, 4997.100521906019, 5027.396712394536, 5998.100284957204, 6011.368806275278, 6030.547708921848, 6043.607165534227, 6044.697765111727, 4784.928226076611, 4934.644441779625, 4986.675866068694, 4998.550130488201, 5000.874978125576, 3147.9685203148133, 3179.4118088153764, 3185.4106990206424, 3189.856456459465, 3198.8400579971376, 5417.0, 5457.945420545744, 5529.944700552943, 5531.972340138354, 5574.16387541872, 6145.354737752561, 6156.907646385308, 6179.373766149369, 6195.752169913243, 6202.658853763086, 5486.393962867606, 5518.475744804237, 5526.281583394213, 5529.751161197675, 5534.501894829485, 5926.436988486087, 5952.8809423812145, 5981.970090149522, 5982.551308651781, 6036.0644100164545, 5949.732262048132, 5956.642601443928, 5964.135200395832, 5970.0, 5971.28344598651, 5256.159014557652, 5381.515663590296, 5399.487048730364, 5454.618176727591, 5523.143912693539, 4113.272425581204, 4121.587841215975, 4136.234796562646, 4148.688848336447, 4165.91668166641, 5874.647521148745, 5964.731587078505, 6008.218931538872, 6024.795040991731, 6065.059915713072, 5748.367679555329, 5773.364929857628, 5811.302643682785, 5817.621854579439, 5822.379929032038, 5763.6541807491685, 5763.827085187451, 5772.682502462405, 5802.970985145047, 5844.824655260349, 5653.614864358258, 5728.856778580569, 5729.2265544151005, 5733.082706766897, 5745.253117094751, 5873.327635925558, 5881.676507791942, 5881.676507792113, 5882.5293976482635, 5884.58656007994, 5572.77708891656, 5652.5477961762135, 5655.519280861173, 5664.943350566607, 5704.885902281848], "value": 4389.612352820627, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [752.0749478141889, 769.957652329122, 776.3827756933238, 780.0989856715493, 794.3287921706158, 13334.33328333583, 13862.168269903801, 14272.286385680727, 16292.918535407307, 16730.41443549476, 16894.662106757856, 17084.487465376027, 17133.571660708487, 17167.313307467688, 17197.312107515685, 877.7410663854179, 889.577450710912, 898.4743924803997, 899.4962820820328, 908.5956749246587, 888.537960260664, 892.8660700894853, 893.0444424465824, 893.718478679214, 894.239896088323, 931.1898648176096, 934.7336009237368, 937.5312343828086, 939.7603611079165, 941.7316064921499, 922.4004397141845, 929.5398777605129, 929.586334081334, 932.3753085432776, 932.9906700932971, 686.8454597715524, 690.8203866994568, 691.5850489706136, 692.0933577014077, 693.1543516909362, 14730.410783568752, 15148.697026059417, 15203.163825989566, 15251.923740381228, 15310.0, 15583.298751556207, 15797.21013949298, 15963.521094367188, 16038.919805401016, 16054.43809466663, 12548.937255313756, 12736.108472406935, 12774.297413642245, 12802.615921522369, 12918.41867115982, 3056.5720799088144, 3071.1861356740483, 3083.198368424226, 3085.0436364727007, 3085.182426656938, 84565.57717211374, 84816.0, 84959.0, 87094.56452717696, 87732.0, 12722.936385318015, 12784.40194975628, 12815.231086134861, 12857.0, 12899.226046437243, 23672.763272367058, 24062.63906041411, 24146.0, 24191.879040605036, 24280.392990175387, 6296.779612713533, 6401.391867772554, 6626.966865165643, 6689.063531105649, 6718.361755633207, 3072.5083986562045, 3138.0899539133397, 3153.30627262002, 3162.984185079106, 3167.889123880653, 3583.4087375582735, 3663.4687970244167, 3665.560132784083, 3671.541057367829, 3673.9632603674154, 809.6639894443857, 810.0441479054772, 815.5269943432795, 825.5830805443213, 825.7646570727314, 595.6783336998059, 606.1877084706515, 610.5756499233079, 614.5053232148164, 634.4068296143121, 10154.949225253826, 10450.738731531621, 10463.84304235437, 10748.301360411548, 11495.0, 615.8922188616974, 619.3434958943534, 624.4567226512963, 634.3624657219465, 644.3427703742251, 4273.230818452708, 4527.683062185615, 5001.799928002912, 5010.824621138316, 5020.49795020495, 71361.2863871365, 71985.64007180036, 73076.63461682657, 73152.26847731454, 73474.63262683652, 64806.35193648003, 65107.674461627386, 65966.67016664887, 66496.33503664998, 67138.66430667815, 58572.414275856696, 59635.40364596385, 61255.0, 61320.69339653273, 62310.37689623136, 10150.441725705157, 11297.0, 11474.426278685865, 11608.0, 11682.182247242612, 27179.592306115028, 27336.589951151145, 27459.31351716223, 27515.86242068777, 28257.15228543147, 34998.82500587481, 35557.37754092055, 35617.1095722609, 36028.0, 36485.635143649284, 14813.555593332218, 14958.40166393332, 15054.247287635355, 15163.620909477351, 15325.540233793005, 14388.082217612573, 14757.557273281818, 14758.409663613334, 15047.924760376565, 15047.924760376565, 15121.243937802847, 15433.84566154324, 15526.844731552992, 15571.0, 15705.214739262763, 12904.032197585031, 12905.032122590655, 13054.804177937149, 13090.14914030585, 13372.063955523408, 14634.34145463478, 14663.0, 15106.471273505815, 15351.155686437352, 15519.5344139676, 10943.45282735844, 11079.944600276947, 11305.26515776472, 11311.490982905954, 11570.59502917394, 11375.54497820078, 12306.75386492283, 12671.366431678563, 12993.090483666052, 13124.27816470065], "value": 7236.164249046315, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1551.0, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [102.0, 110.0, 110.0, 111.0, 110.0, 111.0, 111.0, 111.0, 109.0, 111.0], "value": 109.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 123.0, 125.0, 171.0, 128.0, 124.0, 130.0, 129.0, 145.0, 126.0], "value": 135.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 165.0, 164.0, 167.0, 168.0, 168.0, 167.0, 163.0, 163.0, 165.0], "value": 165.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 74.0, 74.0, 113.0, 78.0, 74.0, 75.0, 74.0, 108.0, 74.0], "value": 81.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 82.0, 103.0, 84.0, 83.0, 82.0, 100.0, 83.0, 83.0, 106.0], "value": 89.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 115.0, 113.0, 114.0, 115.0, 126.0, 113.0, 114.0, 114.0, 116.0], "value": 115.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 150.0, 151.0, 150.0, 152.0, 150.0, 150.0, 149.0, 154.0, 150.0], "value": 150.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 96.0, 95.0, 94.0, 95.0, 95.0, 94.0, 94.0, 94.0, 94.0], "value": 94.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 55.0, 57.0, 55.0, 55.0, 57.0, 59.0, 56.0, 55.0, 55.0], "value": 55.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 56.0, 56.0, 56.0, 59.0, 57.0, 56.0, 56.0, 56.0, 56.0], "value": 56.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 89.0, 89.0, 87.0, 88.0, 90.0, 88.0, 88.0, 115.0, 89.0], "value": 91.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [142.0, 140.0, 134.0, 143.0, 138.0, 134.0, 135.0, 144.0, 136.0, 132.0], "value": 137.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [192.0, 196.0, 194.0, 194.0, 192.0, 195.0, 186.0, 190.0, 193.0, 206.0], "value": 193.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 74.0, 76.0, 75.0, 76.0, 72.0, 72.0, 75.0, 72.0, 73.0], "value": 73.9, "unit": "score"}]}]} 09:16:58 INFO - Return code: 0 09:16:58 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 09:16:58 INFO - # TBPL SUCCESS # 09:16:58 INFO - Running post-action listener: _resource_record_post_action 09:16:58 INFO - [mozharness: 2017-05-27 16:16:58.435609Z] Finished run-tests step (success) 09:16:58 INFO - Running post-run listener: _resource_record_post_run 09:16:58 INFO - Total resource usage - Wall time: 1256s; CPU: 13.0%; Read bytes: 8192; Write bytes: 407904256; Read time: 176; Write time: 228664 09:16:58 INFO - TinderboxPrint: CPU usage
12.7% 09:16:58 INFO - TinderboxPrint: I/O read bytes / time
8,192 / 176 09:16:58 INFO - TinderboxPrint: I/O write bytes / time
407,904,256 / 228,664 09:16:58 INFO - TinderboxPrint: CPU idle
8,755.4 (87.3%) 09:16:58 INFO - TinderboxPrint: CPU user
1,216.9 (12.1%) 09:16:58 INFO - TinderboxPrint: Swap in / out
0 / 0 09:16:58 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 93679616; Read time: 0; Write time: 77284 09:16:58 INFO - run-tests - Wall time: 1240s; CPU: 13.0%; Read bytes: 8192; Write bytes: 314224640; Read time: 176; Write time: 151380 09:16:59 INFO - Running post-run listener: _upload_blobber_files 09:16:59 INFO - Blob upload gear active. 09:16:59 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 09:16:59 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 09:16:59 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'] 09:16:59 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 09:16:59 INFO - (blobuploader) - INFO - Open directory for files ... 09:16:59 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 09:16:59 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:16:59 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:17:00 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 09:17:00 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:17:00 INFO - (blobuploader) - INFO - Done attempting. 09:17:00 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 09:17:00 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:17:00 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:17:06 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 09:17:06 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:17:06 INFO - (blobuploader) - INFO - Done attempting. 09:17:06 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 09:17:06 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:17:06 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:17:08 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 09:17:08 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:17:08 INFO - (blobuploader) - INFO - Done attempting. 09:17:08 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 09:17:08 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:17:08 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:17:09 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 09:17:09 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:17:09 INFO - (blobuploader) - INFO - Done attempting. 09:17:09 INFO - (blobuploader) - INFO - Iteration through files over. 09:17:09 INFO - Return code: 0 09:17:09 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 09:17:09 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 09:17:09 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/dc9453a66faee69e1a41fcf7c613f75948b860b2302e8397a5a81dda0a00eefb24ef09bd3b007a0a28202dee7b6741835252be128cb42ef43d712deba00fd645", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/e770f3a97bacd92684b139bd522fdaa9fe1a600331e29bf3f7eb8d3ab64607a8f74144f749f1745bb43877ece8e2a0061c7ca4ec06caab7e448d80cae67ac854", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/7c7acabab728592a6f7f6206a4098c4835e1400f76acdaba41a6397555f38a61d9fd041f88d500b53faced2cbeff89b192fb66d3535b5f8e6b35aae189361c7c", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/648fe869a5368fc18f5ad645d7e5d266fe1a4966f102b91c150c9dc52061007d3b96e85ce4e40ee4b28f5102068fcc8ae217a9c7f58ea5dabe5e7293d04d683e"} 09:17:09 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 09:17:09 INFO - Writing to file /builds/slave/test/properties/blobber_files 09:17:09 INFO - Contents: 09:17:09 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/dc9453a66faee69e1a41fcf7c613f75948b860b2302e8397a5a81dda0a00eefb24ef09bd3b007a0a28202dee7b6741835252be128cb42ef43d712deba00fd645", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/e770f3a97bacd92684b139bd522fdaa9fe1a600331e29bf3f7eb8d3ab64607a8f74144f749f1745bb43877ece8e2a0061c7ca4ec06caab7e448d80cae67ac854", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/7c7acabab728592a6f7f6206a4098c4835e1400f76acdaba41a6397555f38a61d9fd041f88d500b53faced2cbeff89b192fb66d3535b5f8e6b35aae189361c7c", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/648fe869a5368fc18f5ad645d7e5d266fe1a4966f102b91c150c9dc52061007d3b96e85ce4e40ee4b28f5102068fcc8ae217a9c7f58ea5dabe5e7293d04d683e"} 09:17:09 INFO - Running post-run listener: copy_logs_to_upload_dir 09:17:09 INFO - Copying logs to upload dir... 09:17:09 INFO - mkdir: /builds/slave/test/build/upload/logs 09:17:09 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1316.085390 ========= master_lag: 0.15 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 56 secs) (at 2017-05-27 09:17:07.526186) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-27 09:17:07.530035) ========= 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=88e9d754c8c9af9f7805d7f3000001bd-1495900511.454322-1004867611 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/dc9453a66faee69e1a41fcf7c613f75948b860b2302e8397a5a81dda0a00eefb24ef09bd3b007a0a28202dee7b6741835252be128cb42ef43d712deba00fd645", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/e770f3a97bacd92684b139bd522fdaa9fe1a600331e29bf3f7eb8d3ab64607a8f74144f749f1745bb43877ece8e2a0061c7ca4ec06caab7e448d80cae67ac854", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/7c7acabab728592a6f7f6206a4098c4835e1400f76acdaba41a6397555f38a61d9fd041f88d500b53faced2cbeff89b192fb66d3535b5f8e6b35aae189361c7c", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/648fe869a5368fc18f5ad645d7e5d266fe1a4966f102b91c150c9dc52061007d3b96e85ce4e40ee4b28f5102068fcc8ae217a9c7f58ea5dabe5e7293d04d683e"} build_url:https://queue.taskcluster.net/v1/task/VYCP9MoKR1-Ju82qtJdrjg/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011204 build_url: 'https://queue.taskcluster.net/v1/task/VYCP9MoKR1-Ju82qtJdrjg/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/dc9453a66faee69e1a41fcf7c613f75948b860b2302e8397a5a81dda0a00eefb24ef09bd3b007a0a28202dee7b6741835252be128cb42ef43d712deba00fd645", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/e770f3a97bacd92684b139bd522fdaa9fe1a600331e29bf3f7eb8d3ab64607a8f74144f749f1745bb43877ece8e2a0061c7ca4ec06caab7e448d80cae67ac854", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/7c7acabab728592a6f7f6206a4098c4835e1400f76acdaba41a6397555f38a61d9fd041f88d500b53faced2cbeff89b192fb66d3535b5f8e6b35aae189361c7c", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/648fe869a5368fc18f5ad645d7e5d266fe1a4966f102b91c150c9dc52061007d3b96e85ce4e40ee4b28f5102068fcc8ae217a9c7f58ea5dabe5e7293d04d683e"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-27 09:17:07.553767) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-27 09:17:07.554059) ========= 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=88e9d754c8c9af9f7805d7f3000001bd-1495900511.454322-1004867611 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004475 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-27 09:17:07.636525) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-27 09:17:07.636854) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-27 09:17:07.637153) ========= ========= Total master_lag: 0.29 =========