builder: mozilla-central_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-038 starttime: 1485820457.84 results: success (0) revision: 2b11b3e60ca6342b04f4f4ac0ba979769dc98cf8 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-01-30 15:54:17.843725) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-01-30 15:54:17.844422) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-30 15:54:17.844764) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-30 15:54:17.858446) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-30 15:54:17.858791) ========= 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=8783db0840cc980e80bb0bd400000236-1485820457.517632-1028014260 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-01-30 15:54:18-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 43.0M=0s 2017-01-30 15:54:18 (43.0 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.123592 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-30 15:54:17.995377) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-30 15:54:17.995841) ========= 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=8783db0840cc980e80bb0bd400000236-1485820457.517632-1028014260 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016451 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-30 15:54:18.045900) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-30 15:54:18.046285) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 2b11b3e60ca6342b04f4f4ac0ba979769dc98cf8 --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 2b11b3e60ca6342b04f4f4ac0ba979769dc98cf8 --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=8783db0840cc980e80bb0bd400000236-1485820457.517632-1028014260 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-01-30 15:54:18,339 truncating revision to first 12 chars 2017-01-30 15:54:18,339 Setting DEBUG logging. 2017-01-30 15:54:18,339 attempt 1/10 2017-01-30 15:54:18,339 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/2b11b3e60ca6?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-01-30 15:54:18,760 unpacking tar archive at: mozilla-central-2b11b3e60ca6/testing/mozharness/ program finished with exit code 0 elapsedTime=0.759191 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-30 15:54:18.818191) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-30 15:54:18.818516) ========= script_repo_revision: 2b11b3e60ca6342b04f4f4ac0ba979769dc98cf8 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-30 15:54:18.818907) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-30 15:54:18.819176) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-30 15:54:18.826489) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 50 secs) (at 2017-01-30 15:54:18.826773) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --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', '--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=8783db0840cc980e80bb0bd400000236-1485820457.517632-1028014260 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 15:54:19 INFO - MultiFileLogger online at 20170130 15:54:19 in /builds/slave/test 15:54:19 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --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 15:54:19 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 15:54:19 INFO - {'append_to_log': False, 15:54:19 INFO - 'base_work_dir': '/builds/slave/test', 15:54:19 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 15:54:19 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 15:54:19 INFO - 'branch': 'Firefox-Non-PGO', 15:54:19 INFO - 'buildbot_json_path': 'buildprops.json', 15:54:19 INFO - 'config_files': ('talos/linux_config.py',), 15:54:19 INFO - 'default_actions': ('clobber', 15:54:19 INFO - 'read-buildbot-config', 15:54:19 INFO - 'download-and-extract', 15:54:19 INFO - 'populate-webroot', 15:54:19 INFO - 'create-virtualenv', 15:54:19 INFO - 'install', 15:54:19 INFO - 'run-tests'), 15:54:19 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 15:54:19 INFO - 'download_minidump_stackwalk': True, 15:54:19 INFO - 'download_symbols': 'ondemand', 15:54:19 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 15:54:19 INFO - 'tooltool.py': '/tools/tooltool.py', 15:54:19 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 15:54:19 INFO - '/tools/misc-python/virtualenv.py')}, 15:54:19 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 15:54:19 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 15:54:19 INFO - 'installer_path': 'installer.exe', 15:54:19 INFO - 'log_level': 'info', 15:54:19 INFO - 'log_name': 'talos', 15:54:19 INFO - 'log_to_console': True, 15:54:19 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 15:54:19 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 15:54:19 INFO - 'opt_config_files': (), 15:54:19 INFO - 'pip_index': False, 15:54:19 INFO - 'sps_profile': False, 15:54:19 INFO - 'sps_profile_interval': 0, 15:54:19 INFO - 'suite': 'dromaeojs', 15:54:19 INFO - 'system_bits': '32', 15:54:19 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 15:54:19 INFO - 'title': 'talos-linux64-ix-038', 15:54:19 INFO - 'tooltool_cache': '/builds/tooltool_cache', 15:54:19 INFO - 'use_talos_json': True, 15:54:19 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 15:54:19 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 15:54:19 INFO - 'work_dir': 'build'} 15:54:19 INFO - [mozharness: 2017-01-30 23:54:19.221074Z] Running clobber step. 15:54:19 INFO - Running pre-action listener: _resource_record_pre_action 15:54:19 INFO - Running main action method: clobber 15:54:19 INFO - rmtree: /builds/slave/test/build 15:54:19 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 15:54:20 INFO - Running post-action listener: _resource_record_post_action 15:54:20 INFO - [mozharness: 2017-01-30 23:54:20.194759Z] Finished clobber step (success) 15:54:20 INFO - [mozharness: 2017-01-30 23:54:20.194859Z] Running read-buildbot-config step. 15:54:20 INFO - Running pre-action listener: _resource_record_pre_action 15:54:20 INFO - Running main action method: read_buildbot_config 15:54:20 INFO - Using buildbot properties: 15:54:20 INFO - { 15:54:20 INFO - "project": "", 15:54:20 INFO - "product": "firefox", 15:54:20 INFO - "who": "kwierso@gmail.com", 15:54:20 INFO - "installer_path": "public/build/target.tar.bz2", 15:54:20 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 15:54:20 INFO - "repository": "https://hg.mozilla.org/mozilla-central/", 15:54:20 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs", 15:54:20 INFO - "stage_platform": "linux64", 15:54:20 INFO - "basedir": "/builds/slave/test", 15:54:20 INFO - "buildnumber": 421, 15:54:20 INFO - "platform": "ubuntu64_hw", 15:54:20 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 15:54:20 INFO - "slavebuilddir": "test", 15:54:20 INFO - "taskId": "LxPf4w6VS7STPXbjog-n2g", 15:54:20 INFO - "branch": "mozilla-central", 15:54:20 INFO - "script_repo_revision": "production", 15:54:20 INFO - "revision": "2b11b3e60ca6342b04f4f4ac0ba979769dc98cf8", 15:54:20 INFO - "slavename": "talos-linux64-ix-038", 15:54:20 INFO - "repo_path": "mozilla-central" 15:54:20 INFO - } 15:54:20 INFO - Finding installer, test and symbols from parent task. 15:54:20 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/LxPf4w6VS7STPXbjog-n2g'}, attempt #1 15:54:20 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/LxPf4w6VS7STPXbjog-n2g'}, attempt #1 15:54:21 INFO - Task dependencies: Z0S85dxfR2iS3fUBT4Foww 15:54:21 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Z0S85dxfR2iS3fUBT4Foww'}, attempt #1 15:54:22 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/Z0S85dxfR2iS3fUBT4Foww/artifacts/public/build/target.tar.bz2 15:54:22 INFO - Set test_url: https://queue.taskcluster.net/v1/task/Z0S85dxfR2iS3fUBT4Foww/artifacts/public/build/test_packages.json 15:54:22 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/Z0S85dxfR2iS3fUBT4Foww/artifacts/public/build/target.crashreporter-symbols.zip 15:54:22 INFO - Running post-action listener: _resource_record_post_action 15:54:22 INFO - [mozharness: 2017-01-30 23:54:22.130128Z] Finished read-buildbot-config step (success) 15:54:22 INFO - [mozharness: 2017-01-30 23:54:22.130347Z] Running download-and-extract step. 15:54:22 INFO - Running pre-action listener: _resource_record_pre_action 15:54:22 INFO - Running main action method: download_and_extract 15:54:22 INFO - mkdir: /builds/slave/test/build/tests 15:54:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 15:54:22 INFO - trying https://queue.taskcluster.net/v1/task/Z0S85dxfR2iS3fUBT4Foww/artifacts/public/build/target.test_packages.json 15:54:22 INFO - Downloading https://queue.taskcluster.net/v1/task/Z0S85dxfR2iS3fUBT4Foww/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 15:54:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Z0S85dxfR2iS3fUBT4Foww/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 15:54:22 INFO - Downloaded 896 bytes. 15:54:22 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 15:54:22 INFO - Using the following test package requirements: 15:54:22 INFO - {u'common': [u'target.common.tests.zip'], 15:54:22 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 15:54:22 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 15:54:22 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 15:54:22 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 15:54:22 INFO - u'mozbase': [u'target.common.tests.zip'], 15:54:22 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 15:54:22 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 15:54:22 INFO - u'web-platform': [u'target.common.tests.zip', 15:54:22 INFO - u'target.web-platform.tests.zip'], 15:54:22 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 15:54:22 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 15:54:22 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Z0S85dxfR2iS3fUBT4Foww/artifacts/public/build/target.common.tests.zip 15:54:22 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Z0S85dxfR2iS3fUBT4Foww/artifacts/public/build/target.common.tests.zip'}, attempt #1 15:54:22 INFO - Fetch https://queue.taskcluster.net/v1/task/Z0S85dxfR2iS3fUBT4Foww/artifacts/public/build/target.common.tests.zip into memory 15:54:23 INFO - Expected file size: 20334211 15:54:23 INFO - Obtained file size: 20334211 15:54:27 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 15:54:27 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Z0S85dxfR2iS3fUBT4Foww/artifacts/public/build/target.common.tests.zip 15:54:27 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Z0S85dxfR2iS3fUBT4Foww/artifacts/public/build/target.common.tests.zip'}, attempt #1 15:54:27 INFO - Fetch https://queue.taskcluster.net/v1/task/Z0S85dxfR2iS3fUBT4Foww/artifacts/public/build/target.common.tests.zip into memory 15:54:28 INFO - Expected file size: 20334211 15:54:28 INFO - Obtained file size: 20334211 15:54:32 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Z0S85dxfR2iS3fUBT4Foww/artifacts/public/build/target.talos.tests.zip 15:54:32 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Z0S85dxfR2iS3fUBT4Foww/artifacts/public/build/target.talos.tests.zip'}, attempt #1 15:54:32 INFO - Fetch https://queue.taskcluster.net/v1/task/Z0S85dxfR2iS3fUBT4Foww/artifacts/public/build/target.talos.tests.zip into memory 15:54:33 INFO - Expected file size: 14403454 15:54:33 INFO - Obtained file size: 14403454 15:54:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 15:54:33 INFO - trying https://queue.taskcluster.net/v1/task/Z0S85dxfR2iS3fUBT4Foww/artifacts/public/build/target.tar.bz2 15:54:33 INFO - Downloading https://queue.taskcluster.net/v1/task/Z0S85dxfR2iS3fUBT4Foww/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 15:54:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Z0S85dxfR2iS3fUBT4Foww/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 15:54:34 INFO - Downloaded 56219698 bytes. 15:54:34 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Z0S85dxfR2iS3fUBT4Foww/artifacts/public/build/target.tar.bz2 15:54:34 INFO - mkdir: /builds/slave/test/properties 15:54:34 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 15:54:34 INFO - Writing to file /builds/slave/test/properties/build_url 15:54:34 INFO - Contents: 15:54:34 INFO - build_url:https://queue.taskcluster.net/v1/task/Z0S85dxfR2iS3fUBT4Foww/artifacts/public/build/target.tar.bz2 15:54:34 INFO - Running post-action listener: _resource_record_post_action 15:54:34 INFO - Running post-action listener: set_extra_try_arguments 15:54:34 INFO - [mozharness: 2017-01-30 23:54:34.938504Z] Finished download-and-extract step (success) 15:54:34 INFO - [mozharness: 2017-01-30 23:54:34.938601Z] Running populate-webroot step. 15:54:34 INFO - Running pre-action listener: _resource_record_pre_action 15:54:34 INFO - Running main action method: populate_webroot 15:54:34 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 15:54:34 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 15:54:34 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 15:54:34 INFO - '--tppagecycles', 15:54:34 INFO - '7'], 15:54:34 INFO - 'tests': ['tsvgm']}}, 15:54:34 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 15:54:34 INFO - 'tests': ['tresize', 'tcanvasmark']}, 15:54:34 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 15:54:34 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 15:54:34 INFO - 'tests': ['dromaeo_css', 'kraken']}, 15:54:34 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 15:54:34 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 15:54:34 INFO - 'talos_options': ['--disable-e10s'], 15:54:34 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:54:34 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 15:54:34 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:54:34 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 15:54:34 INFO - 'talos_options': ['--disable-e10s'], 15:54:34 INFO - 'tests': ['damp', 'tps']}, 15:54:34 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 15:54:34 INFO - 'tests': ['damp', 'tps']}, 15:54:34 INFO - 'g3': {'talos_options': ['--disable-e10s'], 15:54:34 INFO - 'tests': ['dromaeo_dom']}, 15:54:34 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 15:54:34 INFO - 'g4': {'talos_options': ['--disable-e10s'], 15:54:34 INFO - 'tests': ['basic_compositor_video']}, 15:54:34 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 15:54:34 INFO - 'other': {'talos_options': ['--disable-e10s'], 15:54:34 INFO - 'tests': ['a11yr', 15:54:34 INFO - 'ts_paint', 15:54:34 INFO - 'tpaint', 15:54:34 INFO - 'sessionrestore', 15:54:34 INFO - 'sessionrestore_no_auto_restore', 15:54:34 INFO - 'tabpaint']}, 15:54:34 INFO - 'other-e10s': {'tests': ['a11yr', 15:54:34 INFO - 'ts_paint', 15:54:34 INFO - 'tpaint', 15:54:34 INFO - 'sessionrestore', 15:54:34 INFO - 'sessionrestore_no_auto_restore', 15:54:34 INFO - 'tabpaint']}, 15:54:34 INFO - 'other-e10s_l64': {'tests': ['a11yr', 15:54:34 INFO - 'ts_paint', 15:54:34 INFO - 'tpaint', 15:54:34 INFO - 'sessionrestore', 15:54:34 INFO - 'sessionrestore_no_auto_restore', 15:54:34 INFO - 'tabpaint']}, 15:54:34 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 15:54:34 INFO - 'ts_paint', 15:54:34 INFO - 'tpaint', 15:54:34 INFO - 'sessionrestore', 15:54:34 INFO - 'sessionrestore_no_auto_restore', 15:54:34 INFO - 'tabpaint']}, 15:54:34 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 15:54:34 INFO - 'tests': ['a11yr', 15:54:34 INFO - 'ts_paint', 15:54:34 INFO - 'tpaint', 15:54:34 INFO - 'sessionrestore', 15:54:34 INFO - 'sessionrestore_no_auto_restore', 15:54:34 INFO - 'tabpaint']}, 15:54:34 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 15:54:34 INFO - 'tests': ['a11yr', 15:54:34 INFO - 'ts_paint', 15:54:34 INFO - 'tpaint', 15:54:34 INFO - 'sessionrestore', 15:54:34 INFO - 'sessionrestore_no_auto_restore', 15:54:34 INFO - 'tabpaint']}, 15:54:34 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 15:54:34 INFO - 'tests': ['tsvgx', 15:54:34 INFO - 'tsvgr_opacity', 15:54:34 INFO - 'tart', 15:54:34 INFO - 'tscrollx', 15:54:34 INFO - 'cart', 15:54:34 INFO - 'tsvg_static']}, 15:54:34 INFO - 'svgr-e10s': {'tests': ['tsvgx', 15:54:34 INFO - 'tsvgr_opacity', 15:54:34 INFO - 'tart', 15:54:34 INFO - 'tscrollx', 15:54:34 INFO - 'cart', 15:54:34 INFO - 'tsvg_static']}, 15:54:34 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 15:54:34 INFO - 'talos_options': ['--disable-e10s'], 15:54:34 INFO - 'tests': ['tp5o']}, 15:54:34 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 15:54:34 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 15:54:34 INFO - 'talos_options': ['--disable-e10s', 15:54:34 INFO - '--xperf_path', 15:54:34 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:54:34 INFO - 'tests': ['tp5n']}, 15:54:34 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 15:54:34 INFO - 'talos_options': ['--xperf_path', 15:54:34 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:54:34 INFO - 'tests': ['tp5n']}}, 15:54:34 INFO - 'talos.zip': {'path': '', 15:54:34 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 15:54:34 INFO - Running post-action listener: _resource_record_post_action 15:54:34 INFO - [mozharness: 2017-01-30 23:54:34.951697Z] Finished populate-webroot step (success) 15:54:34 INFO - [mozharness: 2017-01-30 23:54:34.951791Z] Running create-virtualenv step. 15:54:34 INFO - Running pre-action listener: _resource_record_pre_action 15:54:34 INFO - Running main action method: create_virtualenv 15:54:34 INFO - Creating virtualenv /builds/slave/test/build/venv 15:54:34 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 15:54:34 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 15:54:35 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 15:54:35 INFO - Using real prefix '/usr' 15:54:35 INFO - New python executable in /builds/slave/test/build/venv/bin/python 15:54:35 INFO - Installing distribute.............................................................................................................................................................................................done. 15:54:37 INFO - Installing pip.................done. 15:54:37 INFO - Return code: 0 15:54:37 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 15:54:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 15:54:37 INFO - Reading from file tmpfile_stdout 15:54:37 INFO - Output received: 15:54:37 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) 15:54:37 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 15:54:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 15:54:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:54:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:54:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 15:54:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:54:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:54:37 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.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 0x14361f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1546a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17a8630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1831850>, '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 0x17a66d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17a6b60>, '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': '8783db0840cc980e80bb0bd400000236-1485820457.517632-1028014260', '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 15:54:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 15:54:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 15:54:37 INFO - Using env: {'DISPLAY': ':0', 15:54:37 INFO - 'HOME': '/home/cltbld', 15:54:37 INFO - 'LANG': 'en_US.UTF-8', 15:54:37 INFO - 'LANGUAGE': 'en_US:en', 15:54:37 INFO - 'LOGNAME': 'cltbld', 15:54:37 INFO - 'MAIL': '/var/mail/cltbld', 15:54:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:54:37 INFO - 'MOZ_NO_REMOTE': '1', 15:54:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:54:37 INFO - 'NO_EM_RESTART': '1', 15:54:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:54:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:54:37 INFO - 'PWD': '/builds/slave/test', 15:54:37 INFO - 'SHELL': '/bin/bash', 15:54:37 INFO - 'SHLVL': '1', 15:54:37 INFO - 'TERM': 'linux', 15:54:37 INFO - 'TMOUT': '86400', 15:54:37 INFO - 'USER': 'cltbld', 15:54:37 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1485820457.517632-1028014260', 15:54:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:54:37 INFO - '_': '/tools/buildbot/bin/python'} 15:54:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:54:38 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 15:54:38 INFO - Cleaning up... 15:54:38 INFO - Return code: 0 15:54:38 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 15:54:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 15:54:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:54:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:54:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 15:54:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:54:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:54:38 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 0x14361f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1546a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17a8630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1831850>, '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 0x17a66d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17a6b60>, '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': '8783db0840cc980e80bb0bd400000236-1485820457.517632-1028014260', '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 15:54:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 15:54:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 15:54:38 INFO - Using env: {'DISPLAY': ':0', 15:54:38 INFO - 'HOME': '/home/cltbld', 15:54:38 INFO - 'LANG': 'en_US.UTF-8', 15:54:38 INFO - 'LANGUAGE': 'en_US:en', 15:54:38 INFO - 'LOGNAME': 'cltbld', 15:54:38 INFO - 'MAIL': '/var/mail/cltbld', 15:54:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:54:38 INFO - 'MOZ_NO_REMOTE': '1', 15:54:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:54:38 INFO - 'NO_EM_RESTART': '1', 15:54:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:54:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:54:38 INFO - 'PWD': '/builds/slave/test', 15:54:38 INFO - 'SHELL': '/bin/bash', 15:54:38 INFO - 'SHLVL': '1', 15:54:38 INFO - 'TERM': 'linux', 15:54:38 INFO - 'TMOUT': '86400', 15:54:38 INFO - 'USER': 'cltbld', 15:54:38 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1485820457.517632-1028014260', 15:54:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:54:38 INFO - '_': '/tools/buildbot/bin/python'} 15:54:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:54:38 INFO - Downloading/unpacking psutil>=3.1.1 15:54:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:54:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:54:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:54:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:54:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:54:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:54:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 15:54:40 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:54:40 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:54:40 INFO - Installing collected packages: psutil 15:54:40 INFO - Running setup.py install for psutil 15:54:40 INFO - building 'psutil._psutil_linux' extension 15:54:40 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 15:54:40 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 15:54:40 INFO - building 'psutil._psutil_posix' extension 15:54:40 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 15:54:40 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 15:54:40 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:54:40 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:54:40 INFO - Successfully installed psutil 15:54:40 INFO - Cleaning up... 15:54:40 INFO - Return code: 0 15:54:40 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 15:54:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 15:54:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:54:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:54:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 15:54:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:54:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:54:41 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.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 0x14361f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1546a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17a8630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1831850>, '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 0x17a66d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17a6b60>, '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': '8783db0840cc980e80bb0bd400000236-1485820457.517632-1028014260', '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 15:54:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 15:54:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 15:54:41 INFO - Using env: {'DISPLAY': ':0', 15:54:41 INFO - 'HOME': '/home/cltbld', 15:54:41 INFO - 'LANG': 'en_US.UTF-8', 15:54:41 INFO - 'LANGUAGE': 'en_US:en', 15:54:41 INFO - 'LOGNAME': 'cltbld', 15:54:41 INFO - 'MAIL': '/var/mail/cltbld', 15:54:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:54:41 INFO - 'MOZ_NO_REMOTE': '1', 15:54:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:54:41 INFO - 'NO_EM_RESTART': '1', 15:54:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:54:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:54:41 INFO - 'PWD': '/builds/slave/test', 15:54:41 INFO - 'SHELL': '/bin/bash', 15:54:41 INFO - 'SHLVL': '1', 15:54:41 INFO - 'TERM': 'linux', 15:54:41 INFO - 'TMOUT': '86400', 15:54:41 INFO - 'USER': 'cltbld', 15:54:41 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1485820457.517632-1028014260', 15:54:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:54:41 INFO - '_': '/tools/buildbot/bin/python'} 15:54:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:54:41 INFO - Downloading/unpacking mozsystemmonitor==0.3 15:54:41 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 15:54:41 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 15:54:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:54:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:54:41 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 15:54:41 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 15:54:43 INFO - Downloading mozsystemmonitor-0.3.tar.gz 15:54:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 15:54:43 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 15:54:43 INFO - Installing collected packages: mozsystemmonitor 15:54:43 INFO - Running setup.py install for mozsystemmonitor 15:54:43 INFO - Successfully installed mozsystemmonitor 15:54:43 INFO - Cleaning up... 15:54:43 INFO - Return code: 0 15:54:43 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 15:54:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 15:54:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:54:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:54:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 15:54:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:54:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:54:43 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.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 0x14361f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1546a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17a8630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1831850>, '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 0x17a66d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17a6b60>, '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': '8783db0840cc980e80bb0bd400000236-1485820457.517632-1028014260', '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 15:54:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 15:54:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 15:54:43 INFO - Using env: {'DISPLAY': ':0', 15:54:43 INFO - 'HOME': '/home/cltbld', 15:54:43 INFO - 'LANG': 'en_US.UTF-8', 15:54:43 INFO - 'LANGUAGE': 'en_US:en', 15:54:43 INFO - 'LOGNAME': 'cltbld', 15:54:43 INFO - 'MAIL': '/var/mail/cltbld', 15:54:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:54:43 INFO - 'MOZ_NO_REMOTE': '1', 15:54:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:54:43 INFO - 'NO_EM_RESTART': '1', 15:54:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:54:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:54:43 INFO - 'PWD': '/builds/slave/test', 15:54:43 INFO - 'SHELL': '/bin/bash', 15:54:43 INFO - 'SHLVL': '1', 15:54:43 INFO - 'TERM': 'linux', 15:54:43 INFO - 'TMOUT': '86400', 15:54:43 INFO - 'USER': 'cltbld', 15:54:43 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1485820457.517632-1028014260', 15:54:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:54:43 INFO - '_': '/tools/buildbot/bin/python'} 15:54:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:54:43 INFO - Downloading/unpacking jsonschema==2.5.1 15:54:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:54:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:54:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:54:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:54:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:54:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:54:45 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 15:54:45 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 15:54:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:54:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:54:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:54:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:54:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:54:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:54:45 INFO - Downloading functools32-3.2.3-2.tar.gz 15:54:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 15:54:45 INFO - warning: no files found matching '*.txt' 15:54:45 INFO - no previously-included directories found matching 'build' 15:54:45 INFO - no previously-included directories found matching 'dist' 15:54:45 INFO - no previously-included directories found matching '.git*' 15:54:45 INFO - Installing collected packages: jsonschema, functools32 15:54:45 INFO - Running setup.py install for functools32 15:54:46 INFO - warning: no files found matching '*.txt' 15:54:46 INFO - no previously-included directories found matching 'build' 15:54:46 INFO - no previously-included directories found matching 'dist' 15:54:46 INFO - no previously-included directories found matching '.git*' 15:54:46 INFO - Successfully installed jsonschema functools32 15:54:46 INFO - Cleaning up... 15:54:46 INFO - Return code: 0 15:54:46 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 15:54:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 15:54:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:54:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:54:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 15:54:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:54:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:54: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.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 0x14361f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1546a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17a8630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1831850>, '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 0x17a66d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17a6b60>, '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': '8783db0840cc980e80bb0bd400000236-1485820457.517632-1028014260', '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 15:54:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 15:54:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 15:54:46 INFO - Using env: {'DISPLAY': ':0', 15:54:46 INFO - 'HOME': '/home/cltbld', 15:54:46 INFO - 'LANG': 'en_US.UTF-8', 15:54:46 INFO - 'LANGUAGE': 'en_US:en', 15:54:46 INFO - 'LOGNAME': 'cltbld', 15:54:46 INFO - 'MAIL': '/var/mail/cltbld', 15:54:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:54:46 INFO - 'MOZ_NO_REMOTE': '1', 15:54:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:54:46 INFO - 'NO_EM_RESTART': '1', 15:54:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:54:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:54:46 INFO - 'PWD': '/builds/slave/test', 15:54:46 INFO - 'SHELL': '/bin/bash', 15:54:46 INFO - 'SHLVL': '1', 15:54:46 INFO - 'TERM': 'linux', 15:54:46 INFO - 'TMOUT': '86400', 15:54:46 INFO - 'USER': 'cltbld', 15:54:46 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1485820457.517632-1028014260', 15:54:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:54:46 INFO - '_': '/tools/buildbot/bin/python'} 15:54:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:54:46 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 15:54:46 INFO - Cleaning up... 15:54:46 INFO - Return code: 0 15:54:46 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 15:54:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 15:54:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:54:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:54:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 15:54:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:54:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:54: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.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 0x14361f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1546a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17a8630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1831850>, '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 0x17a66d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17a6b60>, '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': '8783db0840cc980e80bb0bd400000236-1485820457.517632-1028014260', '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 15:54:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 15:54:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 15:54:46 INFO - Using env: {'DISPLAY': ':0', 15:54:46 INFO - 'HOME': '/home/cltbld', 15:54:46 INFO - 'LANG': 'en_US.UTF-8', 15:54:46 INFO - 'LANGUAGE': 'en_US:en', 15:54:46 INFO - 'LOGNAME': 'cltbld', 15:54:46 INFO - 'MAIL': '/var/mail/cltbld', 15:54:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:54:46 INFO - 'MOZ_NO_REMOTE': '1', 15:54:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:54:46 INFO - 'NO_EM_RESTART': '1', 15:54:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:54:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:54:46 INFO - 'PWD': '/builds/slave/test', 15:54:46 INFO - 'SHELL': '/bin/bash', 15:54:46 INFO - 'SHLVL': '1', 15:54:46 INFO - 'TERM': 'linux', 15:54:46 INFO - 'TMOUT': '86400', 15:54:46 INFO - 'USER': 'cltbld', 15:54:46 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1485820457.517632-1028014260', 15:54:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:54:46 INFO - '_': '/tools/buildbot/bin/python'} 15:54:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:54:46 INFO - Downloading/unpacking blobuploader==1.2.4 15:54: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 15:54: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 15:54:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:54:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:54: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 15:54: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 15:54:48 INFO - Downloading blobuploader-1.2.4.tar.gz 15:54:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 15:54:48 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 15:54: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 15:54: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 15:54:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:54:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:54: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 15:54: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 15:54:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 15:54:49 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 15:54: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 15:54: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 15:54:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:54:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:54: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 15:54: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 15:54:49 INFO - Downloading docopt-0.6.1.tar.gz 15:54:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 15:54:49 INFO - Installing collected packages: blobuploader, requests, docopt 15:54:49 INFO - Running setup.py install for blobuploader 15:54:49 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 15:54:49 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 15:54:49 INFO - Running setup.py install for requests 15:54:49 INFO - Running setup.py install for docopt 15:54:49 INFO - Successfully installed blobuploader requests docopt 15:54:49 INFO - Cleaning up... 15:54:50 INFO - Return code: 0 15:54:50 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:54:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 15:54:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:54:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:54:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 15:54:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:54:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:54:50 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.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 0x14361f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1546a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17a8630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1831850>, '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 0x17a66d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17a6b60>, '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': '8783db0840cc980e80bb0bd400000236-1485820457.517632-1028014260', '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 15:54:50 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.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 15:54:50 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.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 15:54:50 INFO - Using env: {'DISPLAY': ':0', 15:54:50 INFO - 'HOME': '/home/cltbld', 15:54:50 INFO - 'LANG': 'en_US.UTF-8', 15:54:50 INFO - 'LANGUAGE': 'en_US:en', 15:54:50 INFO - 'LOGNAME': 'cltbld', 15:54:50 INFO - 'MAIL': '/var/mail/cltbld', 15:54:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:54:50 INFO - 'MOZ_NO_REMOTE': '1', 15:54:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:54:50 INFO - 'NO_EM_RESTART': '1', 15:54:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:54:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:54:50 INFO - 'PWD': '/builds/slave/test', 15:54:50 INFO - 'SHELL': '/bin/bash', 15:54:50 INFO - 'SHLVL': '1', 15:54:50 INFO - 'TERM': 'linux', 15:54:50 INFO - 'TMOUT': '86400', 15:54:50 INFO - 'USER': 'cltbld', 15:54:50 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1485820457.517632-1028014260', 15:54:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:54:50 INFO - '_': '/tools/buildbot/bin/python'} 15:54:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:54:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:54:50 INFO - Running setup.py (path:/tmp/pip-xoZJmZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:54:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:54:50 INFO - Running setup.py (path:/tmp/pip-_t7hEj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:54:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:54:50 INFO - Running setup.py (path:/tmp/pip-7nJX4H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:54:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:54:50 INFO - Running setup.py (path:/tmp/pip-JCSNI4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:54:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:54:50 INFO - Running setup.py (path:/tmp/pip-ScbMah-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:54:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:54:50 INFO - Running setup.py (path:/tmp/pip-RZJYb5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:54:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:54:50 INFO - Running setup.py (path:/tmp/pip-jiwu3e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:54:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:54:50 INFO - Running setup.py (path:/tmp/pip-nYLfEH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:54:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:54:50 INFO - Running setup.py (path:/tmp/pip-axu518-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:54:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:54:50 INFO - Running setup.py (path:/tmp/pip-1YGK4e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:54:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:54:50 INFO - Running setup.py (path:/tmp/pip-KDGpir-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:54:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:54:51 INFO - Running setup.py (path:/tmp/pip-MIGQl5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:54:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:54:51 INFO - Running setup.py (path:/tmp/pip-7vRH78-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:54:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:54:51 INFO - Running setup.py (path:/tmp/pip-cFfT1h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:54:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:54:51 INFO - Running setup.py (path:/tmp/pip-bprQm4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:54:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:54:51 INFO - Running setup.py (path:/tmp/pip-74oC1S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:54:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:54:51 INFO - Running setup.py (path:/tmp/pip-URQtCN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:54:51 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 15:54:51 INFO - Running setup.py install for manifestparser 15:54:51 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 15:54:51 INFO - Running setup.py install for mozcrash 15:54:51 INFO - Running setup.py install for mozdebug 15:54:51 INFO - Running setup.py install for mozdevice 15:54:51 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 15:54:51 INFO - Installing dm script to /builds/slave/test/build/venv/bin 15:54:51 INFO - Running setup.py install for mozfile 15:54:51 INFO - Running setup.py install for mozhttpd 15:54:52 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 15:54:52 INFO - Running setup.py install for mozinfo 15:54:52 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 15:54:52 INFO - Running setup.py install for mozInstall 15:54:52 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 15:54:52 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 15:54:52 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 15:54:52 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 15:54:52 INFO - Running setup.py install for mozleak 15:54:52 INFO - Running setup.py install for mozlog 15:54:52 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 15:54:52 INFO - Running setup.py install for moznetwork 15:54:52 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 15:54:52 INFO - Running setup.py install for mozprocess 15:54:52 INFO - Running setup.py install for mozprofile 15:54:52 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 15:54:52 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 15:54:52 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 15:54:52 INFO - Running setup.py install for mozrunner 15:54:52 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 15:54:52 INFO - Running setup.py install for mozscreenshot 15:54:53 INFO - Running setup.py install for moztest 15:54:53 INFO - Running setup.py install for mozversion 15:54:53 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 15:54:53 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 15:54:53 INFO - Cleaning up... 15:54:53 INFO - Return code: 0 15:54:53 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:54:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 15:54:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:54:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:54:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 15:54:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:54:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:54:53 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.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 0x14361f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1546a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17a8630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1831850>, '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 0x17a66d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17a6b60>, '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': '8783db0840cc980e80bb0bd400000236-1485820457.517632-1028014260', '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 15:54:53 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.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 15:54:53 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.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 15:54:53 INFO - Using env: {'DISPLAY': ':0', 15:54:53 INFO - 'HOME': '/home/cltbld', 15:54:53 INFO - 'LANG': 'en_US.UTF-8', 15:54:53 INFO - 'LANGUAGE': 'en_US:en', 15:54:53 INFO - 'LOGNAME': 'cltbld', 15:54:53 INFO - 'MAIL': '/var/mail/cltbld', 15:54:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:54:53 INFO - 'MOZ_NO_REMOTE': '1', 15:54:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:54:53 INFO - 'NO_EM_RESTART': '1', 15:54:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:54:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:54:53 INFO - 'PWD': '/builds/slave/test', 15:54:53 INFO - 'SHELL': '/bin/bash', 15:54:53 INFO - 'SHLVL': '1', 15:54:53 INFO - 'TERM': 'linux', 15:54:53 INFO - 'TMOUT': '86400', 15:54:53 INFO - 'USER': 'cltbld', 15:54:53 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1485820457.517632-1028014260', 15:54:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:54:53 INFO - '_': '/tools/buildbot/bin/python'} 15:54:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:54:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:54:53 INFO - Running setup.py (path:/tmp/pip-b9wuZj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:54:53 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)) 15:54:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:54:53 INFO - Running setup.py (path:/tmp/pip-VCEQak-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:54:53 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)) 15:54:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:54:53 INFO - Running setup.py (path:/tmp/pip-ow9Tzh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:54:53 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)) 15:54:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:54:53 INFO - Running setup.py (path:/tmp/pip-7JBLYg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:54:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.49 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)) 15:54:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:54:53 INFO - Running setup.py (path:/tmp/pip-wIvU3e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:54:53 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)) 15:54:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:54:53 INFO - Running setup.py (path:/tmp/pip-f_qU9y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:54:53 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)) 15:54:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:54:53 INFO - Running setup.py (path:/tmp/pip-8J3Tas-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:54:54 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)) 15:54:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:54:54 INFO - Running setup.py (path:/tmp/pip-fhXytl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:54:54 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)) 15:54:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:54:54 INFO - Running setup.py (path:/tmp/pip-Kg9G2j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:54:54 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)) 15:54:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:54:54 INFO - Running setup.py (path:/tmp/pip-qzErTP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:54:54 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)) 15:54:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:54:54 INFO - Running setup.py (path:/tmp/pip-2A7MiG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:54:54 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)) 15:54:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:54:54 INFO - Running setup.py (path:/tmp/pip-oKwAsF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:54:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.24 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)) 15:54:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:54:54 INFO - Running setup.py (path:/tmp/pip-GhwrXo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:54:54 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)) 15:54:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:54:54 INFO - Running setup.py (path:/tmp/pip-1B9ZcX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:54:54 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)) 15:54:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:54:54 INFO - Running setup.py (path:/tmp/pip-Ugqp7s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:54:54 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)) 15:54:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:54:54 INFO - Running setup.py (path:/tmp/pip-l7ctwo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:54:54 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)) 15:54:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:54:54 INFO - Running setup.py (path:/tmp/pip-ZPXkN1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:54:54 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)) 15:54:54 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)) 15:54:54 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)) 15:54:54 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)) 15:54:54 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.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 15:54:54 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.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 15:54:54 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 15:54:54 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 15:54:54 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 15:54:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:54:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:54:54 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 15:54:54 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 15:54:56 INFO - Downloading blessings-1.6.tar.gz 15:54:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 15:54:56 INFO - Installing collected packages: blessings 15:54:56 INFO - Running setup.py install for blessings 15:54:57 INFO - Successfully installed blessings 15:54:57 INFO - Cleaning up... 15:54:57 INFO - Return code: 0 15:54:57 INFO - Done creating virtualenv /builds/slave/test/build/venv. 15:54:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:54:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:54:57 INFO - Reading from file tmpfile_stdout 15:54:57 INFO - Current package versions: 15:54:57 INFO - argparse == 1.2.1 15:54:57 INFO - blessings == 1.6 15:54:57 INFO - blobuploader == 1.2.4 15:54:57 INFO - docopt == 0.6.1 15:54:57 INFO - functools32 == 3.2.3-2 15:54:57 INFO - jsonschema == 2.5.1 15:54:57 INFO - manifestparser == 1.1 15:54:57 INFO - mozInstall == 1.12 15:54:57 INFO - mozcrash == 1.0 15:54:57 INFO - mozdebug == 0.1 15:54:57 INFO - mozdevice == 0.49 15:54:57 INFO - mozfile == 1.2 15:54:57 INFO - mozhttpd == 0.7 15:54:57 INFO - mozinfo == 0.9 15:54:57 INFO - mozleak == 0.1 15:54:57 INFO - mozlog == 3.4 15:54:57 INFO - moznetwork == 0.27 15:54:57 INFO - mozprocess == 0.24 15:54:57 INFO - mozprofile == 0.28 15:54:57 INFO - mozrunner == 6.13 15:54:57 INFO - mozscreenshot == 0.1 15:54:57 INFO - mozsystemmonitor == 0.3 15:54:57 INFO - moztest == 0.8 15:54:57 INFO - mozversion == 1.4 15:54:57 INFO - psutil == 3.1.1 15:54:57 INFO - requests == 1.2.3 15:54:57 INFO - wsgiref == 0.1.2 15:54:57 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:54:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 15:54:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:54:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:54:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 15:54:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:54:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:54:57 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.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 0x14361f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1546a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17a8630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1831850>, '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 0x17a66d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17a6b60>, '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': '8783db0840cc980e80bb0bd400000236-1485820457.517632-1028014260', '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 15:54:57 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.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 15:54:57 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.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 15:54:57 INFO - Using env: {'DISPLAY': ':0', 15:54:57 INFO - 'HOME': '/home/cltbld', 15:54:57 INFO - 'LANG': 'en_US.UTF-8', 15:54:57 INFO - 'LANGUAGE': 'en_US:en', 15:54:57 INFO - 'LOGNAME': 'cltbld', 15:54:57 INFO - 'MAIL': '/var/mail/cltbld', 15:54:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:54:57 INFO - 'MOZ_NO_REMOTE': '1', 15:54:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:54:57 INFO - 'NO_EM_RESTART': '1', 15:54:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:54:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:54:57 INFO - 'PWD': '/builds/slave/test', 15:54:57 INFO - 'SHELL': '/bin/bash', 15:54:57 INFO - 'SHLVL': '1', 15:54:57 INFO - 'TERM': 'linux', 15:54:57 INFO - 'TMOUT': '86400', 15:54:57 INFO - 'USER': 'cltbld', 15:54:57 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1485820457.517632-1028014260', 15:54:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:54:57 INFO - '_': '/tools/buildbot/bin/python'} 15:54:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:54:57 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)) 15:54:57 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)) 15:54:57 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)) 15:54:57 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)) 15:54:57 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)) 15:54:57 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)) 15:54:57 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)) 15:54:57 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)) 15:54:57 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)) 15:54:57 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)) 15:54:57 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)) 15:54:57 INFO - Cleaning up... 15:54:57 INFO - Return code: 0 15:54:57 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 15:54:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 15:54:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:54:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:54:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 15:54:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:54:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:54:57 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.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 0x14361f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1546a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17a8630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1831850>, '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 0x17a66d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17a6b60>, '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': '8783db0840cc980e80bb0bd400000236-1485820457.517632-1028014260', '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 15:54:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 15:54:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 15:54:57 INFO - Using env: {'DISPLAY': ':0', 15:54:57 INFO - 'HOME': '/home/cltbld', 15:54:57 INFO - 'LANG': 'en_US.UTF-8', 15:54:57 INFO - 'LANGUAGE': 'en_US:en', 15:54:57 INFO - 'LOGNAME': 'cltbld', 15:54:57 INFO - 'MAIL': '/var/mail/cltbld', 15:54:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:54:57 INFO - 'MOZ_NO_REMOTE': '1', 15:54:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:54:57 INFO - 'NO_EM_RESTART': '1', 15:54:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:54:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:54:57 INFO - 'PWD': '/builds/slave/test', 15:54:57 INFO - 'SHELL': '/bin/bash', 15:54:57 INFO - 'SHLVL': '1', 15:54:57 INFO - 'TERM': 'linux', 15:54:57 INFO - 'TMOUT': '86400', 15:54:57 INFO - 'USER': 'cltbld', 15:54:57 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1485820457.517632-1028014260', 15:54:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:54:57 INFO - '_': '/tools/buildbot/bin/python'} 15:54:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:54:57 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 15:54:57 INFO - Cleaning up... 15:54:57 INFO - Return code: 0 15:54:57 INFO - Running post-action listener: _resource_record_post_action 15:54:57 INFO - Running post-action listener: _start_resource_monitoring 15:54:57 INFO - Starting resource monitoring. 15:54:57 INFO - [mozharness: 2017-01-30 23:54:57.858111Z] Finished create-virtualenv step (success) 15:54:57 INFO - [mozharness: 2017-01-30 23:54:57.858616Z] Running install step. 15:54:57 INFO - Running pre-action listener: _resource_record_pre_action 15:54:57 INFO - Running main action method: install 15:54:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:54:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:54:58 INFO - Reading from file tmpfile_stdout 15:54:58 INFO - Detecting whether we're running mozinstall >=1.0... 15:54:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 15:54:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 15:54:58 INFO - Reading from file tmpfile_stdout 15:54:58 INFO - Output received: 15:54:58 INFO - Usage: mozinstall [options] installer 15:54:58 INFO - Options: 15:54:58 INFO - -h, --help show this help message and exit 15:54:58 INFO - -d DEST, --destination=DEST 15:54:58 INFO - Directory to install application into. [default: 15:54:58 INFO - "/builds/slave/test"] 15:54:58 INFO - --app=APP Application being installed. [default: firefox] 15:54:58 INFO - mkdir: /builds/slave/test/build/application 15:54:58 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'] 15:54:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 15:55:14 INFO - Reading from file tmpfile_stdout 15:55:14 INFO - Output received: 15:55:14 INFO - /builds/slave/test/build/application/firefox/firefox 15:55:14 INFO - Running post-action listener: _resource_record_post_action 15:55:14 INFO - [mozharness: 2017-01-30 23:55:14.359470Z] Finished install step (success) 15:55:14 INFO - [mozharness: 2017-01-30 23:55:14.359746Z] Running run-tests step. 15:55:14 INFO - Running pre-action listener: _resource_record_pre_action 15:55:14 INFO - Running main action method: run_tests 15:55:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 15:55:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 15:55:14 INFO - Python 2.7.3 15:55:14 INFO - Return code: 0 15:55:14 INFO - grabbing minidump binary from tooltool 15:55:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 15:55:14 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 0x1831850>, '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 0x17a66d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17a6b60>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 15:55:14 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 15:55:14 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 15:55:14 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 15:55:14 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 15:55:14 INFO - Return code: 0 15:55:14 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 15:55:14 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 15:55:14 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 15:55:14 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 15:55:14 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 15:55:14 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', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Z0S85dxfR2iS3fUBT4Foww/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-038', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 15:55:14 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 --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Z0S85dxfR2iS3fUBT4Foww/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-038 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 15:55:14 INFO - Using env: {'DISPLAY': ':0', 15:55:14 INFO - 'HOME': '/home/cltbld', 15:55:14 INFO - 'LANG': 'en_US.UTF-8', 15:55:14 INFO - 'LANGUAGE': 'en_US:en', 15:55:14 INFO - 'LOGNAME': 'cltbld', 15:55:14 INFO - 'MAIL': '/var/mail/cltbld', 15:55:14 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 15:55:14 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 15:55:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:55:14 INFO - 'MOZ_NO_REMOTE': '1', 15:55:14 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 15:55:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:55:14 INFO - 'NO_EM_RESTART': '1', 15:55:14 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:55:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:55:14 INFO - 'PWD': '/builds/slave/test', 15:55:14 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 15:55:14 INFO - 'SHELL': '/bin/bash', 15:55:14 INFO - 'SHLVL': '1', 15:55:14 INFO - 'TERM': 'linux', 15:55:14 INFO - 'TMOUT': '86400', 15:55:14 INFO - 'USER': 'cltbld', 15:55:14 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1485820457.517632-1028014260', 15:55:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:55:14 INFO - '_': '/tools/buildbot/bin/python'} 15:55:14 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', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Z0S85dxfR2iS3fUBT4Foww/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-038', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 15:55:14 INFO - mozversion application_buildid: 20170130232212 15:55:14 INFO - mozversion application_changeset: 2b11b3e60ca6342b04f4f4ac0ba979769dc98cf8 15:55:14 INFO - mozversion application_display_name: Nightly 15:55:14 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 15:55:14 INFO - mozversion application_name: Firefox 15:55:14 INFO - mozversion application_remotingname: firefox 15:55:14 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 15:55:14 INFO - mozversion application_vendor: Mozilla 15:55:14 INFO - mozversion application_version: 54.0a1 15:55:14 INFO - mozversion platform_buildid: 20170130232212 15:55:14 INFO - mozversion platform_changeset: 2b11b3e60ca6342b04f4f4ac0ba979769dc98cf8 15:55:14 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 15:55:14 INFO - mozversion platform_version: 54.0a1 15:55:14 INFO - using testdate: 1485820514 15:55:14 INFO - actual date: 1485820514 15:55:14 INFO - starting webserver on 'localhost:46234' 15:55:14 INFO - SUITE-START | Running 2 tests 15:55:14 INFO - TEST-START | dromaeo_css 15:55:14 INFO - operating with platform_type : linux_ 15:55:14 INFO - Initialising browser for dromaeo_css test... 15:55:14 INFO - TEST-INFO | started process 4009 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpJHfDqY/profile http://localhost:46234/getInfo.html) 15:55:18 INFO - PROCESS | 4009 | JavaScript error: chrome://webcompat/content/lib/ua_overrider.jsm, line 109: NS_ERROR_INSUFFICIENT_DOMAIN_LEVELS: Component returned failure code: 0x804b0050 (NS_ERROR_INSUFFICIENT_DOMAIN_LEVELS) [nsIEffectiveTLDService.getBaseDomain] 15:55:19 INFO - PROCESS | 4009 | __metrics Screen width/height:1600/1200 15:55:19 INFO - PROCESS | 4009 | colorDepth:24 15:55:19 INFO - PROCESS | 4009 | Browser inner width/height: 1024/697 15:55:19 INFO - PROCESS | 4009 | __metrics 15:55:19 INFO - PROCESS | 4009 | 1485820519789 addons.xpi WARN Exception running bootstrap method shutdown on shield-recipe-client@mozilla.org: ReferenceError: LogManager is not defined (resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/firefox/browser/features/shield-recipe-client@mozilla.org.xpi!/bootstrap.js:65:3) JS Stack trace: this.shutdown@resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/firefox/browser/features/shield-recipe-client@bootstrap.js:65:3 < callBootstrapMethod@XPIProvider.jsm:4903:11 < observe@XPIProvider.jsm:2884:15 < canQuitApplication@quit.js:67:3 < goQuitApplication@quit.js:109:8 < whenDone@quit.js:100:7 < promise callback*goQuitApplication@quit.js:103:5 < onload@getInfo.html:7:5 15:55:19 INFO - PROCESS | 4009 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 15:55:19 INFO - PROCESS | 4009 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 15:55:20 INFO - PROCESS | 4009 | console.error: 15:55:20 INFO - PROCESS | 4009 | Message: Error: Connection closed before committing the transaction. 15:55:20 INFO - PROCESS | 4009 | Stack: 15:55:20 INFO - PROCESS | 4009 | executeTransaction/promise resource://gre/modules/Promise-backend.js:917:23 15:55:20 INFO - PROCESS | 4009 | walkerLoop@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:801:7 15:55:20 INFO - PROCESS | 4009 | Promise*scheduleWalkerLoop@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:734:11 15:55:20 INFO - PROCESS | 4009 | schedulePromise@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:765:7 15:55:20 INFO - PROCESS | 4009 | completePromise@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:702:7 15:55:20 INFO - PROCESS | 4009 | TaskImpl_run@resource://gre/modules/Task.jsm:324:15 15:55:20 INFO - PROCESS | 4009 | observe@resource://gre/modules/AsyncShutdown.jsm:550:9 15:55:20 INFO - PROCESS | 4009 | addBlocker/moduleBlocker/<@resource://gre/components/nsAsyncShutdown.js:157:15 15:55:20 INFO - PROCESS | 4009 | Promise@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:385:5 15:55:20 INFO - PROCESS | 4009 | moduleBlocker@resource://gre/components/nsAsyncShutdown.js:153:29 15:55:20 INFO - PROCESS | 4009 | trigger@resource://gre/modules/AsyncShutdown.jsm:719:23 15:55:20 INFO - PROCESS | 4009 | _wait@resource://gre/modules/AsyncShutdown.jsm:866:7 15:55:20 INFO - PROCESS | 4009 | wait@resource://gre/modules/AsyncShutdown.jsm:850:28 15:55:20 INFO - PROCESS | 4009 | observe@resource://gre/modules/AsyncShutdown.jsm:533:17 15:55:20 INFO - PROCESS | 4009 | 15:55:20 INFO - PROCESS | 4009 | console.error: PushService: 15:55:20 INFO - PROCESS | 4009 | stateChangeProcessEnqueue: Error transitioning state 15:55:20 INFO - PROCESS | 4009 | UnknownError 15:55:21 INFO - TEST-INFO | 4009: exit 0 15:55:21 INFO - Browser initialized. 15:55:21 INFO - Running cycle 1/1 for dromaeo_css test... 15:55:21 INFO - TEST-INFO | started process 4090 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpJHfDqY/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:55:33 INFO - PROCESS | 4090 | RSS: Main: 153948160 15:55:33 INFO - PROCESS | 4090 | 15:58:38 INFO - PROCESS | 4090 | Cycle 1(1): loaded http://localhost:46234/tests/dromaeo/cssquery-dojo.html (next: http://localhost:46234/tests/dromaeo/cssquery-ext.html) 15:58:40 INFO - PROCESS | 4090 | RSS: Main: 277258240 15:58:40 INFO - PROCESS | 4090 | 16:00:23 INFO - PROCESS | 4090 | ************************* 16:00:23 INFO - PROCESS | 4090 | A coding exception was thrown and uncaught in a Task. 16:00:23 INFO - PROCESS | 4090 | 16:00:23 ERROR - PROCESS | 4090 | Full message: TypeError: NetworkError when attempting to fetch resource. 16:00:23 INFO - PROCESS | 4090 | Full stack: 16:00:23 INFO - PROCESS | 4090 | ************************* 16:01:43 INFO - PROCESS | 4090 | Cycle 1(1): loaded http://localhost:46234/tests/dromaeo/cssquery-ext.html (next: http://localhost:46234/tests/dromaeo/cssquery-jquery.html) 16:01:43 INFO - PROCESS | 4090 | RSS: Main: 239083520 16:01:43 INFO - PROCESS | 4090 | 16:04:45 INFO - PROCESS | 4090 | Cycle 1(1): loaded http://localhost:46234/tests/dromaeo/cssquery-jquery.html (next: http://localhost:46234/tests/dromaeo/cssquery-mootools.html) 16:04:46 INFO - PROCESS | 4090 | RSS: Main: 189124608 16:04:46 INFO - PROCESS | 4090 | 16:07:48 INFO - PROCESS | 4090 | Cycle 1(1): loaded http://localhost:46234/tests/dromaeo/cssquery-mootools.html (next: http://localhost:46234/tests/dromaeo/cssquery-prototype.html) 16:07:49 INFO - PROCESS | 4090 | RSS: Main: 186597376 16:07:49 INFO - PROCESS | 4090 | 16:10:52 INFO - PROCESS | 4090 | Cycle 1(1): loaded http://localhost:46234/tests/dromaeo/cssquery-prototype.html (next: http://localhost:46234/tests/dromaeo/cssquery-yui.html) 16:10:53 INFO - PROCESS | 4090 | RSS: Main: 188928000 16:10:53 INFO - PROCESS | 4090 | 16:13:56 INFO - PROCESS | 4090 | Cycle 1(1): loaded http://localhost:46234/tests/dromaeo/cssquery-yui.html (next: http://localhost:46234/tests/dromaeo/cssquery-dojo.html) 16:13:56 INFO - PROCESS | 4090 | RSS: Main: 283684864 16:13:56 INFO - PROCESS | 4090 | 16:13:56 INFO - PROCESS | 4090 | __start_tp_report 16:13:56 INFO - PROCESS | 4090 | _x_x_mozilla_page_load 16:13:56 INFO - PROCESS | 4090 | _x_x_mozilla_page_load_details 16:13:56 INFO - PROCESS | 4090 | |i|pagename|runs| 16:13:56 INFO - PROCESS | 4090 | |0;dojo.html;2543.300592337107;2560.8975640974363;2574.2148644663375;2588.081231162937;2597.9220623381293;4540.954590454095;4586.4266966629175;4667.206574882274;4683.484816670168;4697.17799385108;4627.259638457839;4674.182018146827;4683.0399768047555;4736.43162820462;4739.33649289099;4119.6704263658985;4258.361245813122;4314.82740690372;4358.150160718661;4443.111377724468;4363.869083927487;4403.647708183354;4436.467623885138;4437.156940181371;4452.688311818174;4209.410682504452;4234.026173979971;4341;4348.369486424483;4382;4284.250256205183;4331.198728235255;4340.47914250292;4340.717853339523;4398.8020539075815;4297.35539669049;4319.438472998521;4322.805473753657;4347.69566130371;4354.194474022284;4601.7699115044115;4677.368555245066;4708.9058218835435;4714.316424118518;4718.103560323528;4945.629077819178;4961.3798275215595;4985.651004429691;5000.7249601271915;5046.495350464924;5032.446430892599;5039.395272567315;5045.873853153664;5058.822941197077;5104.897902041938;4722.76386180693;4727.2909063640045;4730.455997560256;4730.739809310452;4767.833125840579;5000.049990501793;5007;5010;5123.897522049613;5125.820596279113;4865.1242776300605;4909.091818013679;4911.18965370717;4911.852644420673;4918.48355922623;4961.627877909171;4972.477889821589;4979.601631869514;4998.700077995332;5008.424031236382;4951.603871690256;4998.350214472095;5000.67495612784;5002.574781143643;5034.874128146753;5008.398992120969;5009.89980200394;5010.123228435083;5011.5489605935645;5041.621878359138;4224.4508213931995;4251.44731184944;4295.656347492193;4309.332053531708;4358.019445624709;3729.627037296303;3768.1333293342136;3780.3573392523335;3784.848606055782;3799.4870692456166;4365.432493775789;4366.995591014084;4373.037931655031;4405.471343438808;4411.139827733626;4916.336294600254;5023.070731914608;5049.6465247432325;5062;5065.138926382524;4265.338872474771;4291.313389857608;4296.505901821331;4297.333913243452;4342.5874541918465;4490.865274041784;4495.505494395614;4496.7301961882395;4499.460064792246;4534.954650453453;4649.256119020941;4656.231721766007;4656.720596764205;4665.043666048384;4699.271612900075;4904.656674032926;4951.777170027285;4956.10790057793;4980.626453015966;5011.624128190328;4624.815007399667;4641.118187544355;4651.744154071558;4654.37165982588;4673.042026384651;4887.095887260868;4888.780004899859;4893.51064893522;4931.506849315183;4936.456989731055;4960.181570040902;4967.329410529533;4970.453250142554;4971.9510490906205;5026.070177017264;4713.646476514344;4739.928901066418;4744.7390393528685;4756.833510827105;4765.0469906019625;4820.758962051813;4851.34506841586;4851.95148048515;4895.1922932717125;4901.6323775716255;4677.064587082665;4724.834630788044;4725.125851717443;4741.288806679026;4769.260764581495;4701.670883038155;4741.928871067006;4881.585065269492;4886.682365646222;4934.284528743384;4715.41057367829;4742.620590352833;4758.262469317261;4818.518148185153;4819.855404337875 16:13:56 INFO - PROCESS | 4090 | |1;ext.html;537.0333399880215;560.3863769172755;563.0231548263763;569.7920259105427;600.0639003155076;29678;41505;43133.78433107834;43293.35059974095;46687.53312466874;42033.789831050875;42471.78764106183;42515.36226956598;42542.57457425425;42565.78717106418;7411.924661094902;7641.465097443167;7852.921470785304;7855.607219639024;7861.921380786204;7399.001134846781;10079.09288164065;10353.637622683207;10358.171346292316;10655.627053053146;10200.438975856325;10259.743506412326;10265.024822641837;10269.897301027006;10270.589176432972;10097.091261786438;10158.542865570993;10161;10164.33931794431;10168.847467287997;10145.188384929263;10200.0819926207;10207.744806379826;10216.33593816407;10216.438095904723;40520.79739601283;40934.59065409338;40976;40981.385279220834;41011.7949410254;3363.3777751115877;3445.6898879101;3482.9028855910306;3538.486919396673;3601.279744051174;25097.24708258755;27747.44505109907;27756.583651245248;27761;27881;2930.252785539695;2975.7916945813586;3004.3690824926794;3104.068779366181;3107.7669174811754;242135;243804;243842;244575;245999.77000115064;48482;49087.75456122697;49203;49500;49532.25701614479;51557.19549815739;51602.74198628983;51657.7417112912;51696.22455663168;51760.74119629453;12982.870171298355;13312.800307995389;13327;13327.200367977759;13328.866711332956;9308.255339572817;9478.431294122236;9931.106200441995;9969.40183588987;10084.495775211357;15854;16436.506904792874;16445.67108657844;16480.587985300463;16545.420910268323;6605.57063790852;6661.233958094881;6795.082663840417;6817.7272909083085;6855.520113592101;657.5035847934779;667.9265280819106;678.6844117485393;680.6902859199053;686.0944592674713;25515.489690206094;27406.697418079388;27814.860925695648;27841.721582783914;27915.720842791718;888.6800751729372;906.1527471813876;907.8910530736354;908.0692290402259;1103.0183137008069;13081.476740930257;13303.534376296782;13598.728025439435;13620.114692544952;13641.795373069412;337176;337617;338599;339483;339978;43799.12401751947;44164.55835441669;44277;44284.55715442869;44289.11421771547;1159.2928313728619;1195.2708847602955;1201.5073819733868;1202.044374722098;1205;23931.282061538182;25364.239072827844;26089.73910260873;26590.867045664647;26666;36373.45439818458;38238.80880595579;38278.42582361211;38488.6151138485;38562.80718596389;268926;273015;273125;274129;274193;21716.34850954474;22246.332610021724;24581.13966011181;37579.436308455945;42834.78582607067;39091.804540977115;42636.70709882607;43115.56884431241;43120;43279.567204327555;35901.461478078374;36395;36531.81734091313;37286.38781611086;37359.81320093382;37351.813240933625;37357;37446.06384840401;37859;37956.810215949845;35955.82022089873;36318.63681363153;37029.81485092557;37102.44346334861;37637.05907352338;31797.523037154;33289.500657490644;33944.490832637035;34042.82978585091;34383;25351.746482535676;25423.61864571996;25844.612330814678;26116.90670689943;26256.343591409604 16:13:56 INFO - PROCESS | 4090 | |2;jquery.html;385.2449199568845;390.4572644024806;394.5659774248326;403.9454673619061;407.94288799568045;16467.752983705253;18496.16767245474;19366;19462.70805937912;19497.51256218592;17153.31386744532;17436.476905692816;17440.476785696417;18158.63682726348;19083.713744293847;5065.442801291855;5180.2229665550185;5281.419043905167;5298.7350632468415;5314.123169676998;5133.460986596409;5215.687058776467;5242;5276.551493123089;5279.5512381447625;5245.370555533342;5246.422893481714;5247.816326428576;5248.790048398078;5280;5431.321084864392;5641.153826925953;5679.176519404684;5760.2223699800825;5769.9902517059345;5511.311086114236;5627.71861406928;5638.633488823213;5661.5187709044785;5732.3121225453215;13214.20714757108;13282.269475178862;13355.599332020054;13362.131461455072;13384.397702103428;2046.7646220684662;2133.722616059918;2139.7111389962465;2157.46063484129;2182.050807898569;9110.362274640778;9830.459324737136;10140.239482038804;11555.133364997659;13758.724825503434;1736.201347380194;1740.3560682547538;1749.9475015749547;1765.143905205974;1779.2793918463044;77343.19470746358;77593.61203193948;78051.6097419515;78885;79989.60005200053;10466;10679.83980240297;10701.304415212986;10830.729231769268;10889.727756805985;15255.847441525442;15316.693666126615;15347;15353.155576443403;15365.462208822637;7289.963550182321;7482.738104166437;7552.697892084365;7614.619269036526;7690.730824421118;6913.723451061901;6915.723371065101;7104;7151.499395042297;7162.713491460388;4565.771711414416;4649.256119020941;4653.86038418848;4759.405074365704;4821.300911367902;1874.8968806715488;1939.6120775844888;1945.7178709087102;1959.8138176873174;2011.1050582490943;743.6579173580105;749.868772964729;760.2397602397602;770.4914756260953;772.9536227826349;17820.556343231536;18602;18741.531461713566;19092.61814763697;19118.507150819547;752.834376437183;762.1692355332714;771.4484143837184;775.3642013548948;783.7217787685404;9808.215342772704;10426.374417534973;10430.634927777492;10453.320534165256;10473.895261047444;486476;489088;495822;496343;496947;87068;88664.5566772175;89224;89667;90212;865.191046371632;872.5331947408233;879.1647934462286;886.6320477002101;888.5690440136528;15638.218089095728;16050.277737502074;16146.677066458371;16313.347466101222;16514.917425412797;40646.79676601598;40663.79668101641;40982.59017409788;41013.79493102516;41596.792016039726;54023.729881350344;54947.175792363945;56449.71775141098;57171;58248;8024.518528888286;8048.7402601946305;8071.757847264592;8255;8260.669573217005;11581.305121692725;12442.693551908345;12508.687282818002;12510.687232818887;12669.683257918627;5221.321228240305;5411.269478620493;10447.00753428423;10807.243492955418;11230.866135434568;10732.195085368785;10778.568857245622;11025.669229922794;11365.829512557484;11466.082713382742;10567.471626418803;10857.457127143452;10887.564497420331;11083.501242443948;11108.555657773599;7236;7411.7035318588805;7469.253074692705;7811.453198276066;8260.091389947222;9493.715188544355;10052.748681283027;10201.489925503844;10646.73383165427;10875.836862446911 16:13:56 INFO - PROCESS | 4090 | |3;mootools.html;1164.6156768266474;1300.772364836154;1323.5301467978873;1331.440794866156;1335.873092056255;5910.261217347832;6362.745490180393;6577.473802095838;6600.372964568371;6803.557768745028;6621.9006714899315;6679.098321726566;6679.866402671943;6689.531732778707;6693.832654183648;1787.9195436205403;1835.6971099768523;2028.634845727772;2061.3300677279867;2067.235123004483;1997.9100940457643;2070.420282320945;2072.4818795301176;2084.249670118756;2089.4567412472716;2018.222984151105;2036.2669439001947;2040.1227472186954;2044.5604195098051;2049.825764809993;1988.6122206169803;2001.7798042215345;2004.8997550122435;2005.5387260929922;2011.5876245369664;1942.1648691062837;1989.6717041688105;2037.8267847233003;2042.6425375559365;2043.2950632031925;6621.801345959629;6632.502562307798;6655.1348324717965;6672;6685.164354455693;4074.0629655179473;4206.326987681956;4215.262329092397;4218.418093215045;4238.258304796679;2543.6438898554215;2634.7233540478164;2645.2593273883344;2701.1491380215366;2714.2264454630335;1002.5438425516445;1053.115383078218;1085.2132204152006;1102.8345748137845;1527.2211172302095;7813.804654883616;8132.064812546515;8134.064582573021;8134.3085837703275;8161.143079976636;3522.947155792665;3654.5797233317976;3696.77819330841;3701.851925922933;3714.7399682022537;6930.06444130036;6936.514443988974;6940.340667636668;6955.513114081966;6963.651817409109;4151.750894946313;4165.562615925345;4187.979060104741;4194;4195;3512.1570823002294;3630.110622897407;3740.532433445819;3849.5957924417535;3915.060385507458;3017.09487153853;3062.969370306313;3098.7056229658147;3127.62468503781;3128.6402063762503;989.5794287427815;994.6419289055934;995.9004099589984;1011.9392836429838;1012.5392946209457;795.3994733975811;809.3889113719105;809.7813590330578;816.2775943290231;819.2544784246307;4396.60430561251;4433.423654924839;4509.481409637868;4569.109023740405;4579.496255411902;535.7883635963773;539.1077766296785;540.7566595032251;547.9205515200274;549.8966453316082;3081.7842751007215;3105.1616063662686;3127.62468503781;3249.3826173027524;3294.6540613235743;7151.82120446993;7327.45044121693;7463.738769143054;7507.399408047343;7786.532808031423;7738.032745906762;7760.456768026297;7760.68957241704;7765.53406795594;7767.417443691746;6005.6396616203165;6025.758969641165;6101.694915254219;6109.175261339751;6118.204633397719;4584.541545845389;4603.976980115078;4642.164415391513;4715.81136754526;4908.435529914105;7043.964780176271;7108.609026503592;7126.28737126304;7139;7170.641467926687;6996.405305549085;7175;7184.9640751795905;7209.495335326476;7220.1696804866015;5277.076511610529;5826.679532625577;5912.73392697321;5940.46535811779;5942.286925568959;5924.585279030426;5961.910571341346;6154.415330543591;6230.563860529719;6315.431611155018;5718.628289161191;5722;5731;5751.051076572318;5870.765169393177;5639.182318563868;5680.943190568041;5720;5732.369439361583;5802.94197058024;4961.330220420197;5167.405748338839;5171.301874247079;5215.087359712111;5218.608604354613;4089.7750623715983;4144.295469770086;4146.543880173118;4157.230912281238;4172;4190.832366705297;4218.156368726329;4224.535301116936;4318.136372725405;4395.450568678915 16:13:56 INFO - PROCESS | 4090 | |4;prototype.html;359.4051844197852;366.4704501994619;366.9761465504742;375.51370974587905;380.2091649369312;4880.609551235902;4890.462049174593;4910.926336104962;4921.606271498281;4966.503349665036;4819.867331177171;4849.393825771778;4858.927116093261;4865.270209468573;4867.561919427251;3337.9833100834585;3683.502727131843;3842.3275926712854;3870.845166193349;3898.3957486589484;3863.130795571002;3866.911867591511;3878.398848178537;3892.5134358205223;3905.5508616509037;3833.2333533293313;3835.7314987950854;3852.2873268445287;3856.614338566149;3877.8254978526033;3755.9624403756025;3829.5978922213044;3885.9805700971315;3887;3895.8636447724475;3523.6300188480095;3533.505309256706;3537.8231088445473;3539.6549311261815;3540.504329393887;4769.928451073202;4775.832845850413;4783.952160478386;4784.952150478485;4819.228923372279;4301.204277208726;4530.478994915594;4534.161180181677;4535.5734681945005;4541.682082254243;5118.283440318359;5159.14874045782;5165.66423182492;5172.793088276464;5173.922391164136;3902.2585708715537;3913.1977944521304;3923.6664883484937;3926.960730392688;3943.481759522576;5157.149070403379;5162.845114646567;5168.328117344797;5452.6183167178315;5456.372517160537;3956.9208615827524;3970.10672598663;3980.6664767303278;4003.7797921114034;4008.3386241269864;4033.878983630496;4043.2519983802504;4053.128577355824;4076.449679293317;4108.342665173617;4376.934345984812;4442.6227869359955;4496.392986946786;4500.144972455223;4507.639388848885;5125.666831655931;5141.4832624375895;5170.457102004236;5200;5212.452692467312;1309.0313168255423;1309.9541516046893;1311.9212847229196;1314.618760559427;1323.9338033098306;932.2113739704804;979.9167070798919;981.018981018981;981.283662926068;990.5096976996433;4389.604935555815;4393.538678438782;4402.9559704402545;4403.339499075164;4406.27296496081;5092.9236061459105;5110.948890511122;5121.487851214849;5125.564327032244;5130.846074617767;4205.5373908870615;4378.176076430685;4405.140997505519;4415.779211039435;4441.822327106879;2707.851068191229;2720.605512200759;2721.8366897986184;2726.9181924542295;2731.4810186064583;4788.11419887322;4795.712257264575;4807.807687692523;4811.663183577116;4816.349792778;5001.449550639313;5161.4322424533275;5174.671397870973;5191.90969896326;5199.142141546678;4787.784549695202;4789.161896668069;4791.185498465269;4795.976020119947;4819.903601928012;5109.514596113363;5114.616403769806;5118.206677964921;5121.359830021247;5167.1474206755465;4863.975680121577;4949;5022.815075442194;5047.268146118866;5052.166392545336;4705.223638099676;4794.904101917872;4813.663043586916;4815.566599006106;4891.388576427947;3949.3878448840474;3958.1094253793817;3984.7011474140136;3999.580044095328;4007.859724909614;5229.50319719626;5250.343707036621;5256.448072952285;5265.921011184912;5267.815626453055;4680.789364478538;4936.333594964633;4975.228839529878;4984.2025275955675;5002.274670172877;4962.801487940442;4965.641320372794;4982.975085124551;4997.475265097112;4998.950010499849;4867.878303042452;4869.537393947569;4892.804287828447;4899.510048995072;4926.433460151985;4788.11419887322;5023.442732752858;5036.169032109661;5044.4198917125;5052.797888084436;4943.737133491878;4946.332245146859;4950.1584730596605;4952.504749525018;4957.529034741694 16:13:56 INFO - PROCESS | 4090 | |5;yui.html;645.6384424722153;670.6043434373719;708.5677736580685;747.2751431111822;749.7863109013932;12536.874631253697;13748.312584370766;13806.79289810651;13883;13916;13256.323163402212;13573.660658483543;13725.65685857854;13757.174569525836;13775.65560860979;806.9515829050247;813.9226773456542;818.6766227340197;818.7707441916243;821.7124006597672;806.2864365036955;806.5402720449346;807.2049031703797;807.2855522862279;807.6971135824066;857.0187135729586;858.356232825381;859.1279850951258;859.6518410043911;859.6948083430386;856.0326830681353;857.2113655437013;857.2713193785295;857.6097875466647;857.7255278310943;626.9780557680505;628.0798630007016;628.4815027602247;628.5160426471637;628.8553632664513;12367.567135150226;12580.496780128784;12633.93683031579;12736.490540378374;12748.2988435636;11037.172212084046;11137.164712646583;11305.26515776472;11380.487878045426;11423.257488263236;9781.217502599775;9795.755106122333;9798.069183427562;9806.264530160266;10093.646722364681;3178.3484385700876;3183.6657150999044;3218.6459489456142;3256.8045917244804;3314.7016768490953;59905.7004714978;62100.06849897255;62578;62725.37274627241;63142;8298.253157215879;8309.210624990616;8454.661813527513;8494.108118647453;8534.914650853536;17935.103244837705;18167.545811354823;18200;18285.26858925628;18370.540736481697;6496.512761542903;6626.801195964033;6643.767468138689;6694.297098804555;6804.183497980274;3332.433486307285;3445.9483107753404;3455.585329760445;3471.1322169457635;3492.7555071145284;2737.671479422442;2811.831290122599;2836.517791975369;2869.0675530452268;2876.180288617734;450.1559575795384;451.6499712722601;454.543184099984;455.97948092335923;459.67592847042755;565.8330792416247;579.3569138256532;595.7408527290643;603.4719620332122;611.5688439650036;8233.217844304781;8361.407963531325;8451.53516556583;8527.232549070613;8538.530380829114;576.8327185116353;592.4579010205699;597.2057163971907;603.8399824046631;608.9573729838869;4109.376796165498;4246.214450326699;4283.571642835692;4292.205941900758;4402.625776808943;64829.35170648328;66913.66543167351;67536.6623166881;68641.31358686449;69408.3059169412;58144.418555814744;58222.41777582255;58799.70600146972;60662.69668651628;61185.38814611886;50978.745106274975;51092.978140436986;51210.23184652233;51477.7426112867;52090.739546302786;7531.27266585193;7976.401769867167;8092.757217283491;8219.178082191733;8237.711680091168;32949.67050329466;33574.32851343008;34402.48396274108;34422.48366274458;35578.644213557534;45396.773016134706;45640.771796140805;45768.313475298564;45770.54229457796;47895.52104478911;8652.826943461221;8748.343874209333;8769.824603508021;8874.911250887408;8875.911240887508;10415.427151506437;10469.31949423285;10484.318519296221;10710.250282480152;10733.677989660322;9691.563879625293;9751.414915105117;9991.900080999389;10042.397456152654;10086.243531735296;10096;10112.646057387956;10433.739156521147;10449.320794148356;10501.422421766876;9530.714078577654;9637.18083962871;9694.75763105928;10073.647422340184;10104.292699511258;8415.579221039046;8820.86768698483;8860.867086993829;8949.373543851867;9046.773830654287;8280.171982801672;8330.750077497685;8454.16734829452;8484.787880302794;8623.180797824196 16:13:56 INFO - PROCESS | 4090 | __end_tp_report 16:13:56 INFO - PROCESS | 4090 | __start_cc_report 16:13:56 INFO - PROCESS | 4090 | _x_x_mozilla_cycle_collect,1293 16:13:56 INFO - PROCESS | 4090 | __end_cc_report 16:13:56 INFO - PROCESS | 4090 | __startTimestamp1485821636292__endTimestamp 16:13:56 INFO - PROCESS | 4090 | 16:13:56 INFO - PROCESS | 4090 | ------- Summary: start ------- 16:13:56 INFO - PROCESS | 4090 | Number of tests: 6 16:13:56 INFO - PROCESS | 4090 | 16:13:56 INFO - PROCESS | 4090 | [#0] dojo.html Cycles:165 Average:4617.41 Median:4722.76 stddev:473.41 (10.0%) stddev-sans-first:446.02 16:13:56 INFO - PROCESS | 4090 | Values: 2543.3 2560.9 2574.2 2588.1 2597.9 4541.0 4586.4 4667.2 4683.5 4697.2 4627.3 4674.2 4683.0 4736.4 4739.3 4119.7 4258.4 4314.8 4358.2 4443.1 4363.9 4403.6 4436.5 4437.2 4452.7 4209.4 4234.0 4341.0 4348.4 4382.0 4284.3 4331.2 4340.5 4340.7 4398.8 4297.4 4319.4 4322.8 4347.7 4354.2 4601.8 4677.4 4708.9 4714.3 4718.1 4945.6 4961.4 4985.7 5000.7 5046.5 5032.4 5039.4 5045.9 5058.8 5104.9 4722.8 4727.3 4730.5 4730.7 4767.8 5000.0 5007.0 5010.0 5123.9 5125.8 4865.1 4909.1 4911.2 4911.9 4918.5 4961.6 4972.5 4979.6 4998.7 5008.4 4951.6 4998.4 5000.7 5002.6 5034.9 5008.4 5009.9 5010.1 5011.5 5041.6 4224.5 4251.4 4295.7 4309.3 4358.0 3729.6 3768.1 3780.4 3784.8 3799.5 4365.4 4367.0 4373.0 4405.5 4411.1 4916.3 5023.1 5049.6 5062.0 5065.1 4265.3 4291.3 4296.5 4297.3 4342.6 4490.9 4495.5 4496.7 4499.5 4535.0 4649.3 4656.2 4656.7 4665.0 4699.3 4904.7 4951.8 4956.1 4980.6 5011.6 4624.8 4641.1 4651.7 4654.4 4673.0 4887.1 4888.8 4893.5 4931.5 4936.5 4960.2 4967.3 4970.5 4972.0 5026.1 4713.6 4739.9 4744.7 4756.8 4765.0 4820.8 4851.3 4852.0 4895.2 4901.6 4677.1 4724.8 4725.1 4741.3 4769.3 4701.7 4741.9 4881.6 4886.7 4934.3 4715.4 4742.6 4758.3 4818.5 4819.9 16:13:56 INFO - PROCESS | 4090 | 16:13:56 INFO - PROCESS | 4090 | [#1] ext.html Cycles:180 Average:44519.45 Median:18914.34 stddev:75288.82 (398.1%) stddev-sans-first:75427.60 16:13:56 INFO - PROCESS | 4090 | Values: 537.0 560.4 563.0 569.8 600.1 29678.0 41505.0 43133.8 43293.4 46687.5 42033.8 42471.8 42515.4 42542.6 42565.8 7411.9 7641.5 7852.9 7855.6 7861.9 7399.0 10079.1 10353.6 10358.2 10655.6 10200.4 10259.7 10265.0 10269.9 10270.6 10097.1 10158.5 10161.0 10164.3 10168.8 10145.2 10200.1 10207.7 10216.3 10216.4 40520.8 40934.6 40976.0 40981.4 41011.8 3363.4 3445.7 3482.9 3538.5 3601.3 25097.2 27747.4 27756.6 27761.0 27881.0 2930.3 2975.8 3004.4 3104.1 3107.8 242135.0 243804.0 243842.0 244575.0 245999.8 48482.0 49087.8 49203.0 49500.0 49532.3 51557.2 51602.7 51657.7 51696.2 51760.7 12982.9 13312.8 13327.0 13327.2 13328.9 9308.3 9478.4 9931.1 9969.4 10084.5 15854.0 16436.5 16445.7 16480.6 16545.4 6605.6 6661.2 6795.1 6817.7 6855.5 657.5 667.9 678.7 680.7 686.1 25515.5 27406.7 27814.9 27841.7 27915.7 888.7 906.2 907.9 908.1 1103.0 13081.5 13303.5 13598.7 13620.1 13641.8 337176.0 337617.0 338599.0 339483.0 339978.0 43799.1 44164.6 44277.0 44284.6 44289.1 1159.3 1195.3 1201.5 1202.0 1205.0 23931.3 25364.2 26089.7 26590.9 26666.0 36373.5 38238.8 38278.4 38488.6 38562.8 268926.0 273015.0 273125.0 274129.0 274193.0 21716.3 22246.3 24581.1 37579.4 42834.8 39091.8 42636.7 43115.6 43120.0 43279.6 35901.5 36395.0 36531.8 37286.4 37359.8 37351.8 37357.0 37446.1 37859.0 37956.8 35955.8 36318.6 37029.8 37102.4 37637.1 31797.5 33289.5 33944.5 34042.8 34383.0 25351.7 25423.6 25844.6 26116.9 26256.3 16:13:56 INFO - PROCESS | 4090 | 16:13:56 INFO - PROCESS | 4090 | [#2] jquery.html Cycles:180 Average:28143.61 Median:4651.56 stddev:81263.09 (1747.0%) stddev-sans-first:81464.32 16:13:56 INFO - PROCESS | 4090 | Values: 385.2 390.5 394.6 403.9 407.9 16467.8 18496.2 19366.0 19462.7 19497.5 17153.3 17436.5 17440.5 18158.6 19083.7 5065.4 5180.2 5281.4 5298.7 5314.1 5133.5 5215.7 5242.0 5276.6 5279.6 5245.4 5246.4 5247.8 5248.8 5280.0 5431.3 5641.2 5679.2 5760.2 5770.0 5511.3 5627.7 5638.6 5661.5 5732.3 13214.2 13282.3 13355.6 13362.1 13384.4 2046.8 2133.7 2139.7 2157.5 2182.1 9110.4 9830.5 10140.2 11555.1 13758.7 1736.2 1740.4 1749.9 1765.1 1779.3 77343.2 77593.6 78051.6 78885.0 79989.6 10466.0 10679.8 10701.3 10830.7 10889.7 15255.8 15316.7 15347.0 15353.2 15365.5 7290.0 7482.7 7552.7 7614.6 7690.7 6913.7 6915.7 7104.0 7151.5 7162.7 4565.8 4649.3 4653.9 4759.4 4821.3 1874.9 1939.6 1945.7 1959.8 2011.1 743.7 749.9 760.2 770.5 773.0 17820.6 18602.0 18741.5 19092.6 19118.5 752.8 762.2 771.4 775.4 783.7 9808.2 10426.4 10430.6 10453.3 10473.9 486476.0 489088.0 495822.0 496343.0 496947.0 87068.0 88664.6 89224.0 89667.0 90212.0 865.2 872.5 879.2 886.6 888.6 15638.2 16050.3 16146.7 16313.3 16514.9 40646.8 40663.8 40982.6 41013.8 41596.8 54023.7 54947.2 56449.7 57171.0 58248.0 8024.5 8048.7 8071.8 8255.0 8260.7 11581.3 12442.7 12508.7 12510.7 12669.7 5221.3 5411.3 10447.0 10807.2 11230.9 10732.2 10778.6 11025.7 11365.8 11466.1 10567.5 10857.5 10887.6 11083.5 11108.6 7236.0 7411.7 7469.3 7811.5 8260.1 9493.7 10052.7 10201.5 10646.7 10875.8 16:13:56 INFO - PROCESS | 4090 | 16:13:56 INFO - PROCESS | 4090 | [#3] mootools.html Cycles:180 Average:4333.36 Median:4812.12 stddev:2227.10 (46.3%) stddev-sans-first:2220.61 16:13:56 INFO - PROCESS | 4090 | Values: 1164.6 1300.8 1323.5 1331.4 1335.9 5910.3 6362.7 6577.5 6600.4 6803.6 6621.9 6679.1 6679.9 6689.5 6693.8 1787.9 1835.7 2028.6 2061.3 2067.2 1997.9 2070.4 2072.5 2084.2 2089.5 2018.2 2036.3 2040.1 2044.6 2049.8 1988.6 2001.8 2004.9 2005.5 2011.6 1942.2 1989.7 2037.8 2042.6 2043.3 6621.8 6632.5 6655.1 6672.0 6685.2 4074.1 4206.3 4215.3 4218.4 4238.3 2543.6 2634.7 2645.3 2701.1 2714.2 1002.5 1053.1 1085.2 1102.8 1527.2 7813.8 8132.1 8134.1 8134.3 8161.1 3522.9 3654.6 3696.8 3701.9 3714.7 6930.1 6936.5 6940.3 6955.5 6963.7 4151.8 4165.6 4188.0 4194.0 4195.0 3512.2 3630.1 3740.5 3849.6 3915.1 3017.1 3063.0 3098.7 3127.6 3128.6 989.6 994.6 995.9 1011.9 1012.5 795.4 809.4 809.8 816.3 819.3 4396.6 4433.4 4509.5 4569.1 4579.5 535.8 539.1 540.8 547.9 549.9 3081.8 3105.2 3127.6 3249.4 3294.7 7151.8 7327.5 7463.7 7507.4 7786.5 7738.0 7760.5 7760.7 7765.5 7767.4 6005.6 6025.8 6101.7 6109.2 6118.2 4584.5 4604.0 4642.2 4715.8 4908.4 7044.0 7108.6 7126.3 7139.0 7170.6 6996.4 7175.0 7185.0 7209.5 7220.2 5277.1 5826.7 5912.7 5940.5 5942.3 5924.6 5961.9 6154.4 6230.6 6315.4 5718.6 5722.0 5731.0 5751.1 5870.8 5639.2 5680.9 5720.0 5732.4 5802.9 4961.3 5167.4 5171.3 5215.1 5218.6 4089.8 4144.3 4146.5 4157.2 4172.0 4190.8 4218.2 4224.5 4318.1 4395.5 16:13:56 INFO - PROCESS | 4090 | 16:13:56 INFO - PROCESS | 4090 | [#4] prototype.html Cycles:180 Average:4244.89 Median:4793.04 stddev:1176.83 (24.6%) stddev-sans-first:1143.42 16:13:56 INFO - PROCESS | 4090 | Values: 359.4 366.5 367.0 375.5 380.2 4880.6 4890.5 4910.9 4921.6 4966.5 4819.9 4849.4 4858.9 4865.3 4867.6 3338.0 3683.5 3842.3 3870.8 3898.4 3863.1 3866.9 3878.4 3892.5 3905.6 3833.2 3835.7 3852.3 3856.6 3877.8 3756.0 3829.6 3886.0 3887.0 3895.9 3523.6 3533.5 3537.8 3539.7 3540.5 4769.9 4775.8 4784.0 4785.0 4819.2 4301.2 4530.5 4534.2 4535.6 4541.7 5118.3 5159.1 5165.7 5172.8 5173.9 3902.3 3913.2 3923.7 3927.0 3943.5 5157.1 5162.8 5168.3 5452.6 5456.4 3956.9 3970.1 3980.7 4003.8 4008.3 4033.9 4043.3 4053.1 4076.4 4108.3 4376.9 4442.6 4496.4 4500.1 4507.6 5125.7 5141.5 5170.5 5200.0 5212.5 1309.0 1310.0 1311.9 1314.6 1323.9 932.2 979.9 981.0 981.3 990.5 4389.6 4393.5 4403.0 4403.3 4406.3 5092.9 5110.9 5121.5 5125.6 5130.8 4205.5 4378.2 4405.1 4415.8 4441.8 2707.9 2720.6 2721.8 2726.9 2731.5 4788.1 4795.7 4807.8 4811.7 4816.3 5001.4 5161.4 5174.7 5191.9 5199.1 4787.8 4789.2 4791.2 4796.0 4819.9 5109.5 5114.6 5118.2 5121.4 5167.1 4864.0 4949.0 5022.8 5047.3 5052.2 4705.2 4794.9 4813.7 4815.6 4891.4 3949.4 3958.1 3984.7 3999.6 4007.9 5229.5 5250.3 5256.4 5265.9 5267.8 4680.8 4936.3 4975.2 4984.2 5002.3 4962.8 4965.6 4983.0 4997.5 4999.0 4867.9 4869.5 4892.8 4899.5 4926.4 4788.1 5023.4 5036.2 5044.4 5052.8 4943.7 4946.3 4950.2 4952.5 4957.5 16:13:56 INFO - PROCESS | 4090 | 16:13:56 INFO - PROCESS | 4090 | [#5] yui.html Cycles:180 Average:14387.29 Median:603.66 stddev:18648.04 (3089.2%) stddev-sans-first:18671.81 16:13:56 INFO - PROCESS | 4090 | Values: 645.6 670.6 708.6 747.3 749.8 12536.9 13748.3 13806.8 13883.0 13916.0 13256.3 13573.7 13725.7 13757.2 13775.7 807.0 813.9 818.7 818.8 821.7 806.3 806.5 807.2 807.3 807.7 857.0 858.4 859.1 859.7 859.7 856.0 857.2 857.3 857.6 857.7 627.0 628.1 628.5 628.5 628.9 12367.6 12580.5 12633.9 12736.5 12748.3 11037.2 11137.2 11305.3 11380.5 11423.3 9781.2 9795.8 9798.1 9806.3 10093.6 3178.3 3183.7 3218.6 3256.8 3314.7 59905.7 62100.1 62578.0 62725.4 63142.0 8298.3 8309.2 8454.7 8494.1 8534.9 17935.1 18167.5 18200.0 18285.3 18370.5 6496.5 6626.8 6643.8 6694.3 6804.2 3332.4 3445.9 3455.6 3471.1 3492.8 2737.7 2811.8 2836.5 2869.1 2876.2 450.2 451.6 454.5 456.0 459.7 565.8 579.4 595.7 603.5 611.6 8233.2 8361.4 8451.5 8527.2 8538.5 576.8 592.5 597.2 603.8 609.0 4109.4 4246.2 4283.6 4292.2 4402.6 64829.4 66913.7 67536.7 68641.3 69408.3 58144.4 58222.4 58799.7 60662.7 61185.4 50978.7 51093.0 51210.2 51477.7 52090.7 7531.3 7976.4 8092.8 8219.2 8237.7 32949.7 33574.3 34402.5 34422.5 35578.6 45396.8 45640.8 45768.3 45770.5 47895.5 8652.8 8748.3 8769.8 8874.9 8875.9 10415.4 10469.3 10484.3 10710.3 10733.7 9691.6 9751.4 9991.9 10042.4 10086.2 10096.0 10112.6 10433.7 10449.3 10501.4 9530.7 9637.2 9694.8 10073.6 10104.3 8415.6 8820.9 8860.9 8949.4 9046.8 8280.2 8330.8 8454.2 8484.8 8623.2 16:13:56 INFO - PROCESS | 4090 | -------- Summary: end -------- 16:13:56 INFO - PROCESS | 4090 | 16:13:57 INFO - TEST-INFO | 4090: exit 0 16:13:57 INFO - TEST-OK | dromaeo_css | took 1122516ms 16:13:57 INFO - TEST-START | kraken 16:13:57 INFO - operating with platform_type : linux_ 16:13:57 INFO - Initialising browser for kraken test... 16:13:57 INFO - TEST-INFO | started process 4393 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpUYKgvg/profile http://localhost:46234/getInfo.html) 16:14:01 INFO - PROCESS | 4393 | JavaScript error: chrome://webcompat/content/lib/ua_overrider.jsm, line 109: NS_ERROR_INSUFFICIENT_DOMAIN_LEVELS: Component returned failure code: 0x804b0050 (NS_ERROR_INSUFFICIENT_DOMAIN_LEVELS) [nsIEffectiveTLDService.getBaseDomain] 16:14:01 INFO - PROCESS | 4393 | __metrics Screen width/height:1600/1200 16:14:01 INFO - PROCESS | 4393 | colorDepth:24 16:14:01 INFO - PROCESS | 4393 | Browser inner width/height: 1024/697 16:14:01 INFO - PROCESS | 4393 | __metrics 16:14:02 INFO - PROCESS | 4393 | 1485821642162 addons.xpi WARN Exception running bootstrap method shutdown on shield-recipe-client@mozilla.org: ReferenceError: LogManager is not defined (resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/firefox/browser/features/shield-recipe-client@mozilla.org.xpi!/bootstrap.js:65:3) JS Stack trace: this.shutdown@resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/firefox/browser/features/shield-recipe-client@bootstrap.js:65:3 < callBootstrapMethod@XPIProvider.jsm:4903:11 < observe@XPIProvider.jsm:2884:15 < canQuitApplication@quit.js:67:3 < goQuitApplication@quit.js:109:8 < whenDone@quit.js:100:7 < promise callback*goQuitApplication@quit.js:103:5 < onload@getInfo.html:7:5 16:14:02 INFO - PROCESS | 4393 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 16:14:02 INFO - PROCESS | 4393 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 16:14:02 INFO - PROCESS | 4393 | console.error: 16:14:02 INFO - PROCESS | 4393 | Message: Error: Connection closed before committing the transaction. 16:14:02 INFO - PROCESS | 4393 | Stack: 16:14:02 INFO - PROCESS | 4393 | executeTransaction/promise resource://gre/modules/Promise-backend.js:917:23 16:14:02 INFO - PROCESS | 4393 | walkerLoop@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:801:7 16:14:02 INFO - PROCESS | 4393 | Promise*scheduleWalkerLoop@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:734:11 16:14:02 INFO - PROCESS | 4393 | schedulePromise@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:765:7 16:14:02 INFO - PROCESS | 4393 | completePromise@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:702:7 16:14:02 INFO - PROCESS | 4393 | TaskImpl_run@resource://gre/modules/Task.jsm:324:15 16:14:02 INFO - PROCESS | 4393 | observe@resource://gre/modules/AsyncShutdown.jsm:550:9 16:14:02 INFO - PROCESS | 4393 | addBlocker/moduleBlocker/<@resource://gre/components/nsAsyncShutdown.js:157:15 16:14:02 INFO - PROCESS | 4393 | Promise@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:385:5 16:14:02 INFO - PROCESS | 4393 | moduleBlocker@resource://gre/components/nsAsyncShutdown.js:153:29 16:14:02 INFO - PROCESS | 4393 | trigger@resource://gre/modules/AsyncShutdown.jsm:719:23 16:14:02 INFO - PROCESS | 4393 | _wait@resource://gre/modules/AsyncShutdown.jsm:866:7 16:14:02 INFO - PROCESS | 4393 | wait@resource://gre/modules/AsyncShutdown.jsm:850:28 16:14:02 INFO - PROCESS | 4393 | observe@resource://gre/modules/AsyncShutdown.jsm:533:17 16:14:02 INFO - PROCESS | 4393 | 16:14:03 INFO - PROCESS | 4393 | console.error: PushService: 16:14:03 INFO - PROCESS | 4393 | stateChangeProcessEnqueue: Error transitioning state 16:14:03 INFO - PROCESS | 4393 | UnknownError 16:14:03 INFO - TEST-INFO | 4393: exit 0 16:14:03 INFO - Browser initialized. 16:14:03 INFO - Running cycle 1/1 for kraken test... 16:14:03 INFO - TEST-INFO | started process 4473 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpUYKgvg/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:14:15 INFO - PROCESS | 4473 | RSS: Main: 157495296 16:14:15 INFO - PROCESS | 4473 | 16:14:18 INFO - PROCESS | 4473 | Cycle 1(1): loaded http://localhost:46234/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:46234/tests/kraken/driver.html?testName=audio-beat-detection) 16:14:19 INFO - PROCESS | 4473 | RSS: Main: 208809984 16:14:19 INFO - PROCESS | 4473 | 16:14:22 INFO - PROCESS | 4473 | Cycle 1(1): loaded http://localhost:46234/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:46234/tests/kraken/driver.html?testName=audio-dft) 16:14:22 INFO - PROCESS | 4473 | RSS: Main: 187285504 16:14:22 INFO - PROCESS | 4473 | 16:14:25 INFO - PROCESS | 4473 | Cycle 1(1): loaded http://localhost:46234/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:46234/tests/kraken/driver.html?testName=audio-fft) 16:14:26 INFO - PROCESS | 4473 | RSS: Main: 270790656 16:14:26 INFO - PROCESS | 4473 | 16:14:28 INFO - PROCESS | 4473 | Cycle 1(1): loaded http://localhost:46234/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:46234/tests/kraken/driver.html?testName=audio-oscillator) 16:14:29 INFO - PROCESS | 4473 | RSS: Main: 180924416 16:14:29 INFO - PROCESS | 4473 | 16:14:31 INFO - PROCESS | 4473 | Cycle 1(1): loaded http://localhost:46234/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:46234/tests/kraken/driver.html?testName=imaging-gaussian-blur) 16:14:32 INFO - PROCESS | 4473 | RSS: Main: 184647680 16:14:32 INFO - PROCESS | 4473 | 16:14:35 INFO - PROCESS | 4473 | Cycle 1(1): loaded http://localhost:46234/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:46234/tests/kraken/driver.html?testName=imaging-darkroom) 16:14:35 INFO - PROCESS | 4473 | RSS: Main: 223645696 16:14:35 INFO - PROCESS | 4473 | 16:14:39 INFO - PROCESS | 4473 | Cycle 1(1): loaded http://localhost:46234/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:46234/tests/kraken/driver.html?testName=imaging-desaturate) 16:14:39 INFO - PROCESS | 4473 | RSS: Main: 217763840 16:14:39 INFO - PROCESS | 4473 | 16:14:42 INFO - PROCESS | 4473 | Cycle 1(1): loaded http://localhost:46234/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:46234/tests/kraken/driver.html?testName=json-parse-financial) 16:14:43 INFO - PROCESS | 4473 | RSS: Main: 219291648 16:14:43 INFO - PROCESS | 4473 | 16:14:45 INFO - PROCESS | 4473 | Cycle 1(1): loaded http://localhost:46234/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:46234/tests/kraken/driver.html?testName=json-stringify-tinderbox) 16:14:45 INFO - PROCESS | 4473 | RSS: Main: 183271424 16:14:45 INFO - PROCESS | 4473 | 16:14:47 INFO - PROCESS | 4473 | Cycle 1(1): loaded http://localhost:46234/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:46234/tests/kraken/driver.html?testName=stanford-crypto-aes) 16:14:48 INFO - PROCESS | 4473 | RSS: Main: 190341120 16:14:48 INFO - PROCESS | 4473 | 16:14:50 INFO - PROCESS | 4473 | Cycle 1(1): loaded http://localhost:46234/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:46234/tests/kraken/driver.html?testName=stanford-crypto-ccm) 16:14:51 INFO - PROCESS | 4473 | RSS: Main: 199098368 16:14:51 INFO - PROCESS | 4473 | 16:14:53 INFO - PROCESS | 4473 | Cycle 1(1): loaded http://localhost:46234/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:46234/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 16:14:54 INFO - PROCESS | 4473 | RSS: Main: 204042240 16:14:54 INFO - PROCESS | 4473 | 16:14:57 INFO - PROCESS | 4473 | Cycle 1(1): loaded http://localhost:46234/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:46234/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 16:14:58 INFO - PROCESS | 4473 | RSS: Main: 205434880 16:14:58 INFO - PROCESS | 4473 | 16:15:00 INFO - PROCESS | 4473 | Cycle 1(1): loaded http://localhost:46234/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:46234/tests/kraken/driver.html?testName=ai-astar) 16:15:00 INFO - PROCESS | 4473 | RSS: Main: 256937984 16:15:00 INFO - PROCESS | 4473 | 16:15:00 INFO - PROCESS | 4473 | __start_tp_report 16:15:00 INFO - PROCESS | 4473 | _x_x_mozilla_page_load 16:15:00 INFO - PROCESS | 4473 | _x_x_mozilla_page_load_details 16:15:00 INFO - PROCESS | 4473 | |i|pagename|runs| 16:15:00 INFO - PROCESS | 4473 | |0;ai-astar;114;117;116;117;116;116;116;116;117;117 16:15:00 INFO - PROCESS | 4473 | |1;audio-beat-detection;157;131;126;177;128;126;126;129;153;127 16:15:00 INFO - PROCESS | 4473 | |2;audio-dft;162;162;163;161;161;163;161;162;161;162 16:15:00 INFO - PROCESS | 4473 | |3;audio-fft;75;77;76;100;76;76;85;78;91;77 16:15:00 INFO - PROCESS | 4473 | |4;audio-oscillator;84;84;105;83;83;84;97;83;84;111 16:15:00 INFO - PROCESS | 4473 | |5;imaging-gaussian-blur;117;117;117;117;117;117;117;117;117;117 16:15:00 INFO - PROCESS | 4473 | |6;imaging-darkroom;149;148;150;150;150;149;149;150;149;149 16:15:00 INFO - PROCESS | 4473 | |7;imaging-desaturate;95;96;95;95;96;97;95;95;96;95 16:15:00 INFO - PROCESS | 4473 | |8;json-parse-financial;61;61;61;61;62;62;63;62;63;63 16:15:00 INFO - PROCESS | 4473 | |9;json-stringify-tinderbox;67;68;67;67;67;67;67;67;68;69 16:15:00 INFO - PROCESS | 4473 | |10;stanford-crypto-aes;86;86;91;86;84;87;85;92;91;93 16:15:00 INFO - PROCESS | 4473 | |11;stanford-crypto-ccm;141;133;139;134;139;146;141;131;219;154 16:15:00 INFO - PROCESS | 4473 | |12;stanford-crypto-pbkdf2;176;176;174;178;181;184;178;179;174;182 16:15:00 INFO - PROCESS | 4473 | |13;stanford-crypto-sha256-iterative;70;71;67;67;68;67;66;67;71;67 16:15:00 INFO - PROCESS | 4473 | __end_tp_report 16:15:00 INFO - PROCESS | 4473 | __start_cc_report 16:15:00 INFO - PROCESS | 4473 | _x_x_mozilla_cycle_collect,1852 16:15:00 INFO - PROCESS | 4473 | __end_cc_report 16:15:00 INFO - PROCESS | 4473 | __startTimestamp1485821700354__endTimestamp 16:15:00 INFO - PROCESS | 4473 | 16:15:00 INFO - PROCESS | 4473 | ------- Summary: start ------- 16:15:00 INFO - PROCESS | 4473 | Number of tests: 14 16:15:00 INFO - PROCESS | 4473 | 16:15:00 INFO - PROCESS | 4473 | [#0] ai-astar Cycles:10 Average:116.20 Median:116.50 stddev:0.92 (0.8%) stddev-sans-first:0.53 16:15:00 INFO - PROCESS | 4473 | Values: 114.0 117.0 116.0 117.0 116.0 116.0 116.0 116.0 117.0 117.0 16:15:00 INFO - PROCESS | 4473 | 16:15:00 INFO - PROCESS | 4473 | [#1] audio-beat-detection Cycles:10 Average:138.00 Median:130.00 stddev:17.92 (13.8%) stddev-sans-first:17.64 16:15:00 INFO - PROCESS | 4473 | Values: 157.0 131.0 126.0 177.0 128.0 126.0 126.0 129.0 153.0 127.0 16:15:00 INFO - PROCESS | 4473 | 16:15:00 INFO - PROCESS | 4473 | [#2] audio-dft Cycles:10 Average:161.80 Median:162.00 stddev:0.79 (0.5%) stddev-sans-first:0.83 16:15:00 INFO - PROCESS | 4473 | Values: 162.0 162.0 163.0 161.0 161.0 163.0 161.0 162.0 161.0 162.0 16:15:00 INFO - PROCESS | 4473 | 16:15:00 INFO - PROCESS | 4473 | [#3] audio-fft Cycles:10 Average:81.10 Median:77.00 stddev:8.36 (10.9%) stddev-sans-first:8.57 16:15:00 INFO - PROCESS | 4473 | Values: 75.0 77.0 76.0 100.0 76.0 76.0 85.0 78.0 91.0 77.0 16:15:00 INFO - PROCESS | 4473 | 16:15:00 INFO - PROCESS | 4473 | [#4] audio-oscillator Cycles:10 Average:89.80 Median:84.00 stddev:10.57 (12.6%) stddev-sans-first:11.00 16:15:00 INFO - PROCESS | 4473 | Values: 84.0 84.0 105.0 83.0 83.0 84.0 97.0 83.0 84.0 111.0 16:15:00 INFO - PROCESS | 4473 | 16:15:00 INFO - PROCESS | 4473 | [#5] imaging-gaussian-blur Cycles:10 Average:117.00 Median:117.00 stddev:0.00 (0.0%) stddev-sans-first:0.00 16:15:00 INFO - PROCESS | 4473 | Values: 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 16:15:00 INFO - PROCESS | 4473 | 16:15:00 INFO - PROCESS | 4473 | [#6] imaging-darkroom Cycles:10 Average:149.30 Median:149.50 stddev:0.67 (0.5%) stddev-sans-first:0.71 16:15:00 INFO - PROCESS | 4473 | Values: 149.0 148.0 150.0 150.0 150.0 149.0 149.0 150.0 149.0 149.0 16:15:00 INFO - PROCESS | 4473 | 16:15:00 INFO - PROCESS | 4473 | [#7] imaging-desaturate Cycles:10 Average:95.50 Median:95.50 stddev:0.71 (0.7%) stddev-sans-first:0.73 16:15:00 INFO - PROCESS | 4473 | Values: 95.0 96.0 95.0 95.0 96.0 97.0 95.0 95.0 96.0 95.0 16:15:00 INFO - PROCESS | 4473 | 16:15:00 INFO - PROCESS | 4473 | [#8] json-parse-financial Cycles:10 Average:61.90 Median:62.00 stddev:0.88 (1.4%) stddev-sans-first:0.87 16:15:00 INFO - PROCESS | 4473 | Values: 61.0 61.0 61.0 61.0 62.0 62.0 63.0 62.0 63.0 63.0 16:15:00 INFO - PROCESS | 4473 | 16:15:00 INFO - PROCESS | 4473 | [#9] json-stringify-tinderbox Cycles:10 Average:67.40 Median:67.00 stddev:0.70 (1.0%) stddev-sans-first:0.73 16:15:00 INFO - PROCESS | 4473 | Values: 67.0 68.0 67.0 67.0 67.0 67.0 67.0 67.0 68.0 69.0 16:15:00 INFO - PROCESS | 4473 | 16:15:00 INFO - PROCESS | 4473 | [#10] stanford-crypto-aes Cycles:10 Average:88.10 Median:89.00 stddev:3.28 (3.7%) stddev-sans-first:3.39 16:15:00 INFO - PROCESS | 4473 | Values: 86.0 86.0 91.0 86.0 84.0 87.0 85.0 92.0 91.0 93.0 16:15:00 INFO - PROCESS | 4473 | 16:15:00 INFO - PROCESS | 4473 | [#11] stanford-crypto-ccm Cycles:10 Average:147.70 Median:141.00 stddev:25.93 (18.4%) stddev-sans-first:27.39 16:15:00 INFO - PROCESS | 4473 | Values: 141.0 133.0 139.0 134.0 139.0 146.0 141.0 131.0 219.0 154.0 16:15:00 INFO - PROCESS | 4473 | 16:15:00 INFO - PROCESS | 4473 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:178.20 Median:178.50 stddev:3.36 (1.9%) stddev-sans-first:3.47 16:15:00 INFO - PROCESS | 4473 | Values: 176.0 176.0 174.0 178.0 181.0 184.0 178.0 179.0 174.0 182.0 16:15:00 INFO - PROCESS | 4473 | 16:15:00 INFO - PROCESS | 4473 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.10 Median:67.50 stddev:1.85 (2.7%) stddev-sans-first:1.83 16:15:00 INFO - PROCESS | 4473 | Values: 70.0 71.0 67.0 67.0 68.0 67.0 66.0 67.0 71.0 67.0 16:15:00 INFO - PROCESS | 4473 | -------- Summary: end -------- 16:15:00 INFO - PROCESS | 4473 | 16:15:01 INFO - TEST-INFO | 4473: exit 0 16:15:01 INFO - TEST-OK | kraken | took 64416ms 16:15:01 INFO - SUITE-END | took 1186s 16:15:02 INFO - Completed test suite (00:19:47) 16:15:02 INFO - javascript benchmark 16:15:02 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": [], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6202.81636224505, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2543.300592337107, 2560.8975640974363, 2574.2148644663375, 2588.081231162937, 2597.9220623381293, 4540.954590454095, 4586.4266966629175, 4667.206574882274, 4683.484816670168, 4697.17799385108, 4627.259638457839, 4674.182018146827, 4683.0399768047555, 4736.43162820462, 4739.33649289099, 4119.6704263658985, 4258.361245813122, 4314.82740690372, 4358.150160718661, 4443.111377724468, 4363.869083927487, 4403.647708183354, 4436.467623885138, 4437.156940181371, 4452.688311818174, 4209.410682504452, 4234.026173979971, 4341.0, 4348.369486424483, 4382.0, 4284.250256205183, 4331.198728235255, 4340.47914250292, 4340.717853339523, 4398.8020539075815, 4297.35539669049, 4319.438472998521, 4322.805473753657, 4347.69566130371, 4354.194474022284, 4601.7699115044115, 4677.368555245066, 4708.9058218835435, 4714.316424118518, 4718.103560323528, 4945.629077819178, 4961.3798275215595, 4985.651004429691, 5000.7249601271915, 5046.495350464924, 5032.446430892599, 5039.395272567315, 5045.873853153664, 5058.822941197077, 5104.897902041938, 4722.76386180693, 4727.2909063640045, 4730.455997560256, 4730.739809310452, 4767.833125840579, 5000.049990501793, 5007.0, 5010.0, 5123.897522049613, 5125.820596279113, 4865.1242776300605, 4909.091818013679, 4911.18965370717, 4911.852644420673, 4918.48355922623, 4961.627877909171, 4972.477889821589, 4979.601631869514, 4998.700077995332, 5008.424031236382, 4951.603871690256, 4998.350214472095, 5000.67495612784, 5002.574781143643, 5034.874128146753, 5008.398992120969, 5009.89980200394, 5010.123228435083, 5011.5489605935645, 5041.621878359138, 4224.4508213931995, 4251.44731184944, 4295.656347492193, 4309.332053531708, 4358.019445624709, 3729.627037296303, 3768.1333293342136, 3780.3573392523335, 3784.848606055782, 3799.4870692456166, 4365.432493775789, 4366.995591014084, 4373.037931655031, 4405.471343438808, 4411.139827733626, 4916.336294600254, 5023.070731914608, 5049.6465247432325, 5062.0, 5065.138926382524, 4265.338872474771, 4291.313389857608, 4296.505901821331, 4297.333913243452, 4342.5874541918465, 4490.865274041784, 4495.505494395614, 4496.7301961882395, 4499.460064792246, 4534.954650453453, 4649.256119020941, 4656.231721766007, 4656.720596764205, 4665.043666048384, 4699.271612900075, 4904.656674032926, 4951.777170027285, 4956.10790057793, 4980.626453015966, 5011.624128190328, 4624.815007399667, 4641.118187544355, 4651.744154071558, 4654.37165982588, 4673.042026384651, 4887.095887260868, 4888.780004899859, 4893.51064893522, 4931.506849315183, 4936.456989731055, 4960.181570040902, 4967.329410529533, 4970.453250142554, 4971.9510490906205, 5026.070177017264, 4713.646476514344, 4739.928901066418, 4744.7390393528685, 4756.833510827105, 4765.0469906019625, 4820.758962051813, 4851.34506841586, 4851.95148048515, 4895.1922932717125, 4901.6323775716255, 4677.064587082665, 4724.834630788044, 4725.125851717443, 4741.288806679026, 4769.260764581495, 4701.670883038155, 4741.928871067006, 4881.585065269492, 4886.682365646222, 4934.284528743384, 4715.41057367829, 4742.620590352833, 4758.262469317261, 4818.518148185153, 4819.855404337875], "value": 4587.2727073744245, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [537.0333399880215, 560.3863769172755, 563.0231548263763, 569.7920259105427, 600.0639003155076, 29678.0, 41505.0, 43133.78433107834, 43293.35059974095, 46687.53312466874, 42033.789831050875, 42471.78764106183, 42515.36226956598, 42542.57457425425, 42565.78717106418, 7411.924661094902, 7641.465097443167, 7852.921470785304, 7855.607219639024, 7861.921380786204, 7399.001134846781, 10079.09288164065, 10353.637622683207, 10358.171346292316, 10655.627053053146, 10200.438975856325, 10259.743506412326, 10265.024822641837, 10269.897301027006, 10270.589176432972, 10097.091261786438, 10158.542865570993, 10161.0, 10164.33931794431, 10168.847467287997, 10145.188384929263, 10200.0819926207, 10207.744806379826, 10216.33593816407, 10216.438095904723, 40520.79739601283, 40934.59065409338, 40976.0, 40981.385279220834, 41011.7949410254, 3363.3777751115877, 3445.6898879101, 3482.9028855910306, 3538.486919396673, 3601.279744051174, 25097.24708258755, 27747.44505109907, 27756.583651245248, 27761.0, 27881.0, 2930.252785539695, 2975.7916945813586, 3004.3690824926794, 3104.068779366181, 3107.7669174811754, 242135.0, 243804.0, 243842.0, 244575.0, 245999.77000115064, 48482.0, 49087.75456122697, 49203.0, 49500.0, 49532.25701614479, 51557.19549815739, 51602.74198628983, 51657.7417112912, 51696.22455663168, 51760.74119629453, 12982.870171298355, 13312.800307995389, 13327.0, 13327.200367977759, 13328.866711332956, 9308.255339572817, 9478.431294122236, 9931.106200441995, 9969.40183588987, 10084.495775211357, 15854.0, 16436.506904792874, 16445.67108657844, 16480.587985300463, 16545.420910268323, 6605.57063790852, 6661.233958094881, 6795.082663840417, 6817.7272909083085, 6855.520113592101, 657.5035847934779, 667.9265280819106, 678.6844117485393, 680.6902859199053, 686.0944592674713, 25515.489690206094, 27406.697418079388, 27814.860925695648, 27841.721582783914, 27915.720842791718, 888.6800751729372, 906.1527471813876, 907.8910530736354, 908.0692290402259, 1103.0183137008069, 13081.476740930257, 13303.534376296782, 13598.728025439435, 13620.114692544952, 13641.795373069412, 337176.0, 337617.0, 338599.0, 339483.0, 339978.0, 43799.12401751947, 44164.55835441669, 44277.0, 44284.55715442869, 44289.11421771547, 1159.2928313728619, 1195.2708847602955, 1201.5073819733868, 1202.044374722098, 1205.0, 23931.282061538182, 25364.239072827844, 26089.73910260873, 26590.867045664647, 26666.0, 36373.45439818458, 38238.80880595579, 38278.42582361211, 38488.6151138485, 38562.80718596389, 268926.0, 273015.0, 273125.0, 274129.0, 274193.0, 21716.34850954474, 22246.332610021724, 24581.13966011181, 37579.436308455945, 42834.78582607067, 39091.804540977115, 42636.70709882607, 43115.56884431241, 43120.0, 43279.567204327555, 35901.461478078374, 36395.0, 36531.81734091313, 37286.38781611086, 37359.81320093382, 37351.813240933625, 37357.0, 37446.06384840401, 37859.0, 37956.810215949845, 35955.82022089873, 36318.63681363153, 37029.81485092557, 37102.44346334861, 37637.05907352338, 31797.523037154, 33289.500657490644, 33944.490832637035, 34042.82978585091, 34383.0, 25351.746482535676, 25423.61864571996, 25844.612330814678, 26116.90670689943, 26256.343591409604], "value": 17446.058373006297, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [385.2449199568845, 390.4572644024806, 394.5659774248326, 403.9454673619061, 407.94288799568045, 16467.752983705253, 18496.16767245474, 19366.0, 19462.70805937912, 19497.51256218592, 17153.31386744532, 17436.476905692816, 17440.476785696417, 18158.63682726348, 19083.713744293847, 5065.442801291855, 5180.2229665550185, 5281.419043905167, 5298.7350632468415, 5314.123169676998, 5133.460986596409, 5215.687058776467, 5242.0, 5276.551493123089, 5279.5512381447625, 5245.370555533342, 5246.422893481714, 5247.816326428576, 5248.790048398078, 5280.0, 5431.321084864392, 5641.153826925953, 5679.176519404684, 5760.2223699800825, 5769.9902517059345, 5511.311086114236, 5627.71861406928, 5638.633488823213, 5661.5187709044785, 5732.3121225453215, 13214.20714757108, 13282.269475178862, 13355.599332020054, 13362.131461455072, 13384.397702103428, 2046.7646220684662, 2133.722616059918, 2139.7111389962465, 2157.46063484129, 2182.050807898569, 9110.362274640778, 9830.459324737136, 10140.239482038804, 11555.133364997659, 13758.724825503434, 1736.201347380194, 1740.3560682547538, 1749.9475015749547, 1765.143905205974, 1779.2793918463044, 77343.19470746358, 77593.61203193948, 78051.6097419515, 78885.0, 79989.60005200053, 10466.0, 10679.83980240297, 10701.304415212986, 10830.729231769268, 10889.727756805985, 15255.847441525442, 15316.693666126615, 15347.0, 15353.155576443403, 15365.462208822637, 7289.963550182321, 7482.738104166437, 7552.697892084365, 7614.619269036526, 7690.730824421118, 6913.723451061901, 6915.723371065101, 7104.0, 7151.499395042297, 7162.713491460388, 4565.771711414416, 4649.256119020941, 4653.86038418848, 4759.405074365704, 4821.300911367902, 1874.8968806715488, 1939.6120775844888, 1945.7178709087102, 1959.8138176873174, 2011.1050582490943, 743.6579173580105, 749.868772964729, 760.2397602397602, 770.4914756260953, 772.9536227826349, 17820.556343231536, 18602.0, 18741.531461713566, 19092.61814763697, 19118.507150819547, 752.834376437183, 762.1692355332714, 771.4484143837184, 775.3642013548948, 783.7217787685404, 9808.215342772704, 10426.374417534973, 10430.634927777492, 10453.320534165256, 10473.895261047444, 486476.0, 489088.0, 495822.0, 496343.0, 496947.0, 87068.0, 88664.5566772175, 89224.0, 89667.0, 90212.0, 865.191046371632, 872.5331947408233, 879.1647934462286, 886.6320477002101, 888.5690440136528, 15638.218089095728, 16050.277737502074, 16146.677066458371, 16313.347466101222, 16514.917425412797, 40646.79676601598, 40663.79668101641, 40982.59017409788, 41013.79493102516, 41596.792016039726, 54023.729881350344, 54947.175792363945, 56449.71775141098, 57171.0, 58248.0, 8024.518528888286, 8048.7402601946305, 8071.757847264592, 8255.0, 8260.669573217005, 11581.305121692725, 12442.693551908345, 12508.687282818002, 12510.687232818887, 12669.683257918627, 5221.321228240305, 5411.269478620493, 10447.00753428423, 10807.243492955418, 11230.866135434568, 10732.195085368785, 10778.568857245622, 11025.669229922794, 11365.829512557484, 11466.082713382742, 10567.471626418803, 10857.457127143452, 10887.564497420331, 11083.501242443948, 11108.555657773599, 7236.0, 7411.7035318588805, 7469.253074692705, 7811.453198276066, 8260.091389947222, 9493.715188544355, 10052.748681283027, 10201.489925503844, 10646.73383165427, 10875.836862446911], "value": 8485.603389759723, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1164.6156768266474, 1300.772364836154, 1323.5301467978873, 1331.440794866156, 1335.873092056255, 5910.261217347832, 6362.745490180393, 6577.473802095838, 6600.372964568371, 6803.557768745028, 6621.9006714899315, 6679.098321726566, 6679.866402671943, 6689.531732778707, 6693.832654183648, 1787.9195436205403, 1835.6971099768523, 2028.634845727772, 2061.3300677279867, 2067.235123004483, 1997.9100940457643, 2070.420282320945, 2072.4818795301176, 2084.249670118756, 2089.4567412472716, 2018.222984151105, 2036.2669439001947, 2040.1227472186954, 2044.5604195098051, 2049.825764809993, 1988.6122206169803, 2001.7798042215345, 2004.8997550122435, 2005.5387260929922, 2011.5876245369664, 1942.1648691062837, 1989.6717041688105, 2037.8267847233003, 2042.6425375559365, 2043.2950632031925, 6621.801345959629, 6632.502562307798, 6655.1348324717965, 6672.0, 6685.164354455693, 4074.0629655179473, 4206.326987681956, 4215.262329092397, 4218.418093215045, 4238.258304796679, 2543.6438898554215, 2634.7233540478164, 2645.2593273883344, 2701.1491380215366, 2714.2264454630335, 1002.5438425516445, 1053.115383078218, 1085.2132204152006, 1102.8345748137845, 1527.2211172302095, 7813.804654883616, 8132.064812546515, 8134.064582573021, 8134.3085837703275, 8161.143079976636, 3522.947155792665, 3654.5797233317976, 3696.77819330841, 3701.851925922933, 3714.7399682022537, 6930.06444130036, 6936.514443988974, 6940.340667636668, 6955.513114081966, 6963.651817409109, 4151.750894946313, 4165.562615925345, 4187.979060104741, 4194.0, 4195.0, 3512.1570823002294, 3630.110622897407, 3740.532433445819, 3849.5957924417535, 3915.060385507458, 3017.09487153853, 3062.969370306313, 3098.7056229658147, 3127.62468503781, 3128.6402063762503, 989.5794287427815, 994.6419289055934, 995.9004099589984, 1011.9392836429838, 1012.5392946209457, 795.3994733975811, 809.3889113719105, 809.7813590330578, 816.2775943290231, 819.2544784246307, 4396.60430561251, 4433.423654924839, 4509.481409637868, 4569.109023740405, 4579.496255411902, 535.7883635963773, 539.1077766296785, 540.7566595032251, 547.9205515200274, 549.8966453316082, 3081.7842751007215, 3105.1616063662686, 3127.62468503781, 3249.3826173027524, 3294.6540613235743, 7151.82120446993, 7327.45044121693, 7463.738769143054, 7507.399408047343, 7786.532808031423, 7738.032745906762, 7760.456768026297, 7760.68957241704, 7765.53406795594, 7767.417443691746, 6005.6396616203165, 6025.758969641165, 6101.694915254219, 6109.175261339751, 6118.204633397719, 4584.541545845389, 4603.976980115078, 4642.164415391513, 4715.81136754526, 4908.435529914105, 7043.964780176271, 7108.609026503592, 7126.28737126304, 7139.0, 7170.641467926687, 6996.405305549085, 7175.0, 7184.9640751795905, 7209.495335326476, 7220.1696804866015, 5277.076511610529, 5826.679532625577, 5912.73392697321, 5940.46535811779, 5942.286925568959, 5924.585279030426, 5961.910571341346, 6154.415330543591, 6230.563860529719, 6315.431611155018, 5718.628289161191, 5722.0, 5731.0, 5751.051076572318, 5870.765169393177, 5639.182318563868, 5680.943190568041, 5720.0, 5732.369439361583, 5802.94197058024, 4961.330220420197, 5167.405748338839, 5171.301874247079, 5215.087359712111, 5218.608604354613, 4089.7750623715983, 4144.295469770086, 4146.543880173118, 4157.230912281238, 4172.0, 4190.832366705297, 4218.156368726329, 4224.535301116936, 4318.136372725405, 4395.450568678915], "value": 3579.4531964927205, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [359.4051844197852, 366.4704501994619, 366.9761465504742, 375.51370974587905, 380.2091649369312, 4880.609551235902, 4890.462049174593, 4910.926336104962, 4921.606271498281, 4966.503349665036, 4819.867331177171, 4849.393825771778, 4858.927116093261, 4865.270209468573, 4867.561919427251, 3337.9833100834585, 3683.502727131843, 3842.3275926712854, 3870.845166193349, 3898.3957486589484, 3863.130795571002, 3866.911867591511, 3878.398848178537, 3892.5134358205223, 3905.5508616509037, 3833.2333533293313, 3835.7314987950854, 3852.2873268445287, 3856.614338566149, 3877.8254978526033, 3755.9624403756025, 3829.5978922213044, 3885.9805700971315, 3887.0, 3895.8636447724475, 3523.6300188480095, 3533.505309256706, 3537.8231088445473, 3539.6549311261815, 3540.504329393887, 4769.928451073202, 4775.832845850413, 4783.952160478386, 4784.952150478485, 4819.228923372279, 4301.204277208726, 4530.478994915594, 4534.161180181677, 4535.5734681945005, 4541.682082254243, 5118.283440318359, 5159.14874045782, 5165.66423182492, 5172.793088276464, 5173.922391164136, 3902.2585708715537, 3913.1977944521304, 3923.6664883484937, 3926.960730392688, 3943.481759522576, 5157.149070403379, 5162.845114646567, 5168.328117344797, 5452.6183167178315, 5456.372517160537, 3956.9208615827524, 3970.10672598663, 3980.6664767303278, 4003.7797921114034, 4008.3386241269864, 4033.878983630496, 4043.2519983802504, 4053.128577355824, 4076.449679293317, 4108.342665173617, 4376.934345984812, 4442.6227869359955, 4496.392986946786, 4500.144972455223, 4507.639388848885, 5125.666831655931, 5141.4832624375895, 5170.457102004236, 5200.0, 5212.452692467312, 1309.0313168255423, 1309.9541516046893, 1311.9212847229196, 1314.618760559427, 1323.9338033098306, 932.2113739704804, 979.9167070798919, 981.018981018981, 981.283662926068, 990.5096976996433, 4389.604935555815, 4393.538678438782, 4402.9559704402545, 4403.339499075164, 4406.27296496081, 5092.9236061459105, 5110.948890511122, 5121.487851214849, 5125.564327032244, 5130.846074617767, 4205.5373908870615, 4378.176076430685, 4405.140997505519, 4415.779211039435, 4441.822327106879, 2707.851068191229, 2720.605512200759, 2721.8366897986184, 2726.9181924542295, 2731.4810186064583, 4788.11419887322, 4795.712257264575, 4807.807687692523, 4811.663183577116, 4816.349792778, 5001.449550639313, 5161.4322424533275, 5174.671397870973, 5191.90969896326, 5199.142141546678, 4787.784549695202, 4789.161896668069, 4791.185498465269, 4795.976020119947, 4819.903601928012, 5109.514596113363, 5114.616403769806, 5118.206677964921, 5121.359830021247, 5167.1474206755465, 4863.975680121577, 4949.0, 5022.815075442194, 5047.268146118866, 5052.166392545336, 4705.223638099676, 4794.904101917872, 4813.663043586916, 4815.566599006106, 4891.388576427947, 3949.3878448840474, 3958.1094253793817, 3984.7011474140136, 3999.580044095328, 4007.859724909614, 5229.50319719626, 5250.343707036621, 5256.448072952285, 5265.921011184912, 5267.815626453055, 4680.789364478538, 4936.333594964633, 4975.228839529878, 4984.2025275955675, 5002.274670172877, 4962.801487940442, 4965.641320372794, 4982.975085124551, 4997.475265097112, 4998.950010499849, 4867.878303042452, 4869.537393947569, 4892.804287828447, 4899.510048995072, 4926.433460151985, 4788.11419887322, 5023.442732752858, 5036.169032109661, 5044.4198917125, 5052.797888084436, 4943.737133491878, 4946.332245146859, 4950.1584730596605, 4952.504749525018, 4957.529034741694], "value": 3892.5085318372, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [645.6384424722153, 670.6043434373719, 708.5677736580685, 747.2751431111822, 749.7863109013932, 12536.874631253697, 13748.312584370766, 13806.79289810651, 13883.0, 13916.0, 13256.323163402212, 13573.660658483543, 13725.65685857854, 13757.174569525836, 13775.65560860979, 806.9515829050247, 813.9226773456542, 818.6766227340197, 818.7707441916243, 821.7124006597672, 806.2864365036955, 806.5402720449346, 807.2049031703797, 807.2855522862279, 807.6971135824066, 857.0187135729586, 858.356232825381, 859.1279850951258, 859.6518410043911, 859.6948083430386, 856.0326830681353, 857.2113655437013, 857.2713193785295, 857.6097875466647, 857.7255278310943, 626.9780557680505, 628.0798630007016, 628.4815027602247, 628.5160426471637, 628.8553632664513, 12367.567135150226, 12580.496780128784, 12633.93683031579, 12736.490540378374, 12748.2988435636, 11037.172212084046, 11137.164712646583, 11305.26515776472, 11380.487878045426, 11423.257488263236, 9781.217502599775, 9795.755106122333, 9798.069183427562, 9806.264530160266, 10093.646722364681, 3178.3484385700876, 3183.6657150999044, 3218.6459489456142, 3256.8045917244804, 3314.7016768490953, 59905.7004714978, 62100.06849897255, 62578.0, 62725.37274627241, 63142.0, 8298.253157215879, 8309.210624990616, 8454.661813527513, 8494.108118647453, 8534.914650853536, 17935.103244837705, 18167.545811354823, 18200.0, 18285.26858925628, 18370.540736481697, 6496.512761542903, 6626.801195964033, 6643.767468138689, 6694.297098804555, 6804.183497980274, 3332.433486307285, 3445.9483107753404, 3455.585329760445, 3471.1322169457635, 3492.7555071145284, 2737.671479422442, 2811.831290122599, 2836.517791975369, 2869.0675530452268, 2876.180288617734, 450.1559575795384, 451.6499712722601, 454.543184099984, 455.97948092335923, 459.67592847042755, 565.8330792416247, 579.3569138256532, 595.7408527290643, 603.4719620332122, 611.5688439650036, 8233.217844304781, 8361.407963531325, 8451.53516556583, 8527.232549070613, 8538.530380829114, 576.8327185116353, 592.4579010205699, 597.2057163971907, 603.8399824046631, 608.9573729838869, 4109.376796165498, 4246.214450326699, 4283.571642835692, 4292.205941900758, 4402.625776808943, 64829.35170648328, 66913.66543167351, 67536.6623166881, 68641.31358686449, 69408.3059169412, 58144.418555814744, 58222.41777582255, 58799.70600146972, 60662.69668651628, 61185.38814611886, 50978.745106274975, 51092.978140436986, 51210.23184652233, 51477.7426112867, 52090.739546302786, 7531.27266585193, 7976.401769867167, 8092.757217283491, 8219.178082191733, 8237.711680091168, 32949.67050329466, 33574.32851343008, 34402.48396274108, 34422.48366274458, 35578.644213557534, 45396.773016134706, 45640.771796140805, 45768.313475298564, 45770.54229457796, 47895.52104478911, 8652.826943461221, 8748.343874209333, 8769.824603508021, 8874.911250887408, 8875.911240887508, 10415.427151506437, 10469.31949423285, 10484.318519296221, 10710.250282480152, 10733.677989660322, 9691.563879625293, 9751.414915105117, 9991.900080999389, 10042.397456152654, 10086.243531735296, 10096.0, 10112.646057387956, 10433.739156521147, 10449.320794148356, 10501.422421766876, 9530.714078577654, 9637.18083962871, 9694.75763105928, 10073.647422340184, 10104.292699511258, 8415.579221039046, 8820.86768698483, 8860.867086993829, 8949.373543851867, 9046.773830654287, 8280.171982801672, 8330.750077497685, 8454.16734829452, 8484.787880302794, 8623.180797824196], "value": 6018.620719639064, "unit": "score"}]}, {"extraOptions": [], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1560.1, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 117.0, 116.0, 117.0, 116.0, 116.0, 116.0, 116.0, 117.0, 117.0], "value": 116.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [157.0, 131.0, 126.0, 177.0, 128.0, 126.0, 126.0, 129.0, 153.0, 127.0], "value": 138.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 162.0, 163.0, 161.0, 161.0, 163.0, 161.0, 162.0, 161.0, 162.0], "value": 161.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 77.0, 76.0, 100.0, 76.0, 76.0, 85.0, 78.0, 91.0, 77.0], "value": 81.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 84.0, 105.0, 83.0, 83.0, 84.0, 97.0, 83.0, 84.0, 111.0], "value": 89.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0], "value": 117.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 148.0, 150.0, 150.0, 150.0, 149.0, 149.0, 150.0, 149.0, 149.0], "value": 149.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 96.0, 95.0, 95.0, 96.0, 97.0, 95.0, 95.0, 96.0, 95.0], "value": 95.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 61.0, 61.0, 61.0, 62.0, 62.0, 63.0, 62.0, 63.0, 63.0], "value": 61.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 68.0, 67.0, 67.0, 67.0, 67.0, 67.0, 67.0, 68.0, 69.0], "value": 67.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 86.0, 91.0, 86.0, 84.0, 87.0, 85.0, 92.0, 91.0, 93.0], "value": 88.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [141.0, 133.0, 139.0, 134.0, 139.0, 146.0, 141.0, 131.0, 219.0, 154.0], "value": 147.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [176.0, 176.0, 174.0, 178.0, 181.0, 184.0, 178.0, 179.0, 174.0, 182.0], "value": 178.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 71.0, 67.0, 67.0, 68.0, 67.0, 66.0, 67.0, 71.0, 67.0], "value": 68.1, "unit": "score"}]}]} 16:15:02 INFO - Return code: 0 16:15:02 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 16:15:02 ERROR - # TBPL SUCCESS # 16:15:02 INFO - Running post-action listener: _resource_record_post_action 16:15:02 INFO - [mozharness: 2017-01-31 00:15:02.140941Z] Finished run-tests step (success) 16:15:02 INFO - Running post-run listener: _resource_record_post_run 16:15:02 INFO - Total resource usage - Wall time: 1204s; CPU: 13.0%; Read bytes: 4096; Write bytes: 398196736; Read time: 12; Write time: 975336 16:15:02 INFO - TinderboxPrint: CPU usage
13.2% 16:15:02 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 16:15:02 INFO - TinderboxPrint: I/O write bytes / time
398,196,736 / 975,336 16:15:02 INFO - TinderboxPrint: CPU idle
8,343.5 (86.8%) 16:15:02 INFO - TinderboxPrint: CPU user
1,214.0 (12.6%) 16:15:02 INFO - TinderboxPrint: Swap in / out
0 / 0 16:15:02 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 104108032; Read time: 0; Write time: 231684 16:15:02 INFO - run-tests - Wall time: 1188s; CPU: 13.0%; Read bytes: 0; Write bytes: 294088704; Read time: 0; Write time: 743652 16:15:02 INFO - Running post-run listener: _upload_blobber_files 16:15:02 INFO - Blob upload gear active. 16:15:02 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 16:15:02 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 16:15:02 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'] 16:15:02 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 16:15:03 INFO - (blobuploader) - INFO - Open directory for files ... 16:15:03 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 16:15:03 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:15:03 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:15:03 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 16:15:03 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:15:03 INFO - (blobuploader) - INFO - Done attempting. 16:15:03 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 16:15:03 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:15:03 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:15:07 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 16:15:07 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:15:07 INFO - (blobuploader) - INFO - Done attempting. 16:15:07 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 16:15:07 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:15:07 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:15:08 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 16:15:08 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:15:08 INFO - (blobuploader) - INFO - Done attempting. 16:15:08 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 16:15:08 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:15:08 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:15:09 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 16:15:09 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:15:09 INFO - (blobuploader) - INFO - Done attempting. 16:15:09 INFO - (blobuploader) - INFO - Iteration through files over. 16:15:09 INFO - Return code: 0 16:15:09 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 16:15:09 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 16:15:09 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/40c8cdc56df4d3fd423f3993303f530534481251cdb71b16f56804d9937220fa773754b25e70f1c86cb5d387a3544657632fe94909b1b4af0c49ba94f7ccdaa9", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/269e6cd4f5a0fb743bd797ca4aaa22dfc3e964912ea4e5196618e100b8054bb79276923bd3a87b1cb98879eb615e0b8362d4432ed23d25d0c05c8819fbf8fbdb", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/73849a54c14971db7eeb5da563a702dc2fb85e4a06cd88ac21171f163738ad7b316ab2145c8f577178d8d9e5b438cf2f8980b1c351ef16528c0e0deebc6d09e9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/8888c7eba44ae43d92f601575c6d765b38938f6f110cffb2ac30a7bfc2faa9aef2164ca3902c37ef5fae9d822a2b71cafe1a99dbe78662313dcd94bc826ca154"} 16:15:09 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 16:15:09 INFO - Writing to file /builds/slave/test/properties/blobber_files 16:15:09 INFO - Contents: 16:15:09 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/40c8cdc56df4d3fd423f3993303f530534481251cdb71b16f56804d9937220fa773754b25e70f1c86cb5d387a3544657632fe94909b1b4af0c49ba94f7ccdaa9", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/269e6cd4f5a0fb743bd797ca4aaa22dfc3e964912ea4e5196618e100b8054bb79276923bd3a87b1cb98879eb615e0b8362d4432ed23d25d0c05c8819fbf8fbdb", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/73849a54c14971db7eeb5da563a702dc2fb85e4a06cd88ac21171f163738ad7b316ab2145c8f577178d8d9e5b438cf2f8980b1c351ef16528c0e0deebc6d09e9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/8888c7eba44ae43d92f601575c6d765b38938f6f110cffb2ac30a7bfc2faa9aef2164ca3902c37ef5fae9d822a2b71cafe1a99dbe78662313dcd94bc826ca154"} 16:15:09 INFO - Running post-run listener: copy_logs_to_upload_dir 16:15:09 INFO - Copying logs to upload dir... 16:15:09 INFO - mkdir: /builds/slave/test/build/upload/logs 16:15:09 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1250.064994 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 50 secs) (at 2017-01-30 16:15:08.906358) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-30 16:15:08.909986) ========= 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=8783db0840cc980e80bb0bd400000236-1485820457.517632-1028014260 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/40c8cdc56df4d3fd423f3993303f530534481251cdb71b16f56804d9937220fa773754b25e70f1c86cb5d387a3544657632fe94909b1b4af0c49ba94f7ccdaa9", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/269e6cd4f5a0fb743bd797ca4aaa22dfc3e964912ea4e5196618e100b8054bb79276923bd3a87b1cb98879eb615e0b8362d4432ed23d25d0c05c8819fbf8fbdb", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/73849a54c14971db7eeb5da563a702dc2fb85e4a06cd88ac21171f163738ad7b316ab2145c8f577178d8d9e5b438cf2f8980b1c351ef16528c0e0deebc6d09e9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/8888c7eba44ae43d92f601575c6d765b38938f6f110cffb2ac30a7bfc2faa9aef2164ca3902c37ef5fae9d822a2b71cafe1a99dbe78662313dcd94bc826ca154"} build_url:https://queue.taskcluster.net/v1/task/Z0S85dxfR2iS3fUBT4Foww/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011239 build_url: 'https://queue.taskcluster.net/v1/task/Z0S85dxfR2iS3fUBT4Foww/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/40c8cdc56df4d3fd423f3993303f530534481251cdb71b16f56804d9937220fa773754b25e70f1c86cb5d387a3544657632fe94909b1b4af0c49ba94f7ccdaa9", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/269e6cd4f5a0fb743bd797ca4aaa22dfc3e964912ea4e5196618e100b8054bb79276923bd3a87b1cb98879eb615e0b8362d4432ed23d25d0c05c8819fbf8fbdb", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/73849a54c14971db7eeb5da563a702dc2fb85e4a06cd88ac21171f163738ad7b316ab2145c8f577178d8d9e5b438cf2f8980b1c351ef16528c0e0deebc6d09e9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/8888c7eba44ae43d92f601575c6d765b38938f6f110cffb2ac30a7bfc2faa9aef2164ca3902c37ef5fae9d822a2b71cafe1a99dbe78662313dcd94bc826ca154"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-30 16:15:08.934382) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-30 16:15:08.934707) ========= 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=8783db0840cc980e80bb0bd400000236-1485820457.517632-1028014260 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004482 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-30 16:15:09.017532) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-30 16:15:09.017848) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-30 16:15:09.018133) ========= ========= Total master_lag: 0.17 =========