builder: mozilla-central_ubuntu64_hw_test-dromaeojs-stylo-disabled-e10s slave: talos-linux64-ix-015 starttime: 1505381486.1 results: success (0) revision: 6266decf217d4da5a18115cb5b1ff70feb76e7a5 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-09-14 02:31:26.098501) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-09-14 02:31:26.099012) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-14 02:31:26.099288) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-14 02:31:26.342312) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-14 02:31:26.342566) ========= 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=20e666a3d4cfbb71505a330e000001b4-1505377061.210318-221390492 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-09-14 02:31:27-- 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% 220M=0s 2017-09-14 02:31:27 (220 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.080366 ========= master_lag: 0.06 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-14 02:31:26.481076) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-14 02:31:26.484999) ========= 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=20e666a3d4cfbb71505a330e000001b4-1505377061.210318-221390492 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019404 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-14 02:31:26.535223) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-14 02:31:26.535517) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 6266decf217d4da5a18115cb5b1ff70feb76e7a5 --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 6266decf217d4da5a18115cb5b1ff70feb76e7a5 --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=20e666a3d4cfbb71505a330e000001b4-1505377061.210318-221390492 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-09-14 02:31:27,383 truncating revision to first 12 chars 2017-09-14 02:31:27,383 Setting DEBUG logging. 2017-09-14 02:31:27,383 attempt 1/10 2017-09-14 02:31:27,383 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/6266decf217d?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-09-14 02:31:27,651 unpacking tar archive at: mozilla-central-6266decf217d/testing/mozharness/ program finished with exit code 0 elapsedTime=0.537180 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-14 02:31:27.103556) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-14 02:31:27.106930) ========= script_repo_revision: 6266decf217d4da5a18115cb5b1ff70feb76e7a5 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-14 02:31:27.107311) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-14 02:31:27.107586) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-14 02:31:27.130348) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 42 secs) (at 2017-09-14 02:31:27.131707) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-stylo-disabled-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-stylo-disabled-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=20e666a3d4cfbb71505a330e000001b4-1505377061.210318-221390492 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 02:31:28 INFO - MultiFileLogger online at 20170914 02:31:28 in /builds/slave/test 02:31:28 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-stylo-disabled-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 02:31:28 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 02:31:28 INFO - {'append_to_log': False, 02:31:28 INFO - 'base_work_dir': '/builds/slave/test', 02:31:28 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 02:31:28 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 02:31:28 INFO - 'branch': 'Firefox-Non-PGO', 02:31:28 INFO - 'buildbot_json_path': 'buildprops.json', 02:31:28 INFO - 'code_coverage': False, 02:31:28 INFO - 'config_files': ('talos/linux_config.py',), 02:31:28 INFO - 'default_actions': ('clobber', 02:31:28 INFO - 'read-buildbot-config', 02:31:28 INFO - 'download-and-extract', 02:31:28 INFO - 'populate-webroot', 02:31:28 INFO - 'create-virtualenv', 02:31:28 INFO - 'install', 02:31:28 INFO - 'setup-mitmproxy', 02:31:28 INFO - 'run-tests'), 02:31:28 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 02:31:28 INFO - 'disable_ccov_upload': False, 02:31:28 INFO - 'disable_stylo': False, 02:31:28 INFO - 'download_minidump_stackwalk': True, 02:31:28 INFO - 'download_symbols': 'ondemand', 02:31:28 INFO - 'enable_stylo': False, 02:31:28 INFO - 'enable_webrender': False, 02:31:28 INFO - 'exes': {'tooltool.py': '/tools/tooltool.py'}, 02:31:28 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 02:31:28 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 02:31:28 INFO - 'gecko_profile': False, 02:31:28 INFO - 'gecko_profile_interval': 0, 02:31:28 INFO - 'installer_path': 'installer.exe', 02:31:28 INFO - 'log_level': 'info', 02:31:28 INFO - 'log_name': 'talos', 02:31:28 INFO - 'log_to_console': True, 02:31:28 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 02:31:28 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 02:31:28 INFO - 'opt_config_files': (), 02:31:28 INFO - 'pip_index': False, 02:31:28 INFO - 'suite': 'dromaeojs-stylo-disabled-e10s', 02:31:28 INFO - 'system_bits': '32', 02:31:28 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 02:31:28 INFO - 'title': 'talos-linux64-ix-015', 02:31:28 INFO - 'tooltool_cache': '/builds/tooltool_cache', 02:31:28 INFO - 'use_talos_json': True, 02:31:28 INFO - 'verify': 'False', 02:31:28 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 02:31:28 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 02:31:28 INFO - 'work_dir': 'build'} 02:31:28 INFO - [mozharness: 2017-09-14 09:31:28.113715Z] Running clobber step. 02:31:28 INFO - Running pre-action listener: _resource_record_pre_action 02:31:28 INFO - Running main action method: clobber 02:31:28 INFO - rmtree: /builds/slave/test/build 02:31:28 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 02:31:29 INFO - Running post-action listener: _resource_record_post_action 02:31:29 INFO - [mozharness: 2017-09-14 09:31:29.616843Z] Finished clobber step (success) 02:31:29 INFO - [mozharness: 2017-09-14 09:31:29.616941Z] Running read-buildbot-config step. 02:31:29 INFO - Running pre-action listener: _resource_record_pre_action 02:31:29 INFO - Running main action method: read_buildbot_config 02:31:29 INFO - Using buildbot properties: 02:31:29 INFO - { 02:31:29 INFO - "project": "", 02:31:29 INFO - "product": "firefox", 02:31:29 INFO - "who": "archaeopteryx@coole-files.de", 02:31:29 INFO - "installer_path": "public/build/target.tar.bz2", 02:31:29 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-stylo-disabled-e10s", 02:31:29 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 02:31:29 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-stylo-disabled-e10s", 02:31:29 INFO - "stage_platform": "linux64", 02:31:29 INFO - "basedir": "/builds/slave/test", 02:31:29 INFO - "buildnumber": 18, 02:31:29 INFO - "platform": "ubuntu64_hw", 02:31:29 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 02:31:29 INFO - "slavebuilddir": "test", 02:31:29 INFO - "taskId": "PwmCbtTuQSy-xh5ufhPqQg", 02:31:29 INFO - "branch": "mozilla-central", 02:31:29 INFO - "script_repo_revision": "production", 02:31:29 INFO - "revision": "6266decf217d4da5a18115cb5b1ff70feb76e7a5", 02:31:29 INFO - "slavename": "talos-linux64-ix-015", 02:31:29 INFO - "repo_path": "mozilla-central" 02:31:29 INFO - } 02:31:29 INFO - Finding installer, test and symbols from parent task. 02:31:29 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/PwmCbtTuQSy-xh5ufhPqQg'}, attempt #1 02:31:30 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/PwmCbtTuQSy-xh5ufhPqQg'}, attempt #1 02:31:30 INFO - Task dependencies: dyqypZ5BQ3uJrBBpjoZhjw 02:31:30 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/dyqypZ5BQ3uJrBBpjoZhjw'}, attempt #1 02:31:31 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/dyqypZ5BQ3uJrBBpjoZhjw/artifacts/public/build/target.tar.bz2 02:31:31 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/dyqypZ5BQ3uJrBBpjoZhjw/artifacts/public/build/target.test_packages.json 02:31:31 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/dyqypZ5BQ3uJrBBpjoZhjw/artifacts/public/build/target.crashreporter-symbols.zip 02:31:31 INFO - Running post-action listener: _resource_record_post_action 02:31:31 INFO - [mozharness: 2017-09-14 09:31:31.050235Z] Finished read-buildbot-config step (success) 02:31:31 INFO - [mozharness: 2017-09-14 09:31:31.050451Z] Running download-and-extract step. 02:31:31 INFO - Running pre-action listener: _resource_record_pre_action 02:31:31 INFO - Running main action method: download_and_extract 02:31:31 INFO - mkdir: /builds/slave/test/build/tests 02:31:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:31:31 INFO - trying https://queue.taskcluster.net/v1/task/dyqypZ5BQ3uJrBBpjoZhjw/artifacts/public/build/target.test_packages.json 02:31:31 INFO - Downloading https://queue.taskcluster.net/v1/task/dyqypZ5BQ3uJrBBpjoZhjw/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 02:31:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/dyqypZ5BQ3uJrBBpjoZhjw/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 02:31:31 INFO - Downloaded 989 bytes. 02:31:31 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 02:31:31 INFO - Using the following test package requirements: 02:31:31 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 02:31:31 INFO - u'common': [u'target.common.tests.zip'], 02:31:31 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 02:31:31 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 02:31:31 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 02:31:31 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 02:31:31 INFO - u'mozbase': [u'target.common.tests.zip'], 02:31:31 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 02:31:31 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 02:31:31 INFO - u'web-platform': [u'target.common.tests.zip', 02:31:31 INFO - u'target.web-platform.tests.tar.gz'], 02:31:31 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 02:31:31 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite categories: ['common', 'talos'] 02:31:31 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/dyqypZ5BQ3uJrBBpjoZhjw/artifacts/public/build/target.common.tests.zip 02:31:31 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/dyqypZ5BQ3uJrBBpjoZhjw/artifacts/public/build/target.common.tests.zip'}, attempt #1 02:31:31 INFO - Fetch https://queue.taskcluster.net/v1/task/dyqypZ5BQ3uJrBBpjoZhjw/artifacts/public/build/target.common.tests.zip into memory 02:31:32 INFO - Content-Length response header: 54588745 02:31:32 INFO - Bytes received: 54588745 02:31:43 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/dyqypZ5BQ3uJrBBpjoZhjw/artifacts/public/build/target.talos.tests.zip 02:31:43 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/dyqypZ5BQ3uJrBBpjoZhjw/artifacts/public/build/target.talos.tests.zip'}, attempt #1 02:31:43 INFO - Fetch https://queue.taskcluster.net/v1/task/dyqypZ5BQ3uJrBBpjoZhjw/artifacts/public/build/target.talos.tests.zip into memory 02:31:44 INFO - Content-Length response header: 14500356 02:31:44 INFO - Bytes received: 14500356 02:31:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:31:44 INFO - trying https://queue.taskcluster.net/v1/task/dyqypZ5BQ3uJrBBpjoZhjw/artifacts/public/build/target.tar.bz2 02:31:44 INFO - Downloading https://queue.taskcluster.net/v1/task/dyqypZ5BQ3uJrBBpjoZhjw/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 02:31:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/dyqypZ5BQ3uJrBBpjoZhjw/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 02:31:48 INFO - Downloaded 61444046 bytes. 02:31:48 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/dyqypZ5BQ3uJrBBpjoZhjw/artifacts/public/build/target.tar.bz2 02:31:48 INFO - mkdir: /builds/slave/test/properties 02:31:48 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 02:31:48 INFO - Writing to file /builds/slave/test/properties/build_url 02:31:48 INFO - Contents: 02:31:48 INFO - build_url:https://queue.taskcluster.net/v1/task/dyqypZ5BQ3uJrBBpjoZhjw/artifacts/public/build/target.tar.bz2 02:31:48 INFO - Running post-action listener: _resource_record_post_action 02:31:48 INFO - Running post-action listener: find_tests_for_verification 02:31:48 INFO - Running post-action listener: set_extra_try_arguments 02:31:48 INFO - [mozharness: 2017-09-14 09:31:48.046847Z] Finished download-and-extract step (success) 02:31:48 INFO - [mozharness: 2017-09-14 09:31:48.046943Z] Running populate-webroot step. 02:31:48 INFO - Running pre-action listener: _resource_record_pre_action 02:31:48 INFO - Running main action method: populate_webroot 02:31:48 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 02:31:48 INFO - 'chromez-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 02:31:48 INFO - 'tests': ['tresize', 02:31:48 INFO - 'tcanvasmark']}, 02:31:48 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 02:31:48 INFO - 'dromaeojs-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 02:31:48 INFO - 'tests': ['dromaeo_css', 02:31:48 INFO - 'kraken']}, 02:31:48 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 02:31:48 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:31:48 INFO - 'g1-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 02:31:48 INFO - 'talos_options': ['--disable-stylo'], 02:31:48 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:31:48 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 02:31:48 INFO - 'tests': ['damp', 'tps']}, 02:31:48 INFO - 'g2-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 02:31:48 INFO - 'talos_options': ['--disable-stylo'], 02:31:48 INFO - 'tests': ['damp', 'tps']}, 02:31:48 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 02:31:48 INFO - 'g3-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 02:31:48 INFO - 'tests': ['dromaeo_dom']}, 02:31:48 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 02:31:48 INFO - 'g4-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 02:31:48 INFO - 'tests': ['basic_compositor_video', 02:31:48 INFO - 'glvideo']}, 02:31:48 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 02:31:48 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 02:31:48 INFO - 'g5-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 02:31:48 INFO - 'talos_options': ['--disable-stylo'], 02:31:48 INFO - 'tests': ['ts_paint_webext', 02:31:48 INFO - 'tp5o_webext']}, 02:31:48 INFO - 'other-e10s': {'tests': ['a11yr', 02:31:48 INFO - 'ts_paint', 02:31:48 INFO - 'tpaint', 02:31:48 INFO - 'sessionrestore', 02:31:48 INFO - 'sessionrestore_many_windows', 02:31:48 INFO - 'sessionrestore_no_auto_restore', 02:31:48 INFO - 'tabpaint']}, 02:31:48 INFO - 'other-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 02:31:48 INFO - 'tests': ['a11yr', 02:31:48 INFO - 'ts_paint', 02:31:48 INFO - 'tpaint', 02:31:48 INFO - 'sessionrestore', 02:31:48 INFO - 'sessionrestore_many_windows', 02:31:48 INFO - 'sessionrestore_no_auto_restore', 02:31:48 INFO - 'tabpaint']}, 02:31:48 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 02:31:48 INFO - 'perf-reftest-singletons-e10s': {'tests': ['bloom_basic_singleton']}, 02:31:48 INFO - 'perf-reftest-singletons-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 02:31:48 INFO - 'tests': ['bloom_basic_singleton']}, 02:31:48 INFO - 'perf-reftest-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 02:31:48 INFO - 'tests': ['bloom_basic']}, 02:31:48 INFO - 'svgr-e10s': {'tests': ['tsvgx', 02:31:48 INFO - 'tsvgr_opacity', 02:31:48 INFO - 'tart', 02:31:48 INFO - 'tscrollx', 02:31:48 INFO - 'tsvg_static']}, 02:31:48 INFO - 'svgr-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 02:31:48 INFO - 'tests': ['tsvgx', 02:31:48 INFO - 'tsvgr_opacity', 02:31:48 INFO - 'tart', 02:31:48 INFO - 'tscrollx', 02:31:48 INFO - 'tsvg_static']}, 02:31:48 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 02:31:48 INFO - 'tp5o-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 02:31:48 INFO - 'talos_options': ['--disable-stylo'], 02:31:48 INFO - 'tests': ['tp5o']}, 02:31:48 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 02:31:48 INFO - 'talos_options': ['--mitmproxy', 02:31:48 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 02:31:48 INFO - '--firstNonBlankPaint'], 02:31:48 INFO - 'tests': ['tp6_google', 02:31:48 INFO - 'tp6_youtube', 02:31:48 INFO - 'tp6_amazon', 02:31:48 INFO - 'tp6_facebook']}, 02:31:48 INFO - 'tp6-stylo-disabled-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 02:31:48 INFO - 'talos_options': ['--disable-stylo', 02:31:48 INFO - '--mitmproxy', 02:31:48 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 02:31:48 INFO - '--firstNonBlankPaint'], 02:31:48 INFO - 'tests': ['tp6_google', 02:31:48 INFO - 'tp6_youtube', 02:31:48 INFO - 'tp6_amazon', 02:31:48 INFO - 'tp6_facebook']}, 02:31:48 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 02:31:48 INFO - 'talos_options': ['--stylo-threads=1', 02:31:48 INFO - '--mitmproxy', 02:31:48 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 02:31:48 INFO - '--firstNonBlankPaint'], 02:31:48 INFO - 'tests': ['tp6_google', 02:31:48 INFO - 'tp6_youtube', 02:31:48 INFO - 'tp6_amazon', 02:31:48 INFO - 'tp6_facebook']}, 02:31:48 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 02:31:48 INFO - 'talos_options': ['--xperf_path', 02:31:48 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:31:48 INFO - 'tests': ['tp5n']}, 02:31:48 INFO - 'xperf-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 02:31:48 INFO - 'talos_options': ['--disable-stylo', 02:31:48 INFO - '--xperf_path', 02:31:48 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:31:48 INFO - 'tests': ['tp5n']}}} 02:31:48 INFO - Running post-action listener: _resource_record_post_action 02:31:48 INFO - [mozharness: 2017-09-14 09:31:48.061919Z] Finished populate-webroot step (success) 02:31:48 INFO - [mozharness: 2017-09-14 09:31:48.062008Z] Running create-virtualenv step. 02:31:48 INFO - Running pre-action listener: _resource_record_pre_action 02:31:48 INFO - Running main action method: create_virtualenv 02:31:48 INFO - Creating virtualenv /builds/slave/test/build/venv 02:31:48 INFO - Running command: ['virtualenv', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 02:31:48 INFO - Copy/paste: virtualenv --no-site-packages --distribute /builds/slave/test/build/venv 02:31:48 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 02:31:48 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 02:31:48 INFO - New python executable in /builds/slave/test/build/venv/bin/python 02:31:48 INFO - Installing distribute.............................................................................................................................................................................................done. 02:31:48 INFO - Installing pip...............done. 02:31:48 INFO - Return code: 0 02:31:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 02:31:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 02:31:49 INFO - Reading from file tmpfile_stdout 02:31:49 INFO - Output received: 02:31:49 INFO - pip 1.1 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.1-py2.7.egg (python 2.7) 02:31:49 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 02:31:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:31:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:31:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:31:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:31:49 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28ac1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a75a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c18a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c1c090>, '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 0x2c1cd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c16f90>, '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': '20e666a3d4cfbb71505a330e000001b4-1505377061.210318-221390492', '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 02:31:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 02:31:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 02:31:49 INFO - Using env: {'DISPLAY': ':0', 02:31:49 INFO - 'HOME': '/home/cltbld', 02:31:49 INFO - 'LANG': 'en_US.UTF-8', 02:31:49 INFO - 'LANGUAGE': 'en_US:en', 02:31:49 INFO - 'LOGNAME': 'cltbld', 02:31:49 INFO - 'MAIL': '/var/mail/cltbld', 02:31:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:31:49 INFO - 'MOZ_NO_REMOTE': '1', 02:31:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:31:49 INFO - 'NO_EM_RESTART': '1', 02:31:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:31:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:31:49 INFO - 'PWD': '/builds/slave/test', 02:31:49 INFO - 'SHELL': '/bin/bash', 02:31:49 INFO - 'SHLVL': '1', 02:31:49 INFO - 'TERM': 'linux', 02:31:49 INFO - 'TMOUT': '86400', 02:31:49 INFO - 'USER': 'cltbld', 02:31:49 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1505377061.210318-221390492', 02:31:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:31:49 INFO - '_': '/tools/buildbot/bin/python'} 02:31:50 INFO - Ignoring indexes: http://pypi.python.org/simple/ 02:31:50 INFO - Downloading/unpacking pip>=1.5 02:31:50 INFO - Running setup.py egg_info for package pip 02:31:50 INFO - warning: no files found matching 'pip/cacert.pem' 02:31:50 INFO - warning: no files found matching '*.html' under directory 'docs' 02:31:50 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 02:31:50 INFO - no previously-included directories found matching 'docs/_build/_sources' 02:31:50 INFO - Installing collected packages: pip 02:31:50 INFO - Found existing installation: pip 1.1 02:31:50 INFO - Uninstalling pip: 02:31:50 INFO - Successfully uninstalled pip 02:31:50 INFO - Running setup.py install for pip 02:31:50 INFO - warning: no files found matching 'pip/cacert.pem' 02:31:50 INFO - warning: no files found matching '*.html' under directory 'docs' 02:31:50 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 02:31:50 INFO - no previously-included directories found matching 'docs/_build/_sources' 02:31:50 INFO - Installing pip script to /builds/slave/test/build/venv/bin 02:31:50 INFO - Installing pip2.7 script to /builds/slave/test/build/venv/bin 02:31:50 INFO - Installing pip2 script to /builds/slave/test/build/venv/bin 02:31:50 INFO - Successfully installed pip 02:31:50 INFO - Cleaning up... 02:31:50 INFO - Return code: 0 02:31:50 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 02:31:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:31:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:31:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:31:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:31:50 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28ac1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a75a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c18a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c1c090>, '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 0x2c1cd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c16f90>, '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': '20e666a3d4cfbb71505a330e000001b4-1505377061.210318-221390492', '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 02:31:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 02:31:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 02:31:50 INFO - Using env: {'DISPLAY': ':0', 02:31:50 INFO - 'HOME': '/home/cltbld', 02:31:50 INFO - 'LANG': 'en_US.UTF-8', 02:31:50 INFO - 'LANGUAGE': 'en_US:en', 02:31:50 INFO - 'LOGNAME': 'cltbld', 02:31:50 INFO - 'MAIL': '/var/mail/cltbld', 02:31:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:31:50 INFO - 'MOZ_NO_REMOTE': '1', 02:31:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:31:50 INFO - 'NO_EM_RESTART': '1', 02:31:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:31:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:31:50 INFO - 'PWD': '/builds/slave/test', 02:31:50 INFO - 'SHELL': '/bin/bash', 02:31:50 INFO - 'SHLVL': '1', 02:31:50 INFO - 'TERM': 'linux', 02:31:50 INFO - 'TMOUT': '86400', 02:31:50 INFO - 'USER': 'cltbld', 02:31:50 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1505377061.210318-221390492', 02:31:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:31:50 INFO - '_': '/tools/buildbot/bin/python'} 02:31:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:31:50 INFO - Downloading/unpacking psutil>=3.1.1 02:31:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:31:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:31:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:31:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:31:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 02:31:51 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:31:51 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:31:51 INFO - Installing collected packages: psutil 02:31:51 INFO - Running setup.py install for psutil 02:31:51 INFO - building 'psutil._psutil_linux' extension 02:31:51 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 02:31:51 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 02:31:51 INFO - building 'psutil._psutil_posix' extension 02:31:51 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 02:31:52 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 02:31:52 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:31:52 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:31:52 INFO - Successfully installed psutil 02:31:52 INFO - Cleaning up... 02:31:52 INFO - Return code: 0 02:31:52 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 02:31:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:31:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:31:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:31:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:31:52 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28ac1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a75a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c18a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c1c090>, '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 0x2c1cd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c16f90>, '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': '20e666a3d4cfbb71505a330e000001b4-1505377061.210318-221390492', '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 02:31:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 02:31:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 02:31:52 INFO - Using env: {'DISPLAY': ':0', 02:31:52 INFO - 'HOME': '/home/cltbld', 02:31:52 INFO - 'LANG': 'en_US.UTF-8', 02:31:52 INFO - 'LANGUAGE': 'en_US:en', 02:31:52 INFO - 'LOGNAME': 'cltbld', 02:31:52 INFO - 'MAIL': '/var/mail/cltbld', 02:31:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:31:52 INFO - 'MOZ_NO_REMOTE': '1', 02:31:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:31:52 INFO - 'NO_EM_RESTART': '1', 02:31:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:31:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:31:52 INFO - 'PWD': '/builds/slave/test', 02:31:52 INFO - 'SHELL': '/bin/bash', 02:31:52 INFO - 'SHLVL': '1', 02:31:52 INFO - 'TERM': 'linux', 02:31:52 INFO - 'TMOUT': '86400', 02:31:52 INFO - 'USER': 'cltbld', 02:31:52 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1505377061.210318-221390492', 02:31:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:31:52 INFO - '_': '/tools/buildbot/bin/python'} 02:31:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:31:52 INFO - Downloading/unpacking mozsystemmonitor==0.3 02:31:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:31:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:31:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:31:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:31:53 INFO - Downloading mozsystemmonitor-0.3.tar.gz 02:31:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 02:31:54 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 02:31:54 INFO - Installing collected packages: mozsystemmonitor 02:31:54 INFO - Running setup.py install for mozsystemmonitor 02:31:54 INFO - Successfully installed mozsystemmonitor 02:31:54 INFO - Cleaning up... 02:31:55 INFO - Return code: 0 02:31:55 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 02:31:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:31:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:31:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:31:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:31:55 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28ac1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a75a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c18a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c1c090>, '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 0x2c1cd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c16f90>, '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': '20e666a3d4cfbb71505a330e000001b4-1505377061.210318-221390492', '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 02:31:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 02:31:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 02:31:55 INFO - Using env: {'DISPLAY': ':0', 02:31:55 INFO - 'HOME': '/home/cltbld', 02:31:55 INFO - 'LANG': 'en_US.UTF-8', 02:31:55 INFO - 'LANGUAGE': 'en_US:en', 02:31:55 INFO - 'LOGNAME': 'cltbld', 02:31:55 INFO - 'MAIL': '/var/mail/cltbld', 02:31:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:31:55 INFO - 'MOZ_NO_REMOTE': '1', 02:31:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:31:55 INFO - 'NO_EM_RESTART': '1', 02:31:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:31:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:31:55 INFO - 'PWD': '/builds/slave/test', 02:31:55 INFO - 'SHELL': '/bin/bash', 02:31:55 INFO - 'SHLVL': '1', 02:31:55 INFO - 'TERM': 'linux', 02:31:55 INFO - 'TMOUT': '86400', 02:31:55 INFO - 'USER': 'cltbld', 02:31:55 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1505377061.210318-221390492', 02:31:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:31:55 INFO - '_': '/tools/buildbot/bin/python'} 02:31:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:31:55 INFO - Downloading/unpacking jsonschema==2.5.1 02:31:55 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 02:31:55 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 02:31:55 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 02:31:55 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 02:31:56 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 02:31:56 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 02:31:56 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 02:31:56 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 02:31:56 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 02:31:56 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 02:31:56 INFO - Downloading functools32-3.2.3-2.tar.gz 02:31:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 02:31:56 INFO - warning: no files found matching '*.txt' 02:31:56 INFO - no previously-included directories found matching 'build' 02:31:56 INFO - no previously-included directories found matching 'dist' 02:31:56 INFO - no previously-included directories found matching '.git*' 02:31:56 INFO - Installing collected packages: jsonschema, functools32 02:31:56 INFO - Running setup.py install for functools32 02:31:56 INFO - warning: no files found matching '*.txt' 02:31:56 INFO - no previously-included directories found matching 'build' 02:31:56 INFO - no previously-included directories found matching 'dist' 02:31:56 INFO - no previously-included directories found matching '.git*' 02:31:56 INFO - Successfully installed jsonschema functools32 02:31:56 INFO - Cleaning up... 02:31:56 INFO - Return code: 0 02:31:56 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 02:31:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:31:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:31:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:31:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:31:56 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28ac1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a75a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c18a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c1c090>, '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 0x2c1cd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c16f90>, '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': '20e666a3d4cfbb71505a330e000001b4-1505377061.210318-221390492', '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 02:31:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 02:31:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 02:31:56 INFO - Using env: {'DISPLAY': ':0', 02:31:56 INFO - 'HOME': '/home/cltbld', 02:31:56 INFO - 'LANG': 'en_US.UTF-8', 02:31:56 INFO - 'LANGUAGE': 'en_US:en', 02:31:56 INFO - 'LOGNAME': 'cltbld', 02:31:56 INFO - 'MAIL': '/var/mail/cltbld', 02:31:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:31:56 INFO - 'MOZ_NO_REMOTE': '1', 02:31:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:31:56 INFO - 'NO_EM_RESTART': '1', 02:31:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:31:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:31:56 INFO - 'PWD': '/builds/slave/test', 02:31:56 INFO - 'SHELL': '/bin/bash', 02:31:56 INFO - 'SHLVL': '1', 02:31:56 INFO - 'TERM': 'linux', 02:31:56 INFO - 'TMOUT': '86400', 02:31:56 INFO - 'USER': 'cltbld', 02:31:56 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1505377061.210318-221390492', 02:31:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:31:56 INFO - '_': '/tools/buildbot/bin/python'} 02:31:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:31:57 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 02:31:57 INFO - Cleaning up... 02:31:57 INFO - Return code: 0 02:31:57 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 02:31:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:31:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:31:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:31:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:31: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/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 0x28ac1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a75a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c18a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c1c090>, '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 0x2c1cd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c16f90>, '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': '20e666a3d4cfbb71505a330e000001b4-1505377061.210318-221390492', '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 02:31:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 02:31:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 02:31:57 INFO - Using env: {'DISPLAY': ':0', 02:31:57 INFO - 'HOME': '/home/cltbld', 02:31:57 INFO - 'LANG': 'en_US.UTF-8', 02:31:57 INFO - 'LANGUAGE': 'en_US:en', 02:31:57 INFO - 'LOGNAME': 'cltbld', 02:31:57 INFO - 'MAIL': '/var/mail/cltbld', 02:31:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:31:57 INFO - 'MOZ_NO_REMOTE': '1', 02:31:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:31:57 INFO - 'NO_EM_RESTART': '1', 02:31:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:31:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:31:57 INFO - 'PWD': '/builds/slave/test', 02:31:57 INFO - 'SHELL': '/bin/bash', 02:31:57 INFO - 'SHLVL': '1', 02:31:57 INFO - 'TERM': 'linux', 02:31:57 INFO - 'TMOUT': '86400', 02:31:57 INFO - 'USER': 'cltbld', 02:31:57 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1505377061.210318-221390492', 02:31:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:31:57 INFO - '_': '/tools/buildbot/bin/python'} 02:31:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:31:57 INFO - Downloading/unpacking blobuploader==1.2.4 02:31:57 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 02:31:57 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 02:31:57 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 02:31:57 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 02:31:58 INFO - Downloading blobuploader-1.2.4.tar.gz 02:31:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 02:31:58 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 02:31:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:31:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:31:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:31:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:31:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 02:31:58 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 02:31:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:31:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:31:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:31:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:31:58 INFO - Downloading docopt-0.6.1.tar.gz 02:31:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 02:31:59 INFO - Installing collected packages: blobuploader, requests, docopt 02:31:59 INFO - Running setup.py install for blobuploader 02:31:59 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 02:31:59 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 02:31:59 INFO - Running setup.py install for requests 02:31:59 INFO - Running setup.py install for docopt 02:31:59 INFO - Successfully installed blobuploader requests docopt 02:31:59 INFO - Cleaning up... 02:31:59 INFO - Return code: 0 02:31:59 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:31:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:31:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:31:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:31:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:31:59 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28ac1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a75a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c18a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c1c090>, '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 0x2c1cd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c16f90>, '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': '20e666a3d4cfbb71505a330e000001b4-1505377061.210318-221390492', '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 02:31:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 02:31:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 02:31:59 INFO - Using env: {'DISPLAY': ':0', 02:31:59 INFO - 'HOME': '/home/cltbld', 02:31:59 INFO - 'LANG': 'en_US.UTF-8', 02:31:59 INFO - 'LANGUAGE': 'en_US:en', 02:31:59 INFO - 'LOGNAME': 'cltbld', 02:31:59 INFO - 'MAIL': '/var/mail/cltbld', 02:31:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:31:59 INFO - 'MOZ_NO_REMOTE': '1', 02:31:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:31:59 INFO - 'NO_EM_RESTART': '1', 02:31:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:31:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:31:59 INFO - 'PWD': '/builds/slave/test', 02:31:59 INFO - 'SHELL': '/bin/bash', 02:31:59 INFO - 'SHLVL': '1', 02:31:59 INFO - 'TERM': 'linux', 02:31:59 INFO - 'TMOUT': '86400', 02:31:59 INFO - 'USER': 'cltbld', 02:31:59 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1505377061.210318-221390492', 02:31:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:31:59 INFO - '_': '/tools/buildbot/bin/python'} 02:31:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:31:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:31:59 INFO - Running setup.py (path:/tmp/pip-Pz2ihy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:31:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:31:59 INFO - Running setup.py (path:/tmp/pip-75VCbm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:31:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:31:59 INFO - Running setup.py (path:/tmp/pip-wm_Aou-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:32:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:32:00 INFO - Running setup.py (path:/tmp/pip-Hq4in1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:32:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:32:00 INFO - Running setup.py (path:/tmp/pip-EXLFYI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:32:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:32:00 INFO - Running setup.py (path:/tmp/pip-AmNY6A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:32:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:32:00 INFO - Running setup.py (path:/tmp/pip-Nud2vj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:32:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:32:00 INFO - Running setup.py (path:/tmp/pip-ybWOmh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:32:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:32:00 INFO - Running setup.py (path:/tmp/pip-SxtsWi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:32:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:32:00 INFO - Running setup.py (path:/tmp/pip-MxCDOn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:32:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:32:00 INFO - Running setup.py (path:/tmp/pip-CMKD25-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:32:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:32:00 INFO - Running setup.py (path:/tmp/pip-FqgzgZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:32:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:32:00 INFO - Running setup.py (path:/tmp/pip-5Nai76-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:32:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:32:00 INFO - Running setup.py (path:/tmp/pip-CoZxm4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:32:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:32:00 INFO - Running setup.py (path:/tmp/pip-cO9vMO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:32:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:32:00 INFO - Running setup.py (path:/tmp/pip-sAw0sM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:32:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:32:00 INFO - Running setup.py (path:/tmp/pip-WWK0xy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:32:01 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 02:32:01 INFO - Running setup.py install for manifestparser 02:32:01 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 02:32:01 INFO - Running setup.py install for mozcrash 02:32:01 INFO - Running setup.py install for mozdebug 02:32:01 INFO - Running setup.py install for mozdevice 02:32:01 INFO - Installing dm script to /builds/slave/test/build/venv/bin 02:32:01 INFO - Running setup.py install for mozfile 02:32:01 INFO - Running setup.py install for mozhttpd 02:32:01 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 02:32:01 INFO - Running setup.py install for mozinfo 02:32:01 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 02:32:01 INFO - Running setup.py install for mozInstall 02:32:01 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 02:32:01 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 02:32:01 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 02:32:01 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 02:32:01 INFO - Running setup.py install for mozleak 02:32:01 INFO - Running setup.py install for mozlog 02:32:02 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 02:32:02 INFO - Running setup.py install for moznetwork 02:32:02 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 02:32:02 INFO - Running setup.py install for mozprocess 02:32:02 INFO - Running setup.py install for mozprofile 02:32:02 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 02:32:02 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 02:32:02 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 02:32:02 INFO - Running setup.py install for mozrunner 02:32:02 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 02:32:02 INFO - Running setup.py install for mozscreenshot 02:32:02 INFO - Running setup.py install for moztest 02:32:02 INFO - Running setup.py install for mozversion 02:32:02 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 02:32:02 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 02:32:02 INFO - Cleaning up... 02:32:02 INFO - Return code: 0 02:32:02 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:32:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:32:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:32:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:32:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:32:02 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28ac1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a75a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c18a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c1c090>, '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 0x2c1cd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c16f90>, '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': '20e666a3d4cfbb71505a330e000001b4-1505377061.210318-221390492', '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 02:32:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 02:32:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 02:32:02 INFO - Using env: {'DISPLAY': ':0', 02:32:02 INFO - 'HOME': '/home/cltbld', 02:32:02 INFO - 'LANG': 'en_US.UTF-8', 02:32:02 INFO - 'LANGUAGE': 'en_US:en', 02:32:02 INFO - 'LOGNAME': 'cltbld', 02:32:02 INFO - 'MAIL': '/var/mail/cltbld', 02:32:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:32:02 INFO - 'MOZ_NO_REMOTE': '1', 02:32:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:32:02 INFO - 'NO_EM_RESTART': '1', 02:32:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:32:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:32:02 INFO - 'PWD': '/builds/slave/test', 02:32:02 INFO - 'SHELL': '/bin/bash', 02:32:02 INFO - 'SHLVL': '1', 02:32:02 INFO - 'TERM': 'linux', 02:32:02 INFO - 'TMOUT': '86400', 02:32:02 INFO - 'USER': 'cltbld', 02:32:02 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1505377061.210318-221390492', 02:32:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:32:02 INFO - '_': '/tools/buildbot/bin/python'} 02:32:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:32:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:32:03 INFO - Running setup.py (path:/tmp/pip-_S5Xn_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:32:03 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)) 02:32:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:32:03 INFO - Running setup.py (path:/tmp/pip-DMwUPC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:32:03 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)) 02:32:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:32:03 INFO - Running setup.py (path:/tmp/pip-bG6of1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:32:03 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)) 02:32:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:32:03 INFO - Running setup.py (path:/tmp/pip-z38iGZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:32:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.51 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 02:32:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:32:03 INFO - Running setup.py (path:/tmp/pip-CCjt6n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:32:03 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)) 02:32:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:32:03 INFO - Running setup.py (path:/tmp/pip-5NYPut-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:32:03 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)) 02:32:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:32:03 INFO - Running setup.py (path:/tmp/pip-vbw4Qa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:32:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.10 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)) 02:32:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:32:03 INFO - Running setup.py (path:/tmp/pip-o_ZMk0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:32:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.13 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)) 02:32:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:32:03 INFO - Running setup.py (path:/tmp/pip-lROcmk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:32:03 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)) 02:32:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:32:03 INFO - Running setup.py (path:/tmp/pip-sjhlUo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:32:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.5 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)) 02:32:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:32:03 INFO - Running setup.py (path:/tmp/pip-IE8Ngr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:32:03 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)) 02:32:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:32:03 INFO - Running setup.py (path:/tmp/pip-Fp6cFh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:32:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 02:32:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:32:03 INFO - Running setup.py (path:/tmp/pip-vmrhRa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:32:03 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)) 02:32:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:32:03 INFO - Running setup.py (path:/tmp/pip-tF5Ryf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:32:04 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)) 02:32:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:32:04 INFO - Running setup.py (path:/tmp/pip-iHLuKo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:32:04 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)) 02:32:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:32:04 INFO - Running setup.py (path:/tmp/pip-InxjsL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:32:04 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)) 02:32:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:32:04 INFO - Running setup.py (path:/tmp/pip-PU2Gu1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:32:04 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)) 02:32:04 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)) 02:32:04 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)) 02:32:04 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)) 02:32:04 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.51->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 02:32:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.51->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 02:32:04 INFO - Requirement already satisfied (use --upgrade to upgrade): requests in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozInstall==1.13->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 02:32:04 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 02:32:04 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 02:32:04 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 02:32:04 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 02:32:04 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 02:32:05 INFO - Downloading blessings-1.6.tar.gz 02:32:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 02:32:05 INFO - Installing collected packages: blessings 02:32:05 INFO - Running setup.py install for blessings 02:32:05 INFO - Successfully installed blessings 02:32:05 INFO - Cleaning up... 02:32:05 INFO - Return code: 0 02:32:05 INFO - Done creating virtualenv /builds/slave/test/build/venv. 02:32:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:32:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:32:05 INFO - Reading from file tmpfile_stdout 02:32:05 INFO - Current package versions: 02:32:05 INFO - argparse == 1.2.1 02:32:05 INFO - blessings == 1.6 02:32:05 INFO - blobuploader == 1.2.4 02:32:05 INFO - docopt == 0.6.1 02:32:05 INFO - functools32 == 3.2.3-2 02:32:05 INFO - jsonschema == 2.5.1 02:32:05 INFO - manifestparser == 1.1 02:32:05 INFO - mozInstall == 1.13 02:32:05 INFO - mozcrash == 1.0 02:32:05 INFO - mozdebug == 0.1 02:32:05 INFO - mozdevice == 0.51 02:32:05 INFO - mozfile == 1.2 02:32:05 INFO - mozhttpd == 0.7 02:32:05 INFO - mozinfo == 0.10 02:32:05 INFO - mozleak == 0.1 02:32:05 INFO - mozlog == 3.5 02:32:05 INFO - moznetwork == 0.27 02:32:05 INFO - mozprocess == 0.25 02:32:05 INFO - mozprofile == 0.28 02:32:05 INFO - mozrunner == 6.13 02:32:05 INFO - mozscreenshot == 0.1 02:32:05 INFO - mozsystemmonitor == 0.3 02:32:05 INFO - moztest == 0.8 02:32:05 INFO - mozversion == 1.4 02:32:05 INFO - psutil == 3.1.1 02:32:05 INFO - requests == 1.2.3 02:32:05 INFO - wsgiref == 0.1.2 02:32:05 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:32:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:32:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:32:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:32:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:32:05 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28ac1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a75a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c18a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c1c090>, '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 0x2c1cd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c16f90>, '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': '20e666a3d4cfbb71505a330e000001b4-1505377061.210318-221390492', '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 02:32:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 02:32:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 02:32:05 INFO - Using env: {'DISPLAY': ':0', 02:32:05 INFO - 'HOME': '/home/cltbld', 02:32:05 INFO - 'LANG': 'en_US.UTF-8', 02:32:05 INFO - 'LANGUAGE': 'en_US:en', 02:32:05 INFO - 'LOGNAME': 'cltbld', 02:32:05 INFO - 'MAIL': '/var/mail/cltbld', 02:32:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:32:05 INFO - 'MOZ_NO_REMOTE': '1', 02:32:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:32:05 INFO - 'NO_EM_RESTART': '1', 02:32:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:32:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:32:05 INFO - 'PWD': '/builds/slave/test', 02:32:05 INFO - 'SHELL': '/bin/bash', 02:32:05 INFO - 'SHLVL': '1', 02:32:05 INFO - 'TERM': 'linux', 02:32:05 INFO - 'TMOUT': '86400', 02:32:05 INFO - 'USER': 'cltbld', 02:32:05 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1505377061.210318-221390492', 02:32:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:32:05 INFO - '_': '/tools/buildbot/bin/python'} 02:32:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:32:05 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)) 02:32:05 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)) 02:32:05 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)) 02:32:05 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)) 02:32:05 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)) 02:32:05 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)) 02:32:05 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)) 02:32:06 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)) 02:32:06 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)) 02:32:06 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 02:32:06 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 02:32:06 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 02:32:06 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 02:32:06 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 02:32:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 02:32:07 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)) 02:32:07 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)) 02:32:07 INFO - Installing collected packages: simplejson 02:32:07 INFO - Running setup.py install for simplejson 02:32:07 INFO - building 'simplejson._speedups' extension 02:32:07 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c simplejson/_speedups.c -o build/temp.linux-x86_64-2.7/simplejson/_speedups.o 02:32:08 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/simplejson/_speedups.o -o build/lib.linux-x86_64-2.7/simplejson/_speedups.so 02:32:08 INFO - Successfully installed simplejson 02:32:08 INFO - Cleaning up... 02:32:08 INFO - Return code: 0 02:32:08 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 02:32:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:32:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:32:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:32:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:32:08 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28ac1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a75a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c18a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c1c090>, '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 0x2c1cd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c16f90>, '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': '20e666a3d4cfbb71505a330e000001b4-1505377061.210318-221390492', '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 02:32:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 02:32:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 02:32:08 INFO - Using env: {'DISPLAY': ':0', 02:32:08 INFO - 'HOME': '/home/cltbld', 02:32:08 INFO - 'LANG': 'en_US.UTF-8', 02:32:08 INFO - 'LANGUAGE': 'en_US:en', 02:32:08 INFO - 'LOGNAME': 'cltbld', 02:32:08 INFO - 'MAIL': '/var/mail/cltbld', 02:32:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:32:08 INFO - 'MOZ_NO_REMOTE': '1', 02:32:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:32:08 INFO - 'NO_EM_RESTART': '1', 02:32:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:32:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:32:08 INFO - 'PWD': '/builds/slave/test', 02:32:08 INFO - 'SHELL': '/bin/bash', 02:32:08 INFO - 'SHLVL': '1', 02:32:08 INFO - 'TERM': 'linux', 02:32:08 INFO - 'TMOUT': '86400', 02:32:08 INFO - 'USER': 'cltbld', 02:32:08 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1505377061.210318-221390492', 02:32:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:32:08 INFO - '_': '/tools/buildbot/bin/python'} 02:32:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:32:08 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 02:32:08 INFO - Cleaning up... 02:32:08 INFO - Return code: 0 02:32:08 INFO - Running post-action listener: _resource_record_post_action 02:32:08 INFO - Running post-action listener: _start_resource_monitoring 02:32:08 INFO - Starting resource monitoring. 02:32:08 INFO - [mozharness: 2017-09-14 09:32:08.517849Z] Finished create-virtualenv step (success) 02:32:08 INFO - [mozharness: 2017-09-14 09:32:08.518310Z] Running install step. 02:32:08 INFO - Running pre-action listener: _resource_record_pre_action 02:32:08 INFO - Running main action method: install 02:32:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:32:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:32:08 INFO - Reading from file tmpfile_stdout 02:32:08 INFO - Detecting whether we're running mozinstall >=1.0... 02:32:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 02:32:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 02:32:08 INFO - Reading from file tmpfile_stdout 02:32:08 INFO - Output received: 02:32:08 INFO - Usage: mozinstall [options] installer 02:32:08 INFO - Options: 02:32:08 INFO - -h, --help show this help message and exit 02:32:08 INFO - -d DEST, --destination=DEST 02:32:08 INFO - Directory to install application into. [default: 02:32:08 INFO - "/builds/slave/test"] 02:32:08 INFO - --app=APP Application being installed. [default: firefox] 02:32:08 INFO - mkdir: /builds/slave/test/build/application 02:32:08 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'] 02:32:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 02:32:26 INFO - Reading from file tmpfile_stdout 02:32:26 INFO - Output received: 02:32:26 INFO - /builds/slave/test/build/application/firefox/firefox 02:32:26 INFO - Running post-action listener: _resource_record_post_action 02:32:26 INFO - [mozharness: 2017-09-14 09:32:26.681862Z] Finished install step (success) 02:32:26 INFO - [mozharness: 2017-09-14 09:32:26.682114Z] Running setup-mitmproxy step. 02:32:26 INFO - Running pre-action listener: _resource_record_pre_action 02:32:26 INFO - Running main action method: setup_mitmproxy 02:32:26 INFO - Skipping: mitmproxy is not required 02:32:26 INFO - Running post-action listener: _resource_record_post_action 02:32:26 INFO - [mozharness: 2017-09-14 09:32:26.683240Z] Finished setup-mitmproxy step (success) 02:32:26 INFO - [mozharness: 2017-09-14 09:32:26.683461Z] Running run-tests step. 02:32:26 INFO - Running pre-action listener: _resource_record_pre_action 02:32:26 INFO - Running pre-action listener: _set_gcov_prefix 02:32:26 INFO - Running main action method: run_tests 02:32:26 WARNING - Try message not found. 02:32:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 02:32:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 02:32:26 INFO - Python 2.7.3 02:32:26 INFO - Return code: 0 02:32:26 INFO - grabbing minidump binary from tooltool 02:32:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:32:26 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://tooltool.mozilla-releng.net/', '--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 0x2c1c090>, '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 0x2c1cd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c16f90>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 02:32:26 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://tooltool.mozilla-releng.net/', '--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 02:32:26 INFO - Copy/paste: /tools/tooltool.py --url https://tooltool.mozilla-releng.net/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 02:32:26 INFO - Calling ['/tools/tooltool.py', '--url', 'https://tooltool.mozilla-releng.net/', '--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 02:32:26 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 02:32:26 INFO - Return code: 0 02:32:26 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 02:32:26 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 02:32:26 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 02:32:26 INFO - ENV: RUST_BACKTRACE is now full 02:32:26 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 02:32:26 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 02:32:26 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-stylo-disabled-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/dyqypZ5BQ3uJrBBpjoZhjw/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-015', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_raw.log'] in /builds/slave/test/build 02:32:26 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-stylo-disabled-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/dyqypZ5BQ3uJrBBpjoZhjw/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-015 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_raw.log 02:32:26 INFO - Using env: {'DISPLAY': ':0', 02:32:26 INFO - 'HOME': '/home/cltbld', 02:32:26 INFO - 'LANG': 'en_US.UTF-8', 02:32:26 INFO - 'LANGUAGE': 'en_US:en', 02:32:26 INFO - 'LOGNAME': 'cltbld', 02:32:26 INFO - 'MAIL': '/var/mail/cltbld', 02:32:26 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 02:32:26 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 02:32:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:32:26 INFO - 'MOZ_NO_REMOTE': '1', 02:32:26 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 02:32:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:32:26 INFO - 'NO_EM_RESTART': '1', 02:32:26 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:32:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:32:26 INFO - 'PWD': '/builds/slave/test', 02:32:26 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 02:32:26 INFO - 'RUST_BACKTRACE': 'full', 02:32:26 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 02:32:26 INFO - 'SHELL': '/bin/bash', 02:32:26 INFO - 'SHLVL': '1', 02:32:26 INFO - 'TERM': 'linux', 02:32:26 INFO - 'TMOUT': '86400', 02:32:26 INFO - 'USER': 'cltbld', 02:32:26 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1505377061.210318-221390492', 02:32:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:32:26 INFO - '_': '/tools/buildbot/bin/python'} 02:32:26 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-stylo-disabled-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/dyqypZ5BQ3uJrBBpjoZhjw/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-015', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_raw.log'] with output_timeout 3600 02:32:27 INFO - mozversion application_buildid: 20170914084540 02:32:27 INFO - mozversion application_changeset: 6266decf217d4da5a18115cb5b1ff70feb76e7a5 02:32:27 INFO - mozversion application_display_name: Nightly 02:32:27 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 02:32:27 INFO - mozversion application_name: Firefox 02:32:27 INFO - mozversion application_remotingname: firefox 02:32:27 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 02:32:27 INFO - mozversion application_vendor: Mozilla 02:32:27 INFO - mozversion application_version: 57.0a1 02:32:27 INFO - mozversion platform_buildid: 20170914084540 02:32:27 INFO - mozversion platform_changeset: 6266decf217d4da5a18115cb5b1ff70feb76e7a5 02:32:27 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 02:32:27 INFO - mozversion platform_version: 57.0a1 02:32:27 INFO - using testdate: 1505381547 02:32:27 INFO - actual date: 1505381547 02:32:27 INFO - starting webserver on 'localhost:51421' 02:32:27 INFO - SUITE-START | Running 2 tests 02:32:27 INFO - TEST-START | dromaeo_css 02:32:27 INFO - Initialising browser for dromaeo_css test... 02:32:27 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:51421/getInfo.html -profile /tmp/tmpk2aM7B/profile 02:32:27 INFO - TEST-INFO | started process 12524 (/builds/slave/test/build/application/firefox/firefox http://localhost:51421/getInfo.html) 02:32:32 INFO - TEST-INFO | 12524: exit 0 02:32:32 INFO - Browser initialized. 02:32:32 INFO - Running cycle 1/1 for dromaeo_css test... 02:32:32 INFO - Using env: {'DISPLAY': ':0', 02:32:32 INFO - 'HOME': '/home/cltbld', 02:32:32 INFO - 'JSGC_DISABLE_POISONING': '1', 02:32:32 INFO - 'LANG': 'en_US.UTF-8', 02:32:32 INFO - 'LANGUAGE': 'en_US:en', 02:32:32 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 02:32:32 INFO - 'LOGNAME': 'cltbld', 02:32:32 INFO - 'MAIL': '/var/mail/cltbld', 02:32:32 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 02:32:32 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 02:32:32 INFO - 'MOZ_CRASHREPORTER': '1', 02:32:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:32:32 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 02:32:32 INFO - 'MOZ_NO_REMOTE': '1', 02:32:32 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 02:32:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:32:32 INFO - 'NO_EM_RESTART': '1', 02:32:32 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:32:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:32:32 INFO - 'PWD': '/builds/slave/test', 02:32:32 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 02:32:32 INFO - 'RUST_BACKTRACE': 'full', 02:32:32 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 02:32:32 INFO - 'SHELL': '/bin/bash', 02:32:32 INFO - 'SHLVL': '1', 02:32:32 INFO - 'STYLO_FORCE_DISABLED': '1', 02:32:32 INFO - 'TERM': 'linux', 02:32:32 INFO - 'TMOUT': '86400', 02:32:32 INFO - 'USER': 'cltbld', 02:32:32 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1505377061.210318-221390492', 02:32:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:32:32 INFO - '_': '/tools/buildbot/bin/python'} 02:32:32 INFO - TEST-INFO | started process 12760 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpk2aM7B/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 02:32:33 INFO - PID 12760 | 02:32:33 INFO - PID 12760 | (/builds/slave/test/build/application/firefox/firefox:12809): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 02:32:33 INFO - PID 12760 | 02:32:44 INFO - PID 12760 | RSS: Main: 172986368 02:32:44 INFO - PID 12760 | 02:35:41 INFO - PID 12760 | Cycle 1(1): loaded http://localhost:51421/tests/dromaeo/cssquery-dojo.html (next: http://localhost:51421/tests/dromaeo/cssquery-ext.html) 02:35:42 INFO - PID 12760 | RSS: Main: 173211648 02:35:42 INFO - PID 12760 | 02:38:44 INFO - PID 12760 | Cycle 1(1): loaded http://localhost:51421/tests/dromaeo/cssquery-ext.html (next: http://localhost:51421/tests/dromaeo/cssquery-jquery.html) 02:38:45 INFO - PID 12760 | RSS: Main: 171868160 02:38:45 INFO - PID 12760 | 02:41:47 INFO - PID 12760 | Cycle 1(1): loaded http://localhost:51421/tests/dromaeo/cssquery-jquery.html (next: http://localhost:51421/tests/dromaeo/cssquery-mootools.html) 02:41:47 INFO - PID 12760 | RSS: Main: 174489600 02:41:47 INFO - PID 12760 | 02:44:49 INFO - PID 12760 | Cycle 1(1): loaded http://localhost:51421/tests/dromaeo/cssquery-mootools.html (next: http://localhost:51421/tests/dromaeo/cssquery-prototype.html) 02:44:49 INFO - PID 12760 | RSS: Main: 172646400 02:44:49 INFO - PID 12760 | 02:47:53 INFO - PID 12760 | Cycle 1(1): loaded http://localhost:51421/tests/dromaeo/cssquery-prototype.html (next: http://localhost:51421/tests/dromaeo/cssquery-yui.html) 02:47:54 INFO - PID 12760 | RSS: Main: 172593152 02:47:54 INFO - PID 12760 | 02:50:55 INFO - PID 12760 | Cycle 1(1): loaded http://localhost:51421/tests/dromaeo/cssquery-yui.html (next: http://localhost:51421/tests/dromaeo/cssquery-dojo.html) 02:50:55 INFO - PID 12760 | RSS: Main: 177160192 02:50:55 INFO - PID 12760 | 02:50:55 INFO - PID 12760 | __start_tp_report 02:50:55 INFO - PID 12760 | _x_x_mozilla_page_load 02:50:55 INFO - PID 12760 | _x_x_mozilla_page_load_details 02:50:55 INFO - PID 12760 | |i|pagename|runs| 02:50:55 INFO - PID 12760 | |0;dojo.html;3135.043811637451;3147.213196700825;3205.423023855705;3213.983930080349;3229.8546565404554;6134.509239260859;6253.656048917308;6279.686015699214;6344.080108384287;6413.262474815392;6232.283287421937;6236.251649802019;6246.968765156168;6290.622562646245;6309.5267854910835;5777.566682498808;5879.118132280149;5895.528357731393;5900.43945825146;5915.497182739472;5870.442307980735;5923;5956.047032474805;5963.403659634046;5972.6715030673295;1260.701501646808;5451.2640793492765;5728.312602487707;5744;5881.647101173943;5802.564807639444;5809.7095145242565;5870.178175055496;5893.116032595102;5895.29256489224;5724.685142317171;5789.942100578983;5864.560157988168;5866.14940833581;5871.647701137903;6295.401936815995;6327.27236367819;6336.303006669263;6370.681465926731;6404.519661025442;6614;6765.357291057391;6767.796966090976;6841.452683785285;6866.485013623948;6771.356721111487;6776.05135281061;6791.252962174157;6794.762183323609;6815.863682726318;6290.905636415411;6301.842453938688;6313.494920406402;6334.714937827809;6394.968025159845;6991.825204369931;7088.787336379917;7101.538400003983;7138.321859423347;7142.500024998304;6674.799756007327;6683.365080317362;6704.83237919056;6762.661866906635;6775.695093720795;6642.535022548375;6750.054992301082;6758.8648227036165;6759.188897332253;6861.519693621499;6620.937367489001;6669.866602667919;6683.164604424447;6714.127163468718;6716.395524402729;6727.66361681914;6740.494462915301;6740.696668649923;6850.760223392157;6867.07294515244;5199.428062913076;5265.578753699695;5267.236250743697;5275.525202731773;5281.867953301198;4583.427071616048;4606.378138951199;4637.118947399983;4683;4685.882852928704;5703.771849126071;5788.218590490314;5810.738516766755;5859.2090067841145;5870.148828419855;6738.157730283715;6799.694013769392;6812.931870681329;6819.283975182534;6868.313168683192;5810.448007439287;5860.70696465175;5896.970515147483;5897.557683173779;5907.054871220584;5826.708664566755;5836.766529338864;5904.704764761745;5906.350301466835;5909.586328957018;6442.9355706443275;6532.738690452424;6545.607263564201;6587.275399706028;6673.799786006428;6738.49461290415;6740.157480315059;6767.39093481589;6770.187577490733;6770.390664840188;6433.324500927335;6483.319251478527;6513.5114866384265;6533.967330163318;6616.636085015371;6687.364700353459;6765.830854228684;6781.38967492928;6800.693968771516;6810.659467026728;6846.315368463114;6862.142232220973;6942.618156001468;6953.582785032914;6957.9304206959305;6421.678916054272;6563.7702680405955;6590.373914478117;6595.208574971034;6682.031105489579;6536.248331441755;6536.3136870627895;6546.770863019771;6555.016747487915;6558.901616475661;6532.510061745483;6544.476441884733;6549.115869357766;6601.9009714853355;6613.5370524062855;6622.635755033327;6660.56706314088;6725.29384414649;6732.192136943598;6736.461083113437;6402.679866006588;6441.6135031896365;6502.772402965874;6506.674666266573;6527.3472652734345 02:50:55 INFO - PID 12760 | |1;ext.html;861.0872475176313;882.4220135811046;886.5611522296468;888.0985799413593;891.2736120062149;38581.80709096454;42336.36495452571;42377.36433953493;42481.787591062;42493.15013699724;38382.424263636;38465.80767096161;38701.032474188156;38772.418413723746;38816.61183388165;6985.05701730265;7075.716971321141;7102.893456598155;7116.110486189226;7118.074650295454;6763.18841738992;6781.186257649089;6825.556338837984;6835.418989385908;7030.121234845645;6753.088333075021;6810.114685090931;6830.419414349786;6905.067815844872;7515.511491753018;7573.810654733621;7677.616119194018;7693.49992250502;7696.807579810494;7702.768916932473;7513.985611942372;7601.163871974079;7601.391888648895;7601.7719468416035;7603;37931.24137517234;38518.22963540714;38576.42135367972;38664;38750.80624596887;3411.5053317269103;3439.3465241604267;3478.4086705260165;3483.2685136121445;3483.4426491761196;32160.517592236134;32198.195045123826;32313.51529727056;32316.83841580777;32381.352372952646;5211.635185537014;5213.296205012312;5222.0861349264105;5225.137852254374;5232.555232805216;182083;183626;183923;183984;184381.99999999866;42937.141257174684;43800.342994855106;48624.75687621539;48687.51312486901;49631.75184124056;52381;52710.47289527133;52717.47282527126;52717.736411317695;52765.736171318895;16631.501054968372;16715.498535043967;16777.1611419431;16786.916065419595;16789.076600787073;13640.113392629448;13673.31633418345;13681.179129252278;13694.589162325146;13834.23911684867;14380.280985950661;14410.711785764226;14432.350544225324;14516.346764395628;14606.707865842624;5732.111522713986;5768.221290125779;5819.301683797887;5849.64902105875;5973.731182096816;997.1275134257525;1004.9849252261222;1016.1261315268863;1027.060239880501;1031.566741968375;22937.197198097987;23247;23275.7672423277;23296.184633537745;23357.182498612467;1097.7397130522336;1101.730076131337;1104.9447527623586;1108.4845546820768;1108.9778204435866;12266.38668066611;12345.691357716129;12384.009279257638;12446.593713388484;12516.936060434966;226691;227887;228321;228785;228927;52202;52442.21336679953;52570.73714631479;52696;52781.2082818758;1441.9206943617992;1453.6596475766696;1469.7868809022632;1487.9181645009628;1490.93290801912;22824.54350912939;22895.54208915779;23003.6549451755;23039.76960230376;23075;37615.62384376121;37740.43389349217;37757.622423775414;37780;37800.62199378081;200353;200808;200850;201275;202614;30247.848760756056;30652.693473064985;33622.49566256557;33741.66258337385;34101;40196.3970540448;41941.58058419377;42362.94092647709;42385;42640.36039459349;31135.53296700506;31566.210844729067;31601.5259771099;31864.52203217;32035.679643203268;30535;30641.233969150948;30967.845160774054;30985;31400.214994625316;34721.826390867885;34729.47905781466;34824.65175348214;35105;35136.64863351436;30309.242268943453;30323;30324.241893951945;30746.846265768527;31090.68909310878;22721.863906804923;23088.653670195297;23173.768262317837;23233.186838460573;23256.186033488746 02:50:55 INFO - PID 12760 | |2;jquery.html;562.213492130501;564.9011423000974;572.5162237908968;575.9086531023707;579.4466284698113;21564.56870862582;22348.10607575695;22353.77646223537;22356.776432235674;22446.989885455132;23839;24401.511969760595;24769.75230247697;24907;25461;6442.806715798533;6501.902471462932;6507.186601674791;6517.478601711875;6535.150430444036;6436.163298771153;6524.673766311689;6533.15069041024;6542.051402546628;6879.6216208108535;7157;7207.927920720805;7211.927880721178;7212.639368031603;7217.639118044077;6853.4174595159475;7154.749583764569;7161.713531458736;7167.211606723256;7208.819779505554;7045.859082818366;7050.153981522199;7056.788296351117;7057.5412598181465;7059.152901651783;31332.21669458259;31820.681793182233;32066.519002214984;32072.679273207203;32101.678983210102;1985.8411327093797;1997.7602687677572;2006.3679940818595;2010.6079314533672;2017.535966727661;20572.79427205739;20837.479063023395;21357.78642213589;21393;21521.7086974782;2480.6651102101164;2518.584433568459;2568.447783726489;2575;2579.587266037425;118081.40959295235;123188;131986;137981;138253;19347.8065219346;20882.47793805167;21001.264955726478;21104.261350852645;22199.1120355184;42113;42239.788801055794;42341.36487952683;42528.362074568904;42623.14753704909;11476.770464590829;11518.251313664585;11619.419029048513;11646.184767066225;11658.242214256046;9638.132568068908;9675.758106047406;9719.805603887882;9809.607615695293;9856.408615483095;10964.725881853017;11086.61196858106;11181.944090279496;11376.715582110513;11498;3675.7794532328144;3806.7715937043868;4174.791260437027;4212.599803018708;4345.718497788623;921.488573841511;961.7499450142873;973.9464329461806;983.0611765763679;991.8363470027365;19263.614727705368;19499.805001950084;19569.804301957083;19792.505187370432;19886.50283742918;985.1872205430549;990.1929927109383;1018.2261481274285;1045.8744950605976;1048.784999075203;10818.783624327469;10820.02619764225;10843.240973131962;10910.23628346024;10950.014498695156;440948;442630;448648;448745;457569;110040.4497977505;112976.43511782389;116253.41873290579;116614;117073;1060.3955745225148;1108.467935391017;1115.59838458155;1150.6433005768238;1151.9596814111633;20453.488662782955;20506.89746551258;20590;20629.484262893548;20801;52793.7360313196;53030.73484632552;53359;53682;54790;63407.36592634015;64047;64729.67635161794;65016.67491662512;65333;19014.904925475283;19753.703694444306;19886.409087272696;19907.203711851944;20022;22565.210217642303;22570.77429225687;22572.88713556422;22949.082036718344;23049.078036879007;17684.91157544204;18114.72827907556;18227.088645567404;18370.448886533424;18474.907625461787;16407.83592164063;16501.257443414834;16655;16975.660486790443;17254.137293135544;18215.817841821412;18479.630407392047;18721.438356849318;18990.335338263096;19049.14278857427;19468.513287167934;19568;19666.90166549158;19684.114214860652;19761.40715778529;17442.389516366868;17458.563535911704;18159.18283677264;18539.536511587317;18567.721484177477 02:50:55 INFO - PID 12760 | |3;mootools.html;1287.246960528091;1357.68094497793;1368.1996032321094;1373.1417863835104;1380.413324337157;15103.24483775811;15669.843301566994;15673.686526269468;15682.607934801636;15700.293486793093;15200.239988000583;15249.161296128708;15259.618509537268;15317.463888763896;15398.30707618157;2757.131503576367;2774.2370848016753;2825.4490374377006;2832.5892745551987;2835.1069413134796;2755.669319681631;2789.3445040415486;2797.7062408447127;2799.594058861464;2800.2999250187454;2677.6786785585755;2776.01451484722;2776.0977682253247;2776.111644273833;2778.3193117686196;2770.127409865886;2806.8877244910177;2807.0736656903273;2827.3355761396056;2827.575863620463;2737.3293543081872;2737.4935636907235;2759.696433392325;2778.749912507864;2782.318332008671;15222.847771522365;15226.46707365248;15226.619334516616;15278.38886444541;15305;8133.877991830127;8382.455140415854;8435.95782021092;8456.619452124669;8460.450070745383;5307.6019298552765;5407.83731497726;5487.917681234745;5564.415736347706;5567.498925096761;1876.9624607507774;1897.127321432143;1899.591587808614;1916.1568909679697;1932.0726051495221;26800.463990720076;27062.052828151118;27073.45853082947;27098.45803083947;27130.864345678343;6622.437092847162;6878.484113691493;6886.001529778255;6982.441404687613;7063.081799366049;17192.31230750781;17224.569385765455;17272.91363543174;17304.913475432542;17316.134193290283;7807.80480487981;8091.55496447701;8100.351971842357;8101.392395570356;8103.230193131643;7303.415726741848;7308.159561650372;7470.178280389153;7484.1393239777035;7510.774676759706;5095.694258344512;5171.741412929338;5204.167333226741;5278.656887302313;5474.288342515448;1417.4897037066648;1465.9267036648125;1580.9051456912623;1589.2292238264433;1635.7219272723667;779.742684913977;905.6603773584906;908.8227795579799;909.6770646420558;910.7677542226822;8555.572221388906;8998.640054397882;9044.502552359552;9045.366824322235;9091.31815113869;956.784723437235;976.2677991506371;985.3053597213947;986.8766404199475;987.7481242283171;4624.676272660949;5210.5831533477985;5342.038433082005;5375.865603359947;5616.157576363578;20903.268385606432;21856.235031773813;21896.45258868541;22033.669494957587;22116.115355385926;21099;21441.356759297247;21530.354089377342;21587.56824863494;21733.347999559723;11144.108471322275;11572.305661660159;11575.536978520764;11578.247413918069;11596.768064638829;8430.277532402148;8498.490090594583;8519.190676885686;8601.268892144239;8682.088380720186;17620.82379176192;18109.63780724352;18571.44285671432;18927.148278327782;18964;18792;19024;19073.904630476758;19504;19582.804171958098;11132.276402033842;11195.384253866116;11286.20996530235;11297.604583839526;11330.716732081764;13703.246321452416;13725.519606813714;13731.107478013897;13806.723865522432;13812.654683632989;11514.596989105341;11538.59614913474;11629.418529073344;11798;11945.641630751092;10931.83602245951;11100.167487438635;11219.214654974074;11292.548298067984;11297.774044519228;10111.090001899864;10216.182705383402;10272.640457584248;10272.743181420225;10276;7579.749341358614;7616.7334143304715;7670.463067585216;7733.535987840747;7739.032620922385;7676.501027433199;7768;7779.494332868346;7810.10183828867;7852.842943140991 02:50:55 INFO - PID 12760 | |4;prototype.html;490.9959133571845;507.1682440797093;527.0960303080218;529.4070640882212;530.6789392417585;6404.743810247591;6422.325655806143;6448.935510644898;6481.805545833621;6492.545521813475;6163.167972323735;6216.129741836146;6242.502998800471;6277.748890044404;6293.056041593763;4962;5023.949760502403;5074.264231686403;5111.565516931066;5115.258287548294;4916;5056.241563765428;5058.392992840846;5083.720395378253;5105.8767071244265;5042.71410790248;5061.519155680223;5063.5315758430015;5066.164082926312;5080.441151473335;4965.652404331699;4981.900361992758;5036.388355726169;5073;5102.846914592568;4472.8881777955485;4478.8880277992985;4488.451484237933;4520.208963431386;4539.0496177484565;6231.722496888127;6258.123862659231;6270.561060725751;6304.653244071575;6337.651429171394;5760.942390576082;5798.202557207279;5804.680742559158;5804.941950580483;5831.387704291031;6438.939539347364;6489.35106489352;6570.507211959074;6594.395213890534;6631.602103873783;4872.561469467765;4907.214845624683;4911.754412279408;4941.654084214107;4941.925871111936;6948.965255173743;6984.301569842975;7078.752243671447;7089.397401220903;7118.857622847566;5017.498250175026;5044.722540260247;5077.263796749525;5079.5428411443145;5086.262491938648;5067.493250674903;5071.594272458195;5127.8718032048755;5131.179011358165;5153.2270159476375;5741.8564535886935;5746.511546518593;5788.53691704671;5797.88404231913;5809.7966571170655;6698.162729658793;6698.7320507179165;6698.8995165072565;6716.059751634775;6725.529212955144;1684.3262694921884;1714.2200298863986;1722.7157519009475;1744.9932577535935;1761.2338632694562;1196.7845787758288;1230.7046308885804;1232.5870833270776;1232.6671798614502;1235.4502246500401;5739.253896993364;5762.337331206881;5789.247397838339;5793.913091303634;5874.148248503943;6571.211454625475;6685.866282674319;6750.257471678112;6758.695858686371;6767;5901.40985901415;5901.557383196192;5909.202257695156;5918.822435326947;5979.611325263844;3508.7894726315994;3567.518385018041;3596.6371442701156;3649.233660931234;3674.3386190485435;6469.77355792545;6504.601181019742;6520.347965203442;6575.736970521221;6579.83550411234;6894.896576551356;6971.268016858258;6991.440684745208;7010.75462358815;7022.367986881205;6446.194225721785;6488.221413430419;6537.673116344164;6541.121906361186;6584.76953306632;6698.698558564779;6727.966360168363;6738.427233685192;6746.325367463214;6857.5199736018;6739.78683836914;6744.291849355944;6769.526133170631;6814.977753337039;6816.48876334267;6458.644774537445;6529.412352888263;6626.370494802986;6675.532712710064;6686;5001.974990125026;5034.2951986721155;5068.315777370155;5076.11168045598;5104.515071068243;6856.794296171123;6916.273791251846;6918.481113916577;6930.7227710891;6980.930190698231;6609.9839548938035;6649.176723383976;6672;6708.530402871752;6708.631025293461;6442.967785161044;6470.899947008926;6505.381988711065;6550.312217217314;6557;6315.968420158054;6331.651759153291;6446.419822216023;6472.902906456313;6576.2766095730385;6497.772577959749;6574.737010519526;6621.106150669791;6650.235222949423;6670.7665231716655;6289.748410063729;6385.776497822554;6385.808425747235;6416.197975253093;6452.580432304885 02:50:55 INFO - PID 12760 | |5;yui.html;909.1999040844056;913.3697748553502;927.6196759328676;934.1452570897629;937.610891480036;19100.522486937833;20018;20046.59906801863;20086.09612567436;20130.798692013075;18719.251229950787;18971.62056758864;18982.050897455105;18989;18994.430167095008;941.5386460634309;954.5227386306847;958.9472579008186;959.2278216036088;960.7406000379893;971.5142428785607;978.6868202175307;979.4466126638462;979.6032606794224;979.7599588100925;986.9111779939803;1020.1481762728131;1024.5287167902773;1029.4646783672486;1031.8400647899587;1023.9948800255988;1026.1585499890093;1026.2405819693374;1026.5483187397558;1026.8870424253364;722.1442590530186;743.680217506472;753.8529986652605;755.4296506137886;757.0310003195918;19743.901280493505;19784.70322945157;20020.899895500574;20073.598528029503;20078.598428031502;21697.34907952764;21715.34853954384;22261.44346391337;22487.100515979342;22493.662595061087;16036.35854565816;17019.48941531756;17082.914585426992;17147.657046859116;17196.05421701806;3705.0366904604725;3749.531308586427;3763.2849758546063;3764.3412402829395;3779.0741268389147;103140.5553445416;136433;137549;138132.30933845468;138149;16858.40995565174;17388.739168912478;17551;17572;17583.73624395635;31896.362072758417;32978.17554561155;33095;33134.8343258287;33142;9064.818703625891;9132.81734365309;9172.633094676272;9185.311101667401;9197.81604367909;4362.1275744851155;4441.244988351988;4446.5331140230455;4450.132224216311;4473.507914129443;5269.051570717308;5322.893542129135;5330.333708286465;5346.759395827197;5348.197770334481;1000.2897942460788;1057.9047885690325;1059.2055958031476;1060.4326685223368;1069.8020866139789;700.831800367908;714.4284572342106;714.7641278378122;730.9634518274065;732.7215658049907;12305.93847030759;12336.938315308545;12374.257544547356;12423.130380873434;12618.242905425705;670.8121725916751;678.8065401360687;692.62944324786;694.4236283884364;694.6769752065213;5229.52934235913;5394.433584473573;5399.568034557226;5494.340679118532;5505.229267902497;123327;124256;125135;130473;130787;111334;112278.43860780644;113012;116237;117506;95574.52212738892;97407;98836;99574;100781.49609251907;10126.44304563256;10152.695419137437;10209.74475638115;10228.64199753005;10364.844527332247;42675;43554.56445435505;44041.01815418378;44242;44420.333694993955;54517.45482545124;56065;56936;57469;57832;15985.600359991093;16260.105694186934;16458.34166633369;16478.505644830675;16754.832451675327;15852.44516441919;15880.60298492547;15917.442889498812;16003.599910001878;16050.117243551716;16249.67500650004;16303.103329317002;16455.42406015784;16633.584160396087;16650.417235396704;14638.34127464288;14819.555413337617;14847.777283340543;14948.177850218342;14949;15649.29578169008;15657.217139143226;15727.842721572637;15848.207589620242;15859.52421427359;11492.655220343404;11641.243319184226;11759.823602646138;11975.28148311104;12046.096542759504;12729.809052864399;12832.871671283168;12906.741865162832;12937.741245174855;13136 02:50:55 INFO - PID 12760 | __end_tp_report 02:50:55 INFO - PID 12760 | __start_cc_report 02:50:55 INFO - PID 12760 | _x_x_mozilla_cycle_collect,371 02:50:55 INFO - PID 12760 | __end_cc_report 02:50:55 INFO - PID 12760 | __startTimestamp1505382655911__endTimestamp 02:50:55 INFO - PID 12760 | 02:50:55 INFO - PID 12760 | ------- Summary: start ------- 02:50:55 INFO - PID 12760 | Number of tests: 6 02:50:55 INFO - PID 12760 | 02:50:55 INFO - PID 12760 | [#0] dojo.html Cycles:165 Average:6210.18 Median:6506.67 stddev:846.62 (13.0%) stddev-sans-first:814.12 02:50:55 INFO - PID 12760 | Values: 3135.0 3147.2 3205.4 3214.0 3229.9 6134.5 6253.7 6279.7 6344.1 6413.3 6232.3 6236.3 6247.0 6290.6 6309.5 5777.6 5879.1 5895.5 5900.4 5915.5 5870.4 5923.0 5956.0 5963.4 5972.7 1260.7 5451.3 5728.3 5744.0 5881.6 5802.6 5809.7 5870.2 5893.1 5895.3 5724.7 5789.9 5864.6 5866.1 5871.6 6295.4 6327.3 6336.3 6370.7 6404.5 6614.0 6765.4 6767.8 6841.5 6866.5 6771.4 6776.1 6791.3 6794.8 6815.9 6290.9 6301.8 6313.5 6334.7 6395.0 6991.8 7088.8 7101.5 7138.3 7142.5 6674.8 6683.4 6704.8 6762.7 6775.7 6642.5 6750.1 6758.9 6759.2 6861.5 6620.9 6669.9 6683.2 6714.1 6716.4 6727.7 6740.5 6740.7 6850.8 6867.1 5199.4 5265.6 5267.2 5275.5 5281.9 4583.4 4606.4 4637.1 4683.0 4685.9 5703.8 5788.2 5810.7 5859.2 5870.1 6738.2 6799.7 6812.9 6819.3 6868.3 5810.4 5860.7 5897.0 5897.6 5907.1 5826.7 5836.8 5904.7 5906.4 5909.6 6442.9 6532.7 6545.6 6587.3 6673.8 6738.5 6740.2 6767.4 6770.2 6770.4 6433.3 6483.3 6513.5 6534.0 6616.6 6687.4 6765.8 6781.4 6800.7 6810.7 6846.3 6862.1 6942.6 6953.6 6957.9 6421.7 6563.8 6590.4 6595.2 6682.0 6536.2 6536.3 6546.8 6555.0 6558.9 6532.5 6544.5 6549.1 6601.9 6613.5 6622.6 6660.6 6725.3 6732.2 6736.5 6402.7 6441.6 6502.8 6506.7 6527.3 02:50:55 INFO - PID 12760 | 02:50:55 INFO - PID 12760 | [#1] ext.html Cycles:180 Average:37158.83 Median:19080.59 stddev:53144.76 (278.5%) stddev-sans-first:53223.95 02:50:55 INFO - PID 12760 | Values: 861.1 882.4 886.6 888.1 891.3 38581.8 42336.4 42377.4 42481.8 42493.2 38382.4 38465.8 38701.0 38772.4 38816.6 6985.1 7075.7 7102.9 7116.1 7118.1 6763.2 6781.2 6825.6 6835.4 7030.1 6753.1 6810.1 6830.4 6905.1 7515.5 7573.8 7677.6 7693.5 7696.8 7702.8 7514.0 7601.2 7601.4 7601.8 7603.0 37931.2 38518.2 38576.4 38664.0 38750.8 3411.5 3439.3 3478.4 3483.3 3483.4 32160.5 32198.2 32313.5 32316.8 32381.4 5211.6 5213.3 5222.1 5225.1 5232.6 182083.0 183626.0 183923.0 183984.0 184382.0 42937.1 43800.3 48624.8 48687.5 49631.8 52381.0 52710.5 52717.5 52717.7 52765.7 16631.5 16715.5 16777.2 16786.9 16789.1 13640.1 13673.3 13681.2 13694.6 13834.2 14380.3 14410.7 14432.4 14516.3 14606.7 5732.1 5768.2 5819.3 5849.6 5973.7 997.1 1005.0 1016.1 1027.1 1031.6 22937.2 23247.0 23275.8 23296.2 23357.2 1097.7 1101.7 1104.9 1108.5 1109.0 12266.4 12345.7 12384.0 12446.6 12516.9 226691.0 227887.0 228321.0 228785.0 228927.0 52202.0 52442.2 52570.7 52696.0 52781.2 1441.9 1453.7 1469.8 1487.9 1490.9 22824.5 22895.5 23003.7 23039.8 23075.0 37615.6 37740.4 37757.6 37780.0 37800.6 200353.0 200808.0 200850.0 201275.0 202614.0 30247.8 30652.7 33622.5 33741.7 34101.0 40196.4 41941.6 42362.9 42385.0 42640.4 31135.5 31566.2 31601.5 31864.5 32035.7 30535.0 30641.2 30967.8 30985.0 31400.2 34721.8 34729.5 34824.7 35105.0 35136.6 30309.2 30323.0 30324.2 30746.8 31090.7 22721.9 23088.7 23173.8 23233.2 23256.2 02:50:55 INFO - PID 12760 | 02:50:55 INFO - PID 12760 | [#2] jquery.html Cycles:180 Average:34374.64 Median:22355.28 stddev:75481.61 (337.6%) stddev-sans-first:75650.66 02:50:55 INFO - PID 12760 | Values: 562.2 564.9 572.5 575.9 579.4 21564.6 22348.1 22353.8 22356.8 22447.0 23839.0 24401.5 24769.8 24907.0 25461.0 6442.8 6501.9 6507.2 6517.5 6535.2 6436.2 6524.7 6533.2 6542.1 6879.6 7157.0 7207.9 7211.9 7212.6 7217.6 6853.4 7154.7 7161.7 7167.2 7208.8 7045.9 7050.2 7056.8 7057.5 7059.2 31332.2 31820.7 32066.5 32072.7 32101.7 1985.8 1997.8 2006.4 2010.6 2017.5 20572.8 20837.5 21357.8 21393.0 21521.7 2480.7 2518.6 2568.4 2575.0 2579.6 118081.4 123188.0 131986.0 137981.0 138253.0 19347.8 20882.5 21001.3 21104.3 22199.1 42113.0 42239.8 42341.4 42528.4 42623.1 11476.8 11518.3 11619.4 11646.2 11658.2 9638.1 9675.8 9719.8 9809.6 9856.4 10964.7 11086.6 11181.9 11376.7 11498.0 3675.8 3806.8 4174.8 4212.6 4345.7 921.5 961.7 973.9 983.1 991.8 19263.6 19499.8 19569.8 19792.5 19886.5 985.2 990.2 1018.2 1045.9 1048.8 10818.8 10820.0 10843.2 10910.2 10950.0 440948.0 442630.0 448648.0 448745.0 457569.0 110040.4 112976.4 116253.4 116614.0 117073.0 1060.4 1108.5 1115.6 1150.6 1152.0 20453.5 20506.9 20590.0 20629.5 20801.0 52793.7 53030.7 53359.0 53682.0 54790.0 63407.4 64047.0 64729.7 65016.7 65333.0 19014.9 19753.7 19886.4 19907.2 20022.0 22565.2 22570.8 22572.9 22949.1 23049.1 17684.9 18114.7 18227.1 18370.4 18474.9 16407.8 16501.3 16655.0 16975.7 17254.1 18215.8 18479.6 18721.4 18990.3 19049.1 19468.5 19568.0 19666.9 19684.1 19761.4 17442.4 17458.6 18159.2 18539.5 18567.7 02:50:55 INFO - PID 12760 | 02:50:55 INFO - PID 12760 | [#3] mootools.html Cycles:180 Average:9472.99 Median:14934.10 stddev:6700.95 (44.9%) stddev-sans-first:6691.52 02:50:55 INFO - PID 12760 | Values: 1287.2 1357.7 1368.2 1373.1 1380.4 15103.2 15669.8 15673.7 15682.6 15700.3 15200.2 15249.2 15259.6 15317.5 15398.3 2757.1 2774.2 2825.4 2832.6 2835.1 2755.7 2789.3 2797.7 2799.6 2800.3 2677.7 2776.0 2776.1 2776.1 2778.3 2770.1 2806.9 2807.1 2827.3 2827.6 2737.3 2737.5 2759.7 2778.7 2782.3 15222.8 15226.5 15226.6 15278.4 15305.0 8133.9 8382.5 8436.0 8456.6 8460.5 5307.6 5407.8 5487.9 5564.4 5567.5 1877.0 1897.1 1899.6 1916.2 1932.1 26800.5 27062.1 27073.5 27098.5 27130.9 6622.4 6878.5 6886.0 6982.4 7063.1 17192.3 17224.6 17272.9 17304.9 17316.1 7807.8 8091.6 8100.4 8101.4 8103.2 7303.4 7308.2 7470.2 7484.1 7510.8 5095.7 5171.7 5204.2 5278.7 5474.3 1417.5 1465.9 1580.9 1589.2 1635.7 779.7 905.7 908.8 909.7 910.8 8555.6 8998.6 9044.5 9045.4 9091.3 956.8 976.3 985.3 986.9 987.7 4624.7 5210.6 5342.0 5375.9 5616.2 20903.3 21856.2 21896.5 22033.7 22116.1 21099.0 21441.4 21530.4 21587.6 21733.3 11144.1 11572.3 11575.5 11578.2 11596.8 8430.3 8498.5 8519.2 8601.3 8682.1 17620.8 18109.6 18571.4 18927.1 18964.0 18792.0 19024.0 19073.9 19504.0 19582.8 11132.3 11195.4 11286.2 11297.6 11330.7 13703.2 13725.5 13731.1 13806.7 13812.7 11514.6 11538.6 11629.4 11798.0 11945.6 10931.8 11100.2 11219.2 11292.5 11297.8 10111.1 10216.2 10272.6 10272.7 10276.0 7579.7 7616.7 7670.5 7733.5 7739.0 7676.5 7768.0 7779.5 7810.1 7852.8 02:50:55 INFO - PID 12760 | 02:50:55 INFO - PID 12760 | [#4] prototype.html Cycles:180 Average:5578.81 Median:6274.15 stddev:1570.87 (25.0%) stddev-sans-first:1528.15 02:50:55 INFO - PID 12760 | Values: 491.0 507.2 527.1 529.4 530.7 6404.7 6422.3 6448.9 6481.8 6492.5 6163.2 6216.1 6242.5 6277.7 6293.1 4962.0 5023.9 5074.3 5111.6 5115.3 4916.0 5056.2 5058.4 5083.7 5105.9 5042.7 5061.5 5063.5 5066.2 5080.4 4965.7 4981.9 5036.4 5073.0 5102.8 4472.9 4478.9 4488.5 4520.2 4539.0 6231.7 6258.1 6270.6 6304.7 6337.7 5760.9 5798.2 5804.7 5804.9 5831.4 6438.9 6489.4 6570.5 6594.4 6631.6 4872.6 4907.2 4911.8 4941.7 4941.9 6949.0 6984.3 7078.8 7089.4 7118.9 5017.5 5044.7 5077.3 5079.5 5086.3 5067.5 5071.6 5127.9 5131.2 5153.2 5741.9 5746.5 5788.5 5797.9 5809.8 6698.2 6698.7 6698.9 6716.1 6725.5 1684.3 1714.2 1722.7 1745.0 1761.2 1196.8 1230.7 1232.6 1232.7 1235.5 5739.3 5762.3 5789.2 5793.9 5874.1 6571.2 6685.9 6750.3 6758.7 6767.0 5901.4 5901.6 5909.2 5918.8 5979.6 3508.8 3567.5 3596.6 3649.2 3674.3 6469.8 6504.6 6520.3 6575.7 6579.8 6894.9 6971.3 6991.4 7010.8 7022.4 6446.2 6488.2 6537.7 6541.1 6584.8 6698.7 6728.0 6738.4 6746.3 6857.5 6739.8 6744.3 6769.5 6815.0 6816.5 6458.6 6529.4 6626.4 6675.5 6686.0 5002.0 5034.3 5068.3 5076.1 5104.5 6856.8 6916.3 6918.5 6930.7 6980.9 6610.0 6649.2 6672.0 6708.5 6708.6 6443.0 6470.9 6505.4 6550.3 6557.0 6316.0 6331.7 6446.4 6472.9 6576.3 6497.8 6574.7 6621.1 6650.2 6670.8 6289.7 6385.8 6385.8 6416.2 6452.6 02:50:55 INFO - PID 12760 | 02:50:55 INFO - PID 12760 | [#5] yui.html Cycles:180 Average:24478.18 Median:19422.21 stddev:35426.71 (182.4%) stddev-sans-first:35481.89 02:50:55 INFO - PID 12760 | Values: 909.2 913.4 927.6 934.1 937.6 19100.5 20018.0 20046.6 20086.1 20130.8 18719.3 18971.6 18982.1 18989.0 18994.4 941.5 954.5 958.9 959.2 960.7 971.5 978.7 979.4 979.6 979.8 986.9 1020.1 1024.5 1029.5 1031.8 1024.0 1026.2 1026.2 1026.5 1026.9 722.1 743.7 753.9 755.4 757.0 19743.9 19784.7 20020.9 20073.6 20078.6 21697.3 21715.3 22261.4 22487.1 22493.7 16036.4 17019.5 17082.9 17147.7 17196.1 3705.0 3749.5 3763.3 3764.3 3779.1 103140.6 136433.0 137549.0 138132.3 138149.0 16858.4 17388.7 17551.0 17572.0 17583.7 31896.4 32978.2 33095.0 33134.8 33142.0 9064.8 9132.8 9172.6 9185.3 9197.8 4362.1 4441.2 4446.5 4450.1 4473.5 5269.1 5322.9 5330.3 5346.8 5348.2 1000.3 1057.9 1059.2 1060.4 1069.8 700.8 714.4 714.8 731.0 732.7 12305.9 12336.9 12374.3 12423.1 12618.2 670.8 678.8 692.6 694.4 694.7 5229.5 5394.4 5399.6 5494.3 5505.2 123327.0 124256.0 125135.0 130473.0 130787.0 111334.0 112278.4 113012.0 116237.0 117506.0 95574.5 97407.0 98836.0 99574.0 100781.5 10126.4 10152.7 10209.7 10228.6 10364.8 42675.0 43554.6 44041.0 44242.0 44420.3 54517.5 56065.0 56936.0 57469.0 57832.0 15985.6 16260.1 16458.3 16478.5 16754.8 15852.4 15880.6 15917.4 16003.6 16050.1 16249.7 16303.1 16455.4 16633.6 16650.4 14638.3 14819.6 14847.8 14948.2 14949.0 15649.3 15657.2 15727.8 15848.2 15859.5 11492.7 11641.2 11759.8 11975.3 12046.1 12729.8 12832.9 12906.7 12937.7 13136.0 02:50:55 INFO - PID 12760 | -------- Summary: end -------- 02:50:55 INFO - PID 12760 | 02:50:56 INFO - TEST-INFO | 12760: exit 0 02:50:56 INFO - TEST-OK | dromaeo_css | took 1109626ms 02:50:56 INFO - TEST-START | kraken 02:50:56 INFO - Initialising browser for kraken test... 02:50:56 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:51421/getInfo.html -profile /tmp/tmp9UZCTn/profile 02:50:56 INFO - TEST-INFO | started process 13130 (/builds/slave/test/build/application/firefox/firefox http://localhost:51421/getInfo.html) 02:51:01 INFO - TEST-INFO | 13130: exit 0 02:51:02 INFO - Browser initialized. 02:51:02 INFO - Running cycle 1/1 for kraken test... 02:51:02 INFO - Using env: {'DISPLAY': ':0', 02:51:02 INFO - 'HOME': '/home/cltbld', 02:51:02 INFO - 'JSGC_DISABLE_POISONING': '1', 02:51:02 INFO - 'LANG': 'en_US.UTF-8', 02:51:02 INFO - 'LANGUAGE': 'en_US:en', 02:51:02 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 02:51:02 INFO - 'LOGNAME': 'cltbld', 02:51:02 INFO - 'MAIL': '/var/mail/cltbld', 02:51:02 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 02:51:02 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 02:51:02 INFO - 'MOZ_CRASHREPORTER': '1', 02:51:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:51:02 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 02:51:02 INFO - 'MOZ_NO_REMOTE': '1', 02:51:02 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 02:51:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:51:02 INFO - 'NO_EM_RESTART': '1', 02:51:02 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:51:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:51:02 INFO - 'PWD': '/builds/slave/test', 02:51:02 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 02:51:02 INFO - 'RUST_BACKTRACE': 'full', 02:51:02 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 02:51:02 INFO - 'SHELL': '/bin/bash', 02:51:02 INFO - 'SHLVL': '1', 02:51:02 INFO - 'STYLO_FORCE_DISABLED': '1', 02:51:02 INFO - 'TERM': 'linux', 02:51:02 INFO - 'TMOUT': '86400', 02:51:02 INFO - 'USER': 'cltbld', 02:51:02 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1505377061.210318-221390492', 02:51:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:51:02 INFO - '_': '/tools/buildbot/bin/python'} 02:51:02 INFO - TEST-INFO | started process 13363 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp9UZCTn/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 02:51:03 INFO - PID 13363 | 02:51:03 INFO - PID 13363 | (/builds/slave/test/build/application/firefox/firefox:13412): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 02:51:03 INFO - PID 13363 | 02:51:13 INFO - PID 13363 | RSS: Main: 172986368 02:51:13 INFO - PID 13363 | 02:51:15 INFO - PID 13363 | Cycle 1(1): loaded http://localhost:51421/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:51421/tests/kraken/driver.html?testName=audio-beat-detection) 02:51:16 INFO - PID 13363 | RSS: Main: 177897472 02:51:16 INFO - PID 13363 | 02:51:19 INFO - PID 13363 | Cycle 1(1): loaded http://localhost:51421/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:51421/tests/kraken/driver.html?testName=audio-dft) 02:51:20 INFO - PID 13363 | RSS: Main: 178081792 02:51:20 INFO - PID 13363 | 02:51:23 INFO - PID 13363 | Cycle 1(1): loaded http://localhost:51421/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:51421/tests/kraken/driver.html?testName=audio-fft) 02:51:23 INFO - PID 13363 | RSS: Main: 173629440 02:51:23 INFO - PID 13363 | 02:51:25 INFO - PID 13363 | Cycle 1(1): loaded http://localhost:51421/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:51421/tests/kraken/driver.html?testName=audio-oscillator) 02:51:26 INFO - PID 13363 | RSS: Main: 174874624 02:51:26 INFO - PID 13363 | 02:51:28 INFO - PID 13363 | Cycle 1(1): loaded http://localhost:51421/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:51421/tests/kraken/driver.html?testName=imaging-gaussian-blur) 02:51:29 INFO - PID 13363 | RSS: Main: 174874624 02:51:29 INFO - PID 13363 | 02:51:32 INFO - PID 13363 | Cycle 1(1): loaded http://localhost:51421/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:51421/tests/kraken/driver.html?testName=imaging-darkroom) 02:51:32 INFO - PID 13363 | RSS: Main: 177364992 02:51:33 INFO - PID 13363 | 02:51:36 INFO - PID 13363 | Cycle 1(1): loaded http://localhost:51421/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:51421/tests/kraken/driver.html?testName=imaging-desaturate) 02:51:37 INFO - PID 13363 | RSS: Main: 177377280 02:51:37 INFO - PID 13363 | 02:51:40 INFO - PID 13363 | Cycle 1(1): loaded http://localhost:51421/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:51421/tests/kraken/driver.html?testName=json-parse-financial) 02:51:40 INFO - PID 13363 | RSS: Main: 177680384 02:51:40 INFO - PID 13363 | 02:51:42 INFO - PID 13363 | Cycle 1(1): loaded http://localhost:51421/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:51421/tests/kraken/driver.html?testName=json-stringify-tinderbox) 02:51:43 INFO - PID 13363 | RSS: Main: 177516544 02:51:43 INFO - PID 13363 | 02:51:44 INFO - PID 13363 | Cycle 1(1): loaded http://localhost:51421/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:51421/tests/kraken/driver.html?testName=stanford-crypto-aes) 02:51:45 INFO - PID 13363 | RSS: Main: 177401856 02:51:45 INFO - PID 13363 | 02:51:47 INFO - PID 13363 | Cycle 1(1): loaded http://localhost:51421/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:51421/tests/kraken/driver.html?testName=stanford-crypto-ccm) 02:51:48 INFO - PID 13363 | RSS: Main: 174616576 02:51:48 INFO - PID 13363 | 02:51:50 INFO - PID 13363 | Cycle 1(1): loaded http://localhost:51421/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:51421/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 02:51:51 INFO - PID 13363 | RSS: Main: 175177728 02:51:51 INFO - PID 13363 | 02:51:54 INFO - PID 13363 | Cycle 1(1): loaded http://localhost:51421/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:51421/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 02:51:54 INFO - PID 13363 | RSS: Main: 175169536 02:51:54 INFO - PID 13363 | 02:51:56 INFO - PID 13363 | Cycle 1(1): loaded http://localhost:51421/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:51421/tests/kraken/driver.html?testName=ai-astar) 02:51:56 INFO - PID 13363 | RSS: Main: 176472064 02:51:56 INFO - PID 13363 | 02:51:56 INFO - PID 13363 | __start_tp_report 02:51:56 INFO - PID 13363 | _x_x_mozilla_page_load 02:51:56 INFO - PID 13363 | _x_x_mozilla_page_load_details 02:51:56 INFO - PID 13363 | |i|pagename|runs| 02:51:56 INFO - PID 13363 | |0;ai-astar;109;108;106;107;106;107;108;109;107;107 02:51:56 INFO - PID 13363 | |1;audio-beat-detection;117;117;117;119;116;116;153;115;120;119 02:51:56 INFO - PID 13363 | |2;audio-dft;163;161;163;161;160;163;162;164;174;163 02:51:56 INFO - PID 13363 | |3;audio-fft;75;76;77;74;74;73;73;74;81;75 02:51:56 INFO - PID 13363 | |4;audio-oscillator;79;79;79;78;79;79;78;79;79;80 02:51:56 INFO - PID 13363 | |5;imaging-gaussian-blur;114;114;113;115;115;116;113;114;113;117 02:51:56 INFO - PID 13363 | |6;imaging-darkroom;157;149;149;149;148;148;150;147;148;147 02:51:56 INFO - PID 13363 | |7;imaging-desaturate;95;94;94;93;94;94;94;96;94;95 02:51:56 INFO - PID 13363 | |8;json-parse-financial;54;55;54;54;55;53;52;53;54;55 02:51:56 INFO - PID 13363 | |9;json-stringify-tinderbox;38;38;42;37;42;42;43;42;42;43 02:51:56 INFO - PID 13363 | |10;stanford-crypto-aes;76;78;72;75;74;75;74;74;78;73 02:51:56 INFO - PID 13363 | |11;stanford-crypto-ccm;119;116;112;115;119;117;109;117;113;111 02:51:56 INFO - PID 13363 | |12;stanford-crypto-pbkdf2;182;176;177;173;167;163;166;169;171;177 02:51:56 INFO - PID 13363 | |13;stanford-crypto-sha256-iterative;67;65;65;65;68;74;63;64;62;67 02:51:56 INFO - PID 13363 | __end_tp_report 02:51:56 INFO - PID 13363 | __start_cc_report 02:51:56 INFO - PID 13363 | _x_x_mozilla_cycle_collect,955 02:51:56 INFO - PID 13363 | __end_cc_report 02:51:56 INFO - PID 13363 | __startTimestamp1505382716957__endTimestamp 02:51:56 INFO - PID 13363 | 02:51:56 INFO - PID 13363 | ------- Summary: start ------- 02:51:56 INFO - PID 13363 | Number of tests: 14 02:51:56 INFO - PID 13363 | 02:51:56 INFO - PID 13363 | [#0] ai-astar Cycles:10 Average:107.40 Median:107.50 stddev:1.07 (1.0%) stddev-sans-first:0.97 02:51:56 INFO - PID 13363 | Values: 109.0 108.0 106.0 107.0 106.0 107.0 108.0 109.0 107.0 107.0 02:51:56 INFO - PID 13363 | 02:51:56 INFO - PID 13363 | [#1] audio-beat-detection Cycles:10 Average:120.90 Median:118.00 stddev:11.39 (9.6%) stddev-sans-first:11.99 02:51:56 INFO - PID 13363 | Values: 117.0 117.0 117.0 119.0 116.0 116.0 153.0 115.0 120.0 119.0 02:51:56 INFO - PID 13363 | 02:51:56 INFO - PID 13363 | [#2] audio-dft Cycles:10 Average:163.40 Median:163.00 stddev:3.92 (2.4%) stddev-sans-first:4.16 02:51:56 INFO - PID 13363 | Values: 163.0 161.0 163.0 161.0 160.0 163.0 162.0 164.0 174.0 163.0 02:51:56 INFO - PID 13363 | 02:51:56 INFO - PID 13363 | [#3] audio-fft Cycles:10 Average:75.20 Median:75.00 stddev:2.39 (3.2%) stddev-sans-first:2.54 02:51:56 INFO - PID 13363 | Values: 75.0 76.0 77.0 74.0 74.0 73.0 73.0 74.0 81.0 75.0 02:51:56 INFO - PID 13363 | 02:51:56 INFO - PID 13363 | [#4] audio-oscillator Cycles:10 Average:78.90 Median:79.00 stddev:0.57 (0.7%) stddev-sans-first:0.60 02:51:56 INFO - PID 13363 | Values: 79.0 79.0 79.0 78.0 79.0 79.0 78.0 79.0 79.0 80.0 02:51:56 INFO - PID 13363 | 02:51:56 INFO - PID 13363 | [#5] imaging-gaussian-blur Cycles:10 Average:114.40 Median:114.50 stddev:1.35 (1.2%) stddev-sans-first:1.42 02:51:56 INFO - PID 13363 | Values: 114.0 114.0 113.0 115.0 115.0 116.0 113.0 114.0 113.0 117.0 02:51:56 INFO - PID 13363 | 02:51:56 INFO - PID 13363 | [#6] imaging-darkroom Cycles:10 Average:149.20 Median:149.00 stddev:2.90 (1.9%) stddev-sans-first:1.00 02:51:56 INFO - PID 13363 | Values: 157.0 149.0 149.0 149.0 148.0 148.0 150.0 147.0 148.0 147.0 02:51:56 INFO - PID 13363 | 02:51:56 INFO - PID 13363 | [#7] imaging-desaturate Cycles:10 Average:94.30 Median:94.00 stddev:0.82 (0.9%) stddev-sans-first:0.83 02:51:56 INFO - PID 13363 | Values: 95.0 94.0 94.0 93.0 94.0 94.0 94.0 96.0 94.0 95.0 02:51:56 INFO - PID 13363 | 02:51:56 INFO - PID 13363 | [#8] json-parse-financial Cycles:10 Average:53.90 Median:54.00 stddev:0.99 (1.8%) stddev-sans-first:1.05 02:51:56 INFO - PID 13363 | Values: 54.0 55.0 54.0 54.0 55.0 53.0 52.0 53.0 54.0 55.0 02:51:56 INFO - PID 13363 | 02:51:56 INFO - PID 13363 | [#9] json-stringify-tinderbox Cycles:10 Average:40.90 Median:42.00 stddev:2.28 (5.4%) stddev-sans-first:2.17 02:51:56 INFO - PID 13363 | Values: 38.0 38.0 42.0 37.0 42.0 42.0 43.0 42.0 42.0 43.0 02:51:56 INFO - PID 13363 | 02:51:56 INFO - PID 13363 | [#10] stanford-crypto-aes Cycles:10 Average:74.90 Median:75.00 stddev:1.97 (2.6%) stddev-sans-first:2.05 02:51:56 INFO - PID 13363 | Values: 76.0 78.0 72.0 75.0 74.0 75.0 74.0 74.0 78.0 73.0 02:51:56 INFO - PID 13363 | 02:51:56 INFO - PID 13363 | [#11] stanford-crypto-ccm Cycles:10 Average:114.80 Median:116.50 stddev:3.43 (2.9%) stddev-sans-first:3.28 02:51:56 INFO - PID 13363 | Values: 119.0 116.0 112.0 115.0 119.0 117.0 109.0 117.0 113.0 111.0 02:51:56 INFO - PID 13363 | 02:51:56 INFO - PID 13363 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:172.10 Median:174.50 stddev:5.95 (3.4%) stddev-sans-first:5.12 02:51:56 INFO - PID 13363 | Values: 182.0 176.0 177.0 173.0 167.0 163.0 166.0 169.0 171.0 177.0 02:51:56 INFO - PID 13363 | 02:51:56 INFO - PID 13363 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.00 Median:66.00 stddev:3.37 (5.1%) stddev-sans-first:3.55 02:51:56 INFO - PID 13363 | Values: 67.0 65.0 65.0 65.0 68.0 74.0 63.0 64.0 62.0 67.0 02:51:56 INFO - PID 13363 | -------- Summary: end -------- 02:51:56 INFO - PID 13363 | 02:51:57 INFO - PID 13363 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 02:51:57 INFO - TEST-INFO | 13363: exit 0 02:51:57 INFO - TEST-OK | kraken | took 60970ms 02:51:57 INFO - SUITE-END | took 1170s 02:51:58 INFO - Completed test suite (00:19:31) 02:51:58 INFO - javascript benchmark 02:51:58 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s", "stylo_disabled"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8644.450584242639, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3135.043811637451, 3147.213196700825, 3205.423023855705, 3213.983930080349, 3229.8546565404554, 6134.509239260859, 6253.656048917308, 6279.686015699214, 6344.080108384287, 6413.262474815392, 6232.283287421937, 6236.251649802019, 6246.968765156168, 6290.622562646245, 6309.5267854910835, 5777.566682498808, 5879.118132280149, 5895.528357731393, 5900.43945825146, 5915.497182739472, 5870.442307980735, 5923.0, 5956.047032474805, 5963.403659634046, 5972.6715030673295, 1260.701501646808, 5451.2640793492765, 5728.312602487707, 5744.0, 5881.647101173943, 5802.564807639444, 5809.7095145242565, 5870.178175055496, 5893.116032595102, 5895.29256489224, 5724.685142317171, 5789.942100578983, 5864.560157988168, 5866.14940833581, 5871.647701137903, 6295.401936815995, 6327.27236367819, 6336.303006669263, 6370.681465926731, 6404.519661025442, 6614.0, 6765.357291057391, 6767.796966090976, 6841.452683785285, 6866.485013623948, 6771.356721111487, 6776.05135281061, 6791.252962174157, 6794.762183323609, 6815.863682726318, 6290.905636415411, 6301.842453938688, 6313.494920406402, 6334.714937827809, 6394.968025159845, 6991.825204369931, 7088.787336379917, 7101.538400003983, 7138.321859423347, 7142.500024998304, 6674.799756007327, 6683.365080317362, 6704.83237919056, 6762.661866906635, 6775.695093720795, 6642.535022548375, 6750.054992301082, 6758.8648227036165, 6759.188897332253, 6861.519693621499, 6620.937367489001, 6669.866602667919, 6683.164604424447, 6714.127163468718, 6716.395524402729, 6727.66361681914, 6740.494462915301, 6740.696668649923, 6850.760223392157, 6867.07294515244, 5199.428062913076, 5265.578753699695, 5267.236250743697, 5275.525202731773, 5281.867953301198, 4583.427071616048, 4606.378138951199, 4637.118947399983, 4683.0, 4685.882852928704, 5703.771849126071, 5788.218590490314, 5810.738516766755, 5859.2090067841145, 5870.148828419855, 6738.157730283715, 6799.694013769392, 6812.931870681329, 6819.283975182534, 6868.313168683192, 5810.448007439287, 5860.70696465175, 5896.970515147483, 5897.557683173779, 5907.054871220584, 5826.708664566755, 5836.766529338864, 5904.704764761745, 5906.350301466835, 5909.586328957018, 6442.9355706443275, 6532.738690452424, 6545.607263564201, 6587.275399706028, 6673.799786006428, 6738.49461290415, 6740.157480315059, 6767.39093481589, 6770.187577490733, 6770.390664840188, 6433.324500927335, 6483.319251478527, 6513.5114866384265, 6533.967330163318, 6616.636085015371, 6687.364700353459, 6765.830854228684, 6781.38967492928, 6800.693968771516, 6810.659467026728, 6846.315368463114, 6862.142232220973, 6942.618156001468, 6953.582785032914, 6957.9304206959305, 6421.678916054272, 6563.7702680405955, 6590.373914478117, 6595.208574971034, 6682.031105489579, 6536.248331441755, 6536.3136870627895, 6546.770863019771, 6555.016747487915, 6558.901616475661, 6532.510061745483, 6544.476441884733, 6549.115869357766, 6601.9009714853355, 6613.5370524062855, 6622.635755033327, 6660.56706314088, 6725.29384414649, 6732.192136943598, 6736.461083113437, 6402.679866006588, 6441.6135031896365, 6502.772402965874, 6506.674666266573, 6527.3472652734345], "value": 6147.696254585293, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [861.0872475176313, 882.4220135811046, 886.5611522296468, 888.0985799413593, 891.2736120062149, 38581.80709096454, 42336.36495452571, 42377.36433953493, 42481.787591062, 42493.15013699724, 38382.424263636, 38465.80767096161, 38701.032474188156, 38772.418413723746, 38816.61183388165, 6985.05701730265, 7075.716971321141, 7102.893456598155, 7116.110486189226, 7118.074650295454, 6763.18841738992, 6781.186257649089, 6825.556338837984, 6835.418989385908, 7030.121234845645, 6753.088333075021, 6810.114685090931, 6830.419414349786, 6905.067815844872, 7515.511491753018, 7573.810654733621, 7677.616119194018, 7693.49992250502, 7696.807579810494, 7702.768916932473, 7513.985611942372, 7601.163871974079, 7601.391888648895, 7601.7719468416035, 7603.0, 37931.24137517234, 38518.22963540714, 38576.42135367972, 38664.0, 38750.80624596887, 3411.5053317269103, 3439.3465241604267, 3478.4086705260165, 3483.2685136121445, 3483.4426491761196, 32160.517592236134, 32198.195045123826, 32313.51529727056, 32316.83841580777, 32381.352372952646, 5211.635185537014, 5213.296205012312, 5222.0861349264105, 5225.137852254374, 5232.555232805216, 182083.0, 183626.0, 183923.0, 183984.0, 184381.99999999866, 42937.141257174684, 43800.342994855106, 48624.75687621539, 48687.51312486901, 49631.75184124056, 52381.0, 52710.47289527133, 52717.47282527126, 52717.736411317695, 52765.736171318895, 16631.501054968372, 16715.498535043967, 16777.1611419431, 16786.916065419595, 16789.076600787073, 13640.113392629448, 13673.31633418345, 13681.179129252278, 13694.589162325146, 13834.23911684867, 14380.280985950661, 14410.711785764226, 14432.350544225324, 14516.346764395628, 14606.707865842624, 5732.111522713986, 5768.221290125779, 5819.301683797887, 5849.64902105875, 5973.731182096816, 997.1275134257525, 1004.9849252261222, 1016.1261315268863, 1027.060239880501, 1031.566741968375, 22937.197198097987, 23247.0, 23275.7672423277, 23296.184633537745, 23357.182498612467, 1097.7397130522336, 1101.730076131337, 1104.9447527623586, 1108.4845546820768, 1108.9778204435866, 12266.38668066611, 12345.691357716129, 12384.009279257638, 12446.593713388484, 12516.936060434966, 226691.0, 227887.0, 228321.0, 228785.0, 228927.0, 52202.0, 52442.21336679953, 52570.73714631479, 52696.0, 52781.2082818758, 1441.9206943617992, 1453.6596475766696, 1469.7868809022632, 1487.9181645009628, 1490.93290801912, 22824.54350912939, 22895.54208915779, 23003.6549451755, 23039.76960230376, 23075.0, 37615.62384376121, 37740.43389349217, 37757.622423775414, 37780.0, 37800.62199378081, 200353.0, 200808.0, 200850.0, 201275.0, 202614.0, 30247.848760756056, 30652.693473064985, 33622.49566256557, 33741.66258337385, 34101.0, 40196.3970540448, 41941.58058419377, 42362.94092647709, 42385.0, 42640.36039459349, 31135.53296700506, 31566.210844729067, 31601.5259771099, 31864.52203217, 32035.679643203268, 30535.0, 30641.233969150948, 30967.845160774054, 30985.0, 31400.214994625316, 34721.826390867885, 34729.47905781466, 34824.65175348214, 35105.0, 35136.64863351436, 30309.242268943453, 30323.0, 30324.241893951945, 30746.846265768527, 31090.68909310878, 22721.863906804923, 23088.653670195297, 23173.768262317837, 23233.186838460573, 23256.186033488746], "value": 16950.501724780865, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [562.213492130501, 564.9011423000974, 572.5162237908968, 575.9086531023707, 579.4466284698113, 21564.56870862582, 22348.10607575695, 22353.77646223537, 22356.776432235674, 22446.989885455132, 23839.0, 24401.511969760595, 24769.75230247697, 24907.0, 25461.0, 6442.806715798533, 6501.902471462932, 6507.186601674791, 6517.478601711875, 6535.150430444036, 6436.163298771153, 6524.673766311689, 6533.15069041024, 6542.051402546628, 6879.6216208108535, 7157.0, 7207.927920720805, 7211.927880721178, 7212.639368031603, 7217.639118044077, 6853.4174595159475, 7154.749583764569, 7161.713531458736, 7167.211606723256, 7208.819779505554, 7045.859082818366, 7050.153981522199, 7056.788296351117, 7057.5412598181465, 7059.152901651783, 31332.21669458259, 31820.681793182233, 32066.519002214984, 32072.679273207203, 32101.678983210102, 1985.8411327093797, 1997.7602687677572, 2006.3679940818595, 2010.6079314533672, 2017.535966727661, 20572.79427205739, 20837.479063023395, 21357.78642213589, 21393.0, 21521.7086974782, 2480.6651102101164, 2518.584433568459, 2568.447783726489, 2575.0, 2579.587266037425, 118081.40959295235, 123188.0, 131986.0, 137981.0, 138253.0, 19347.8065219346, 20882.47793805167, 21001.264955726478, 21104.261350852645, 22199.1120355184, 42113.0, 42239.788801055794, 42341.36487952683, 42528.362074568904, 42623.14753704909, 11476.770464590829, 11518.251313664585, 11619.419029048513, 11646.184767066225, 11658.242214256046, 9638.132568068908, 9675.758106047406, 9719.805603887882, 9809.607615695293, 9856.408615483095, 10964.725881853017, 11086.61196858106, 11181.944090279496, 11376.715582110513, 11498.0, 3675.7794532328144, 3806.7715937043868, 4174.791260437027, 4212.599803018708, 4345.718497788623, 921.488573841511, 961.7499450142873, 973.9464329461806, 983.0611765763679, 991.8363470027365, 19263.614727705368, 19499.805001950084, 19569.804301957083, 19792.505187370432, 19886.50283742918, 985.1872205430549, 990.1929927109383, 1018.2261481274285, 1045.8744950605976, 1048.784999075203, 10818.783624327469, 10820.02619764225, 10843.240973131962, 10910.23628346024, 10950.014498695156, 440948.0, 442630.0, 448648.0, 448745.0, 457569.0, 110040.4497977505, 112976.43511782389, 116253.41873290579, 116614.0, 117073.0, 1060.3955745225148, 1108.467935391017, 1115.59838458155, 1150.6433005768238, 1151.9596814111633, 20453.488662782955, 20506.89746551258, 20590.0, 20629.484262893548, 20801.0, 52793.7360313196, 53030.73484632552, 53359.0, 53682.0, 54790.0, 63407.36592634015, 64047.0, 64729.67635161794, 65016.67491662512, 65333.0, 19014.904925475283, 19753.703694444306, 19886.409087272696, 19907.203711851944, 20022.0, 22565.210217642303, 22570.77429225687, 22572.88713556422, 22949.082036718344, 23049.078036879007, 17684.91157544204, 18114.72827907556, 18227.088645567404, 18370.448886533424, 18474.907625461787, 16407.83592164063, 16501.257443414834, 16655.0, 16975.660486790443, 17254.137293135544, 18215.817841821412, 18479.630407392047, 18721.438356849318, 18990.335338263096, 19049.14278857427, 19468.513287167934, 19568.0, 19666.90166549158, 19684.114214860652, 19761.40715778529, 17442.389516366868, 17458.563535911704, 18159.18283677264, 18539.536511587317, 18567.721484177477], "value": 12817.049243427893, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1287.246960528091, 1357.68094497793, 1368.1996032321094, 1373.1417863835104, 1380.413324337157, 15103.24483775811, 15669.843301566994, 15673.686526269468, 15682.607934801636, 15700.293486793093, 15200.239988000583, 15249.161296128708, 15259.618509537268, 15317.463888763896, 15398.30707618157, 2757.131503576367, 2774.2370848016753, 2825.4490374377006, 2832.5892745551987, 2835.1069413134796, 2755.669319681631, 2789.3445040415486, 2797.7062408447127, 2799.594058861464, 2800.2999250187454, 2677.6786785585755, 2776.01451484722, 2776.0977682253247, 2776.111644273833, 2778.3193117686196, 2770.127409865886, 2806.8877244910177, 2807.0736656903273, 2827.3355761396056, 2827.575863620463, 2737.3293543081872, 2737.4935636907235, 2759.696433392325, 2778.749912507864, 2782.318332008671, 15222.847771522365, 15226.46707365248, 15226.619334516616, 15278.38886444541, 15305.0, 8133.877991830127, 8382.455140415854, 8435.95782021092, 8456.619452124669, 8460.450070745383, 5307.6019298552765, 5407.83731497726, 5487.917681234745, 5564.415736347706, 5567.498925096761, 1876.9624607507774, 1897.127321432143, 1899.591587808614, 1916.1568909679697, 1932.0726051495221, 26800.463990720076, 27062.052828151118, 27073.45853082947, 27098.45803083947, 27130.864345678343, 6622.437092847162, 6878.484113691493, 6886.001529778255, 6982.441404687613, 7063.081799366049, 17192.31230750781, 17224.569385765455, 17272.91363543174, 17304.913475432542, 17316.134193290283, 7807.80480487981, 8091.55496447701, 8100.351971842357, 8101.392395570356, 8103.230193131643, 7303.415726741848, 7308.159561650372, 7470.178280389153, 7484.1393239777035, 7510.774676759706, 5095.694258344512, 5171.741412929338, 5204.167333226741, 5278.656887302313, 5474.288342515448, 1417.4897037066648, 1465.9267036648125, 1580.9051456912623, 1589.2292238264433, 1635.7219272723667, 779.742684913977, 905.6603773584906, 908.8227795579799, 909.6770646420558, 910.7677542226822, 8555.572221388906, 8998.640054397882, 9044.502552359552, 9045.366824322235, 9091.31815113869, 956.784723437235, 976.2677991506371, 985.3053597213947, 986.8766404199475, 987.7481242283171, 4624.676272660949, 5210.5831533477985, 5342.038433082005, 5375.865603359947, 5616.157576363578, 20903.268385606432, 21856.235031773813, 21896.45258868541, 22033.669494957587, 22116.115355385926, 21099.0, 21441.356759297247, 21530.354089377342, 21587.56824863494, 21733.347999559723, 11144.108471322275, 11572.305661660159, 11575.536978520764, 11578.247413918069, 11596.768064638829, 8430.277532402148, 8498.490090594583, 8519.190676885686, 8601.268892144239, 8682.088380720186, 17620.82379176192, 18109.63780724352, 18571.44285671432, 18927.148278327782, 18964.0, 18792.0, 19024.0, 19073.904630476758, 19504.0, 19582.804171958098, 11132.276402033842, 11195.384253866116, 11286.20996530235, 11297.604583839526, 11330.716732081764, 13703.246321452416, 13725.519606813714, 13731.107478013897, 13806.723865522432, 13812.654683632989, 11514.596989105341, 11538.59614913474, 11629.418529073344, 11798.0, 11945.641630751092, 10931.83602245951, 11100.167487438635, 11219.214654974074, 11292.548298067984, 11297.774044519228, 10111.090001899864, 10216.182705383402, 10272.640457584248, 10272.743181420225, 10276.0, 7579.749341358614, 7616.7334143304715, 7670.463067585216, 7733.535987840747, 7739.032620922385, 7676.501027433199, 7768.0, 7779.494332868346, 7810.10183828867, 7852.842943140991], "value": 6792.615118737205, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [490.9959133571845, 507.1682440797093, 527.0960303080218, 529.4070640882212, 530.6789392417585, 6404.743810247591, 6422.325655806143, 6448.935510644898, 6481.805545833621, 6492.545521813475, 6163.167972323735, 6216.129741836146, 6242.502998800471, 6277.748890044404, 6293.056041593763, 4962.0, 5023.949760502403, 5074.264231686403, 5111.565516931066, 5115.258287548294, 4916.0, 5056.241563765428, 5058.392992840846, 5083.720395378253, 5105.8767071244265, 5042.71410790248, 5061.519155680223, 5063.5315758430015, 5066.164082926312, 5080.441151473335, 4965.652404331699, 4981.900361992758, 5036.388355726169, 5073.0, 5102.846914592568, 4472.8881777955485, 4478.8880277992985, 4488.451484237933, 4520.208963431386, 4539.0496177484565, 6231.722496888127, 6258.123862659231, 6270.561060725751, 6304.653244071575, 6337.651429171394, 5760.942390576082, 5798.202557207279, 5804.680742559158, 5804.941950580483, 5831.387704291031, 6438.939539347364, 6489.35106489352, 6570.507211959074, 6594.395213890534, 6631.602103873783, 4872.561469467765, 4907.214845624683, 4911.754412279408, 4941.654084214107, 4941.925871111936, 6948.965255173743, 6984.301569842975, 7078.752243671447, 7089.397401220903, 7118.857622847566, 5017.498250175026, 5044.722540260247, 5077.263796749525, 5079.5428411443145, 5086.262491938648, 5067.493250674903, 5071.594272458195, 5127.8718032048755, 5131.179011358165, 5153.2270159476375, 5741.8564535886935, 5746.511546518593, 5788.53691704671, 5797.88404231913, 5809.7966571170655, 6698.162729658793, 6698.7320507179165, 6698.8995165072565, 6716.059751634775, 6725.529212955144, 1684.3262694921884, 1714.2200298863986, 1722.7157519009475, 1744.9932577535935, 1761.2338632694562, 1196.7845787758288, 1230.7046308885804, 1232.5870833270776, 1232.6671798614502, 1235.4502246500401, 5739.253896993364, 5762.337331206881, 5789.247397838339, 5793.913091303634, 5874.148248503943, 6571.211454625475, 6685.866282674319, 6750.257471678112, 6758.695858686371, 6767.0, 5901.40985901415, 5901.557383196192, 5909.202257695156, 5918.822435326947, 5979.611325263844, 3508.7894726315994, 3567.518385018041, 3596.6371442701156, 3649.233660931234, 3674.3386190485435, 6469.77355792545, 6504.601181019742, 6520.347965203442, 6575.736970521221, 6579.83550411234, 6894.896576551356, 6971.268016858258, 6991.440684745208, 7010.75462358815, 7022.367986881205, 6446.194225721785, 6488.221413430419, 6537.673116344164, 6541.121906361186, 6584.76953306632, 6698.698558564779, 6727.966360168363, 6738.427233685192, 6746.325367463214, 6857.5199736018, 6739.78683836914, 6744.291849355944, 6769.526133170631, 6814.977753337039, 6816.48876334267, 6458.644774537445, 6529.412352888263, 6626.370494802986, 6675.532712710064, 6686.0, 5001.974990125026, 5034.2951986721155, 5068.315777370155, 5076.11168045598, 5104.515071068243, 6856.794296171123, 6916.273791251846, 6918.481113916577, 6930.7227710891, 6980.930190698231, 6609.9839548938035, 6649.176723383976, 6672.0, 6708.530402871752, 6708.631025293461, 6442.967785161044, 6470.899947008926, 6505.381988711065, 6550.312217217314, 6557.0, 6315.968420158054, 6331.651759153291, 6446.419822216023, 6472.902906456313, 6576.2766095730385, 6497.772577959749, 6574.737010519526, 6621.106150669791, 6650.235222949423, 6670.7665231716655, 6289.748410063729, 6385.776497822554, 6385.808425747235, 6416.197975253093, 6452.580432304885], "value": 5113.279350882778, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [909.1999040844056, 913.3697748553502, 927.6196759328676, 934.1452570897629, 937.610891480036, 19100.522486937833, 20018.0, 20046.59906801863, 20086.09612567436, 20130.798692013075, 18719.251229950787, 18971.62056758864, 18982.050897455105, 18989.0, 18994.430167095008, 941.5386460634309, 954.5227386306847, 958.9472579008186, 959.2278216036088, 960.7406000379893, 971.5142428785607, 978.6868202175307, 979.4466126638462, 979.6032606794224, 979.7599588100925, 986.9111779939803, 1020.1481762728131, 1024.5287167902773, 1029.4646783672486, 1031.8400647899587, 1023.9948800255988, 1026.1585499890093, 1026.2405819693374, 1026.5483187397558, 1026.8870424253364, 722.1442590530186, 743.680217506472, 753.8529986652605, 755.4296506137886, 757.0310003195918, 19743.901280493505, 19784.70322945157, 20020.899895500574, 20073.598528029503, 20078.598428031502, 21697.34907952764, 21715.34853954384, 22261.44346391337, 22487.100515979342, 22493.662595061087, 16036.35854565816, 17019.48941531756, 17082.914585426992, 17147.657046859116, 17196.05421701806, 3705.0366904604725, 3749.531308586427, 3763.2849758546063, 3764.3412402829395, 3779.0741268389147, 103140.5553445416, 136433.0, 137549.0, 138132.30933845468, 138149.0, 16858.40995565174, 17388.739168912478, 17551.0, 17572.0, 17583.73624395635, 31896.362072758417, 32978.17554561155, 33095.0, 33134.8343258287, 33142.0, 9064.818703625891, 9132.81734365309, 9172.633094676272, 9185.311101667401, 9197.81604367909, 4362.1275744851155, 4441.244988351988, 4446.5331140230455, 4450.132224216311, 4473.507914129443, 5269.051570717308, 5322.893542129135, 5330.333708286465, 5346.759395827197, 5348.197770334481, 1000.2897942460788, 1057.9047885690325, 1059.2055958031476, 1060.4326685223368, 1069.8020866139789, 700.831800367908, 714.4284572342106, 714.7641278378122, 730.9634518274065, 732.7215658049907, 12305.93847030759, 12336.938315308545, 12374.257544547356, 12423.130380873434, 12618.242905425705, 670.8121725916751, 678.8065401360687, 692.62944324786, 694.4236283884364, 694.6769752065213, 5229.52934235913, 5394.433584473573, 5399.568034557226, 5494.340679118532, 5505.229267902497, 123327.0, 124256.0, 125135.0, 130473.0, 130787.0, 111334.0, 112278.43860780644, 113012.0, 116237.0, 117506.0, 95574.52212738892, 97407.0, 98836.0, 99574.0, 100781.49609251907, 10126.44304563256, 10152.695419137437, 10209.74475638115, 10228.64199753005, 10364.844527332247, 42675.0, 43554.56445435505, 44041.01815418378, 44242.0, 44420.333694993955, 54517.45482545124, 56065.0, 56936.0, 57469.0, 57832.0, 15985.600359991093, 16260.105694186934, 16458.34166633369, 16478.505644830675, 16754.832451675327, 15852.44516441919, 15880.60298492547, 15917.442889498812, 16003.599910001878, 16050.117243551716, 16249.67500650004, 16303.103329317002, 16455.42406015784, 16633.584160396087, 16650.417235396704, 14638.34127464288, 14819.555413337617, 14847.777283340543, 14948.177850218342, 14949.0, 15649.29578169008, 15657.217139143226, 15727.842721572637, 15848.207589620242, 15859.52421427359, 11492.655220343404, 11641.243319184226, 11759.823602646138, 11975.28148311104, 12046.096542759504, 12729.809052864399, 12832.871671283168, 12906.741865162832, 12937.741245174855, 13136.0], "value": 8994.540396851275, "unit": "score"}]}, {"extraOptions": ["e10s", "stylo_disabled"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1426.3, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [109.0, 108.0, 106.0, 107.0, 106.0, 107.0, 108.0, 109.0, 107.0, 107.0], "value": 107.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 119.0, 116.0, 116.0, 153.0, 115.0, 120.0, 119.0], "value": 120.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 161.0, 163.0, 161.0, 160.0, 163.0, 162.0, 164.0, 174.0, 163.0], "value": 163.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 77.0, 74.0, 74.0, 73.0, 73.0, 74.0, 81.0, 75.0], "value": 75.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 79.0, 79.0, 78.0, 79.0, 79.0, 78.0, 79.0, 79.0, 80.0], "value": 78.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 114.0, 113.0, 115.0, 115.0, 116.0, 113.0, 114.0, 113.0, 117.0], "value": 114.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [157.0, 149.0, 149.0, 149.0, 148.0, 148.0, 150.0, 147.0, 148.0, 147.0], "value": 149.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 94.0, 94.0, 93.0, 94.0, 94.0, 94.0, 96.0, 94.0, 95.0], "value": 94.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 55.0, 54.0, 54.0, 55.0, 53.0, 52.0, 53.0, 54.0, 55.0], "value": 53.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [38.0, 38.0, 42.0, 37.0, 42.0, 42.0, 43.0, 42.0, 42.0, 43.0], "value": 40.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 78.0, 72.0, 75.0, 74.0, 75.0, 74.0, 74.0, 78.0, 73.0], "value": 74.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [119.0, 116.0, 112.0, 115.0, 119.0, 117.0, 109.0, 117.0, 113.0, 111.0], "value": 114.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [182.0, 176.0, 177.0, 173.0, 167.0, 163.0, 166.0, 169.0, 171.0, 177.0], "value": 172.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 65.0, 65.0, 65.0, 68.0, 74.0, 63.0, 64.0, 62.0, 67.0], "value": 66.0, "unit": "score"}]}]} 02:51:58 INFO - Return code: 0 02:51:58 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 02:51:58 INFO - # TBPL SUCCESS # 02:51:58 INFO - Running post-action listener: _package_coverage_data 02:51:58 INFO - Running post-action listener: _resource_record_post_action 02:51:58 INFO - [mozharness: 2017-09-14 09:51:58.215797Z] Finished run-tests step (success) 02:51:58 INFO - Running post-run listener: _resource_record_post_run 02:51:58 INFO - Total resource usage - Wall time: 1189s; CPU: 13.0%; Read bytes: 16384; Write bytes: 338780160; Read time: 272; Write time: 189792 02:51:58 INFO - TinderboxPrint: CPU usage
13.1% 02:51:58 INFO - TinderboxPrint: I/O read bytes / time
16,384 / 272 02:51:58 INFO - TinderboxPrint: I/O write bytes / time
338,780,160 / 189,792 02:51:58 INFO - TinderboxPrint: CPU idle
8,235.0 (86.9%) 02:51:58 INFO - TinderboxPrint: CPU user
1,194.1 (12.6%) 02:51:58 INFO - TinderboxPrint: Swap in / out
0 / 0 02:51:58 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 13082624; Read time: 0; Write time: 956 02:51:58 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 02:51:58 INFO - run-tests - Wall time: 1172s; CPU: 13.0%; Read bytes: 12288; Write bytes: 325697536; Read time: 252; Write time: 188836 02:51:58 INFO - Running post-run listener: _upload_blobber_files 02:51:58 INFO - Blob upload gear active. 02:51:58 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 02:51:58 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 02:51:58 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'] 02:51:58 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 02:51:59 INFO - (blobuploader) - INFO - Open directory for files ... 02:51:59 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 02:51:59 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:51:59 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:52:06 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 02:52:06 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:52:06 INFO - (blobuploader) - INFO - Done attempting. 02:52:06 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_errorsummary.log ... 02:52:06 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:52:06 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:52:07 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-stylo-disabled-e10s_errorsummary.log: uploaded 02:52:07 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:52:07 INFO - (blobuploader) - INFO - Done attempting. 02:52:07 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 02:52:07 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:52:07 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:52:08 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 02:52:08 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:52:08 INFO - (blobuploader) - INFO - Done attempting. 02:52:08 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_raw.log ... 02:52:08 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:52:08 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:52:10 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-stylo-disabled-e10s_raw.log: uploaded 02:52:10 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:52:10 INFO - (blobuploader) - INFO - Done attempting. 02:52:10 INFO - (blobuploader) - INFO - Iteration through files over. 02:52:10 INFO - Return code: 0 02:52:10 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 02:52:10 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 02:52:10 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/2b696587bee63a34168dd8054041f73a4b06e4c61f029154962cb21d1d99ec5841f84691eebe9912ebbd398271ae758b5a63696ceebef02a89d8674f22761e23", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/5d5a2230604a78dbe95ed95a33cfd027ccda4a4958f1d6b43a7c5a590e52740b84ac5d1dae39f4d9b3be7c06f8940d59b5c4a422223f4b92f0c1763b729edbec", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/629be4047250162e8cca64cea096372f3313783b69e4e23912e2bb3b02ddc4a48ba97366e2e0fb212d4b3c10ddcf29985eb954d9db8d07d6047e2fbdfabdd5d1", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/3a36b1215632e5706e61d9758af44fb5d620fc111b4fd3d2f9fe217103876b199a32bc8e242519ebf74ceb93004343c4bb5c11bb37e684d345c02f6d2788a5c2"} 02:52:10 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 02:52:10 INFO - Writing to file /builds/slave/test/properties/blobber_files 02:52:10 INFO - Contents: 02:52:10 INFO - blobber_files:{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/2b696587bee63a34168dd8054041f73a4b06e4c61f029154962cb21d1d99ec5841f84691eebe9912ebbd398271ae758b5a63696ceebef02a89d8674f22761e23", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/5d5a2230604a78dbe95ed95a33cfd027ccda4a4958f1d6b43a7c5a590e52740b84ac5d1dae39f4d9b3be7c06f8940d59b5c4a422223f4b92f0c1763b729edbec", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/629be4047250162e8cca64cea096372f3313783b69e4e23912e2bb3b02ddc4a48ba97366e2e0fb212d4b3c10ddcf29985eb954d9db8d07d6047e2fbdfabdd5d1", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/3a36b1215632e5706e61d9758af44fb5d620fc111b4fd3d2f9fe217103876b199a32bc8e242519ebf74ceb93004343c4bb5c11bb37e684d345c02f6d2788a5c2"} 02:52:10 INFO - Running post-run listener: copy_logs_to_upload_dir 02:52:10 INFO - Copying logs to upload dir... 02:52:10 INFO - mkdir: /builds/slave/test/build/upload/logs 02:52:10 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1242.169883 ========= master_lag: 0.70 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 42 secs) (at 2017-09-14 02:52:09.999775) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-14 02:52:10.007243) ========= 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=20e666a3d4cfbb71505a330e000001b4-1505377061.210318-221390492 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/2b696587bee63a34168dd8054041f73a4b06e4c61f029154962cb21d1d99ec5841f84691eebe9912ebbd398271ae758b5a63696ceebef02a89d8674f22761e23", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/5d5a2230604a78dbe95ed95a33cfd027ccda4a4958f1d6b43a7c5a590e52740b84ac5d1dae39f4d9b3be7c06f8940d59b5c4a422223f4b92f0c1763b729edbec", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/629be4047250162e8cca64cea096372f3313783b69e4e23912e2bb3b02ddc4a48ba97366e2e0fb212d4b3c10ddcf29985eb954d9db8d07d6047e2fbdfabdd5d1", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/3a36b1215632e5706e61d9758af44fb5d620fc111b4fd3d2f9fe217103876b199a32bc8e242519ebf74ceb93004343c4bb5c11bb37e684d345c02f6d2788a5c2"} build_url:https://queue.taskcluster.net/v1/task/dyqypZ5BQ3uJrBBpjoZhjw/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011378 build_url: 'https://queue.taskcluster.net/v1/task/dyqypZ5BQ3uJrBBpjoZhjw/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/2b696587bee63a34168dd8054041f73a4b06e4c61f029154962cb21d1d99ec5841f84691eebe9912ebbd398271ae758b5a63696ceebef02a89d8674f22761e23", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/5d5a2230604a78dbe95ed95a33cfd027ccda4a4958f1d6b43a7c5a590e52740b84ac5d1dae39f4d9b3be7c06f8940d59b5c4a422223f4b92f0c1763b729edbec", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/629be4047250162e8cca64cea096372f3313783b69e4e23912e2bb3b02ddc4a48ba97366e2e0fb212d4b3c10ddcf29985eb954d9db8d07d6047e2fbdfabdd5d1", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/3a36b1215632e5706e61d9758af44fb5d620fc111b4fd3d2f9fe217103876b199a32bc8e242519ebf74ceb93004343c4bb5c11bb37e684d345c02f6d2788a5c2"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-14 02:52:10.037839) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-14 02:52:10.038140) ========= 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=20e666a3d4cfbb71505a330e000001b4-1505377061.210318-221390492 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004470 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-14 02:52:10.119708) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-14 02:52:10.121062) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-14 02:52:10.121359) ========= ========= Total master_lag: 0.91 =========