builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-068 starttime: 1505169322.98 results: success (0) revision: 85157b4b361ab9fdf7b3c3d7cf129bd3d422feac ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-09-11 15:35:22.977345) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-09-11 15:35:22.977859) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-11 15:35:22.978200) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-11 15:35:23.010714) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-11 15:35:23.010998) ========= 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=97facb8ba2ac28944cc45e6b000001d4-1505167450.332409-1360272433 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-09-11 15:35:23-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 92.1M=0s 2017-09-11 15:35:23 (92.1 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.160071 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-11 15:35:23.187951) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-11 15:35:23.188498) ========= 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=97facb8ba2ac28944cc45e6b000001d4-1505167450.332409-1360272433 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019807 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-11 15:35:23.238642) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-11 15:35:23.238977) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 85157b4b361ab9fdf7b3c3d7cf129bd3d422feac --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 85157b4b361ab9fdf7b3c3d7cf129bd3d422feac --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=97facb8ba2ac28944cc45e6b000001d4-1505167450.332409-1360272433 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-09-11 15:35:23,300 truncating revision to first 12 chars 2017-09-11 15:35:23,300 Setting DEBUG logging. 2017-09-11 15:35:23,300 attempt 1/10 2017-09-11 15:35:23,300 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/85157b4b361a?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-09-11 15:35:23,743 unpacking tar archive at: mozilla-central-85157b4b361a/testing/mozharness/ program finished with exit code 0 elapsedTime=0.758163 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-11 15:35:24.013424) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-11 15:35:24.013879) ========= script_repo_revision: 85157b4b361ab9fdf7b3c3d7cf129bd3d422feac ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-11 15:35:24.014535) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-11 15:35:24.014998) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-11 15:35:24.029392) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 40 secs) (at 2017-09-11 15:35:24.029806) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=97facb8ba2ac28944cc45e6b000001d4-1505167450.332409-1360272433 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 15:35:24 INFO - MultiFileLogger online at 20170911 15:35:24 in /builds/slave/test 15:35:24 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 15:35:24 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 15:35:24 INFO - {'append_to_log': False, 15:35:24 INFO - 'base_work_dir': '/builds/slave/test', 15:35:24 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 15:35:24 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 15:35:24 INFO - 'branch': 'Firefox-Non-PGO', 15:35:24 INFO - 'buildbot_json_path': 'buildprops.json', 15:35:24 INFO - 'code_coverage': False, 15:35:24 INFO - 'config_files': ('talos/linux_config.py',), 15:35:24 INFO - 'default_actions': ('clobber', 15:35:24 INFO - 'read-buildbot-config', 15:35:24 INFO - 'download-and-extract', 15:35:24 INFO - 'populate-webroot', 15:35:24 INFO - 'create-virtualenv', 15:35:24 INFO - 'install', 15:35:24 INFO - 'setup-mitmproxy', 15:35:24 INFO - 'run-tests'), 15:35:24 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 15:35:24 INFO - 'disable_ccov_upload': False, 15:35:24 INFO - 'disable_stylo': False, 15:35:24 INFO - 'download_minidump_stackwalk': True, 15:35:24 INFO - 'download_symbols': 'ondemand', 15:35:24 INFO - 'enable_stylo': False, 15:35:24 INFO - 'enable_webrender': False, 15:35:24 INFO - 'exes': {'tooltool.py': '/tools/tooltool.py'}, 15:35:24 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 15:35:24 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 15:35:24 INFO - 'gecko_profile': False, 15:35:24 INFO - 'gecko_profile_interval': 0, 15:35:24 INFO - 'installer_path': 'installer.exe', 15:35:24 INFO - 'log_level': 'info', 15:35:24 INFO - 'log_name': 'talos', 15:35:24 INFO - 'log_to_console': True, 15:35:24 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 15:35:24 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 15:35:24 INFO - 'opt_config_files': (), 15:35:24 INFO - 'pip_index': False, 15:35:24 INFO - 'suite': 'dromaeojs-e10s', 15:35:24 INFO - 'system_bits': '32', 15:35:24 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 15:35:24 INFO - 'title': 'talos-linux64-ix-068', 15:35:24 INFO - 'tooltool_cache': '/builds/tooltool_cache', 15:35:24 INFO - 'use_talos_json': True, 15:35:24 INFO - 'verify': 'False', 15:35:24 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 15:35:24 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 15:35:24 INFO - 'work_dir': 'build'} 15:35:24 INFO - [mozharness: 2017-09-11 22:35:24.215244Z] Running clobber step. 15:35:24 INFO - Running pre-action listener: _resource_record_pre_action 15:35:24 INFO - Running main action method: clobber 15:35:24 INFO - rmtree: /builds/slave/test/build 15:35:24 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 15:35:25 INFO - Running post-action listener: _resource_record_post_action 15:35:25 INFO - [mozharness: 2017-09-11 22:35:25.754811Z] Finished clobber step (success) 15:35:25 INFO - [mozharness: 2017-09-11 22:35:25.754908Z] Running read-buildbot-config step. 15:35:25 INFO - Running pre-action listener: _resource_record_pre_action 15:35:25 INFO - Running main action method: read_buildbot_config 15:35:25 INFO - Using buildbot properties: 15:35:25 INFO - { 15:35:25 INFO - "project": "", 15:35:25 INFO - "product": "firefox", 15:35:25 INFO - "who": "kwierso@gmail.com", 15:35:25 INFO - "installer_path": "public/build/target.tar.bz2", 15:35:25 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 15:35:25 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 15:35:25 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-e10s", 15:35:25 INFO - "stage_platform": "linux64", 15:35:25 INFO - "basedir": "/builds/slave/test", 15:35:25 INFO - "buildnumber": 1138, 15:35:25 INFO - "platform": "ubuntu64_hw", 15:35:25 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 15:35:25 INFO - "slavebuilddir": "test", 15:35:25 INFO - "taskId": "foANasB1Q32xWWSMyqFKAQ", 15:35:25 INFO - "branch": "mozilla-central", 15:35:25 INFO - "script_repo_revision": "production", 15:35:25 INFO - "revision": "85157b4b361ab9fdf7b3c3d7cf129bd3d422feac", 15:35:25 INFO - "slavename": "talos-linux64-ix-068", 15:35:25 INFO - "repo_path": "mozilla-central" 15:35:25 INFO - } 15:35:25 INFO - Finding installer, test and symbols from parent task. 15:35:25 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/foANasB1Q32xWWSMyqFKAQ'}, attempt #1 15:35:26 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/foANasB1Q32xWWSMyqFKAQ'}, attempt #1 15:35:26 INFO - Task dependencies: PxukmEXgQ0mTuA19AmBRIg 15:35:26 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/PxukmEXgQ0mTuA19AmBRIg'}, attempt #1 15:35:27 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/PxukmEXgQ0mTuA19AmBRIg/artifacts/public/build/target.tar.bz2 15:35:27 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/PxukmEXgQ0mTuA19AmBRIg/artifacts/public/build/target.test_packages.json 15:35:27 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/PxukmEXgQ0mTuA19AmBRIg/artifacts/public/build/target.crashreporter-symbols.zip 15:35:27 INFO - Running post-action listener: _resource_record_post_action 15:35:27 INFO - [mozharness: 2017-09-11 22:35:27.131768Z] Finished read-buildbot-config step (success) 15:35:27 INFO - [mozharness: 2017-09-11 22:35:27.131983Z] Running download-and-extract step. 15:35:27 INFO - Running pre-action listener: _resource_record_pre_action 15:35:27 INFO - Running main action method: download_and_extract 15:35:27 INFO - mkdir: /builds/slave/test/build/tests 15:35:27 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')]} 15:35:27 INFO - trying https://queue.taskcluster.net/v1/task/PxukmEXgQ0mTuA19AmBRIg/artifacts/public/build/target.test_packages.json 15:35:27 INFO - Downloading https://queue.taskcluster.net/v1/task/PxukmEXgQ0mTuA19AmBRIg/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 15:35:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/PxukmEXgQ0mTuA19AmBRIg/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 15:35:27 INFO - Downloaded 989 bytes. 15:35:27 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 15:35:27 INFO - Using the following test package requirements: 15:35:27 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 15:35:27 INFO - u'common': [u'target.common.tests.zip'], 15:35:27 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 15:35:27 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 15:35:27 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 15:35:27 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 15:35:27 INFO - u'mozbase': [u'target.common.tests.zip'], 15:35:27 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 15:35:27 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 15:35:27 INFO - u'web-platform': [u'target.common.tests.zip', 15:35:27 INFO - u'target.web-platform.tests.tar.gz'], 15:35:27 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 15:35:27 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite categories: ['common', 'talos'] 15:35:27 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/PxukmEXgQ0mTuA19AmBRIg/artifacts/public/build/target.common.tests.zip 15:35:27 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/PxukmEXgQ0mTuA19AmBRIg/artifacts/public/build/target.common.tests.zip'}, attempt #1 15:35:27 INFO - Fetch https://queue.taskcluster.net/v1/task/PxukmEXgQ0mTuA19AmBRIg/artifacts/public/build/target.common.tests.zip into memory 15:35:28 INFO - Content-Length response header: 55028389 15:35:28 INFO - Bytes received: 55028389 15:35:39 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/PxukmEXgQ0mTuA19AmBRIg/artifacts/public/build/target.talos.tests.zip 15:35:39 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/PxukmEXgQ0mTuA19AmBRIg/artifacts/public/build/target.talos.tests.zip'}, attempt #1 15:35:39 INFO - Fetch https://queue.taskcluster.net/v1/task/PxukmEXgQ0mTuA19AmBRIg/artifacts/public/build/target.talos.tests.zip into memory 15:35:40 INFO - Content-Length response header: 14497963 15:35:40 INFO - Bytes received: 14497963 15:35:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:35:40 INFO - trying https://queue.taskcluster.net/v1/task/PxukmEXgQ0mTuA19AmBRIg/artifacts/public/build/target.tar.bz2 15:35:40 INFO - Downloading https://queue.taskcluster.net/v1/task/PxukmEXgQ0mTuA19AmBRIg/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 15:35:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/PxukmEXgQ0mTuA19AmBRIg/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 15:35:41 INFO - Downloaded 62858707 bytes. 15:35:42 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/PxukmEXgQ0mTuA19AmBRIg/artifacts/public/build/target.tar.bz2 15:35:42 INFO - mkdir: /builds/slave/test/properties 15:35:42 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 15:35:42 INFO - Writing to file /builds/slave/test/properties/build_url 15:35:42 INFO - Contents: 15:35:42 INFO - build_url:https://queue.taskcluster.net/v1/task/PxukmEXgQ0mTuA19AmBRIg/artifacts/public/build/target.tar.bz2 15:35:42 INFO - Running post-action listener: _resource_record_post_action 15:35:42 INFO - Running post-action listener: find_tests_for_verification 15:35:42 INFO - Running post-action listener: set_extra_try_arguments 15:35:42 INFO - [mozharness: 2017-09-11 22:35:42.203619Z] Finished download-and-extract step (success) 15:35:42 INFO - [mozharness: 2017-09-11 22:35:42.203848Z] Running populate-webroot step. 15:35:42 INFO - Running pre-action listener: _resource_record_pre_action 15:35:42 INFO - Running main action method: populate_webroot 15:35:42 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 15:35:42 INFO - 'chromez-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 15:35:42 INFO - 'tests': ['tresize', 15:35:42 INFO - 'tcanvasmark']}, 15:35:42 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 15:35:42 INFO - 'dromaeojs-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 15:35:42 INFO - 'tests': ['dromaeo_css', 15:35:42 INFO - 'kraken']}, 15:35:42 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 15:35:42 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:35:42 INFO - 'g1-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 15:35:42 INFO - 'talos_options': ['--disable-stylo'], 15:35:42 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:35:42 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 15:35:42 INFO - 'tests': ['damp', 'tps']}, 15:35:42 INFO - 'g2-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 15:35:42 INFO - 'talos_options': ['--disable-stylo'], 15:35:42 INFO - 'tests': ['damp', 'tps']}, 15:35:42 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 15:35:42 INFO - 'g3-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 15:35:42 INFO - 'tests': ['dromaeo_dom']}, 15:35:42 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 15:35:42 INFO - 'g4-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 15:35:42 INFO - 'tests': ['basic_compositor_video', 15:35:42 INFO - 'glvideo']}, 15:35:42 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 15:35:42 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 15:35:42 INFO - 'g5-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 15:35:42 INFO - 'talos_options': ['--disable-stylo'], 15:35:42 INFO - 'tests': ['ts_paint_webext', 15:35:42 INFO - 'tp5o_webext']}, 15:35:42 INFO - 'other-e10s': {'tests': ['a11yr', 15:35:42 INFO - 'ts_paint', 15:35:42 INFO - 'tpaint', 15:35:42 INFO - 'sessionrestore', 15:35:42 INFO - 'sessionrestore_many_windows', 15:35:42 INFO - 'sessionrestore_no_auto_restore', 15:35:42 INFO - 'tabpaint']}, 15:35:42 INFO - 'other-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 15:35:42 INFO - 'tests': ['a11yr', 15:35:42 INFO - 'ts_paint', 15:35:42 INFO - 'tpaint', 15:35:42 INFO - 'sessionrestore', 15:35:42 INFO - 'sessionrestore_many_windows', 15:35:42 INFO - 'sessionrestore_no_auto_restore', 15:35:42 INFO - 'tabpaint']}, 15:35:42 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 15:35:42 INFO - 'perf-reftest-singletons-e10s': {'tests': ['bloom_basic_singleton']}, 15:35:42 INFO - 'perf-reftest-singletons-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 15:35:42 INFO - 'tests': ['bloom_basic_singleton']}, 15:35:42 INFO - 'perf-reftest-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 15:35:42 INFO - 'tests': ['bloom_basic']}, 15:35:42 INFO - 'svgr-e10s': {'tests': ['tsvgx', 15:35:42 INFO - 'tsvgr_opacity', 15:35:42 INFO - 'tart', 15:35:42 INFO - 'tscrollx', 15:35:42 INFO - 'tsvg_static']}, 15:35:42 INFO - 'svgr-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 15:35:42 INFO - 'tests': ['tsvgx', 15:35:42 INFO - 'tsvgr_opacity', 15:35:42 INFO - 'tart', 15:35:42 INFO - 'tscrollx', 15:35:42 INFO - 'tsvg_static']}, 15:35:42 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 15:35:42 INFO - 'tp5o-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 15:35:42 INFO - 'talos_options': ['--disable-stylo'], 15:35:42 INFO - 'tests': ['tp5o']}, 15:35:42 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 15:35:42 INFO - 'talos_options': ['--mitmproxy', 15:35:42 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 15:35:42 INFO - '--firstNonBlankPaint'], 15:35:42 INFO - 'tests': ['tp6_google', 15:35:42 INFO - 'tp6_youtube', 15:35:42 INFO - 'tp6_amazon', 15:35:42 INFO - 'tp6_facebook']}, 15:35:42 INFO - 'tp6-stylo-disabled-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 15:35:42 INFO - 'talos_options': ['--disable-stylo', 15:35:42 INFO - '--mitmproxy', 15:35:42 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 15:35:42 INFO - '--firstNonBlankPaint'], 15:35:42 INFO - 'tests': ['tp6_google', 15:35:42 INFO - 'tp6_youtube', 15:35:42 INFO - 'tp6_amazon', 15:35:42 INFO - 'tp6_facebook']}, 15:35:42 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 15:35:42 INFO - 'talos_options': ['--stylo-threads=1', 15:35:42 INFO - '--mitmproxy', 15:35:42 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 15:35:42 INFO - '--firstNonBlankPaint'], 15:35:42 INFO - 'tests': ['tp6_google', 15:35:42 INFO - 'tp6_youtube', 15:35:42 INFO - 'tp6_amazon', 15:35:42 INFO - 'tp6_facebook']}, 15:35:42 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 15:35:42 INFO - 'talos_options': ['--xperf_path', 15:35:42 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:35:42 INFO - 'tests': ['tp5n']}, 15:35:42 INFO - 'xperf-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 15:35:42 INFO - 'talos_options': ['--disable-stylo', 15:35:42 INFO - '--xperf_path', 15:35:42 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:35:42 INFO - 'tests': ['tp5n']}}} 15:35:42 INFO - Running post-action listener: _resource_record_post_action 15:35:42 INFO - [mozharness: 2017-09-11 22:35:42.227216Z] Finished populate-webroot step (success) 15:35:42 INFO - [mozharness: 2017-09-11 22:35:42.227305Z] Running create-virtualenv step. 15:35:42 INFO - Running pre-action listener: _resource_record_pre_action 15:35:42 INFO - Running main action method: create_virtualenv 15:35:42 INFO - Creating virtualenv /builds/slave/test/build/venv 15:35:42 INFO - Running command: ['virtualenv', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 15:35:42 INFO - Copy/paste: virtualenv --no-site-packages --distribute /builds/slave/test/build/venv 15:35:42 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 15:35:42 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 15:35:42 INFO - New python executable in /builds/slave/test/build/venv/bin/python 15:35:42 INFO - Installing distribute.............................................................................................................................................................................................done. 15:35:43 INFO - Installing pip...............done. 15:35:43 INFO - Return code: 0 15:35:43 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 15:35:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 15:35:43 INFO - Reading from file tmpfile_stdout 15:35:43 INFO - Output received: 15:35:43 INFO - pip 1.1 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.1-py2.7.egg (python 2.7) 15:35:43 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 15:35:43 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')]} 15:35:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:35:43 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')]} 15:35:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:35:43 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/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 0x118d1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1356a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14f9a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14fd090>, '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 0x14fdd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14f7f90>, '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': '97facb8ba2ac28944cc45e6b000001d4-1505167450.332409-1360272433', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:35:43 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 15:35:43 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 15:35:43 INFO - Using env: {'DISPLAY': ':0', 15:35:43 INFO - 'HOME': '/home/cltbld', 15:35:43 INFO - 'LANG': 'en_US.UTF-8', 15:35:43 INFO - 'LANGUAGE': 'en_US:en', 15:35:43 INFO - 'LOGNAME': 'cltbld', 15:35:43 INFO - 'MAIL': '/var/mail/cltbld', 15:35:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:35:43 INFO - 'MOZ_NO_REMOTE': '1', 15:35:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:35:43 INFO - 'NO_EM_RESTART': '1', 15:35:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:35:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:35:43 INFO - 'PWD': '/builds/slave/test', 15:35:43 INFO - 'SHELL': '/bin/bash', 15:35:43 INFO - 'SHLVL': '1', 15:35:43 INFO - 'TERM': 'linux', 15:35:43 INFO - 'TMOUT': '86400', 15:35:43 INFO - 'USER': 'cltbld', 15:35:43 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1505167450.332409-1360272433', 15:35:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:35:43 INFO - '_': '/tools/buildbot/bin/python'} 15:35:44 INFO - Ignoring indexes: http://pypi.python.org/simple/ 15:35:44 INFO - Downloading/unpacking pip>=1.5 15:35:44 INFO - Running setup.py egg_info for package pip 15:35:44 INFO - warning: no files found matching 'pip/cacert.pem' 15:35:44 INFO - warning: no files found matching '*.html' under directory 'docs' 15:35:44 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 15:35:44 INFO - no previously-included directories found matching 'docs/_build/_sources' 15:35:44 INFO - Installing collected packages: pip 15:35:44 INFO - Found existing installation: pip 1.1 15:35:44 INFO - Uninstalling pip: 15:35:44 INFO - Successfully uninstalled pip 15:35:44 INFO - Running setup.py install for pip 15:35:44 INFO - warning: no files found matching 'pip/cacert.pem' 15:35:44 INFO - warning: no files found matching '*.html' under directory 'docs' 15:35:44 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 15:35:44 INFO - no previously-included directories found matching 'docs/_build/_sources' 15:35:44 INFO - Installing pip script to /builds/slave/test/build/venv/bin 15:35:44 INFO - Installing pip2.7 script to /builds/slave/test/build/venv/bin 15:35:44 INFO - Installing pip2 script to /builds/slave/test/build/venv/bin 15:35:44 INFO - Successfully installed pip 15:35:44 INFO - Cleaning up... 15:35:44 INFO - Return code: 0 15:35:44 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 15:35: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')]} 15:35:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:35: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')]} 15:35:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:35:44 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 0x118d1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1356a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14f9a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14fd090>, '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 0x14fdd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14f7f90>, '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': '97facb8ba2ac28944cc45e6b000001d4-1505167450.332409-1360272433', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:35:44 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 15:35:44 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 15:35:44 INFO - Using env: {'DISPLAY': ':0', 15:35:44 INFO - 'HOME': '/home/cltbld', 15:35:44 INFO - 'LANG': 'en_US.UTF-8', 15:35:44 INFO - 'LANGUAGE': 'en_US:en', 15:35:44 INFO - 'LOGNAME': 'cltbld', 15:35:44 INFO - 'MAIL': '/var/mail/cltbld', 15:35:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:35:44 INFO - 'MOZ_NO_REMOTE': '1', 15:35:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:35:44 INFO - 'NO_EM_RESTART': '1', 15:35:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:35:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:35:44 INFO - 'PWD': '/builds/slave/test', 15:35:44 INFO - 'SHELL': '/bin/bash', 15:35:44 INFO - 'SHLVL': '1', 15:35:44 INFO - 'TERM': 'linux', 15:35:44 INFO - 'TMOUT': '86400', 15:35:44 INFO - 'USER': 'cltbld', 15:35:44 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1505167450.332409-1360272433', 15:35:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:35:44 INFO - '_': '/tools/buildbot/bin/python'} 15:35:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:35:44 INFO - Downloading/unpacking psutil>=3.1.1 15:35:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:35:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:35:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:35:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:35:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 15:35:45 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:35:45 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:35:45 INFO - Installing collected packages: psutil 15:35:45 INFO - Running setup.py install for psutil 15:35:46 INFO - building 'psutil._psutil_linux' extension 15:35:46 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 15:35:46 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 15:35:46 INFO - building 'psutil._psutil_posix' extension 15:35:46 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 15:35:46 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 15:35:46 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:35:46 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:35:46 INFO - Successfully installed psutil 15:35:46 INFO - Cleaning up... 15:35:46 INFO - Return code: 0 15:35:46 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 15:35:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:35:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:35:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:35:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:35:46 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x118d1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1356a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14f9a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14fd090>, '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 0x14fdd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14f7f90>, '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': '97facb8ba2ac28944cc45e6b000001d4-1505167450.332409-1360272433', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:35:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 15:35:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 15:35:46 INFO - Using env: {'DISPLAY': ':0', 15:35:46 INFO - 'HOME': '/home/cltbld', 15:35:46 INFO - 'LANG': 'en_US.UTF-8', 15:35:46 INFO - 'LANGUAGE': 'en_US:en', 15:35:46 INFO - 'LOGNAME': 'cltbld', 15:35:46 INFO - 'MAIL': '/var/mail/cltbld', 15:35:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:35:46 INFO - 'MOZ_NO_REMOTE': '1', 15:35:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:35:46 INFO - 'NO_EM_RESTART': '1', 15:35:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:35:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:35:46 INFO - 'PWD': '/builds/slave/test', 15:35:46 INFO - 'SHELL': '/bin/bash', 15:35:46 INFO - 'SHLVL': '1', 15:35:46 INFO - 'TERM': 'linux', 15:35:46 INFO - 'TMOUT': '86400', 15:35:46 INFO - 'USER': 'cltbld', 15:35:46 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1505167450.332409-1360272433', 15:35:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:35:46 INFO - '_': '/tools/buildbot/bin/python'} 15:35:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:35:46 INFO - Downloading/unpacking mozsystemmonitor==0.3 15:35:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:35:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:35:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:35:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:35:47 INFO - Downloading mozsystemmonitor-0.3.tar.gz 15:35:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 15:35:47 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 15:35:47 INFO - Installing collected packages: mozsystemmonitor 15:35:47 INFO - Running setup.py install for mozsystemmonitor 15:35:48 INFO - Successfully installed mozsystemmonitor 15:35:48 INFO - Cleaning up... 15:35:49 INFO - Return code: 0 15:35:49 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 15:35: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')]} 15:35:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:35: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')]} 15:35:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:35:49 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x118d1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1356a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14f9a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14fd090>, '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 0x14fdd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14f7f90>, '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': '97facb8ba2ac28944cc45e6b000001d4-1505167450.332409-1360272433', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:35:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 15:35:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 15:35:49 INFO - Using env: {'DISPLAY': ':0', 15:35:49 INFO - 'HOME': '/home/cltbld', 15:35:49 INFO - 'LANG': 'en_US.UTF-8', 15:35:49 INFO - 'LANGUAGE': 'en_US:en', 15:35:49 INFO - 'LOGNAME': 'cltbld', 15:35:49 INFO - 'MAIL': '/var/mail/cltbld', 15:35:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:35:49 INFO - 'MOZ_NO_REMOTE': '1', 15:35:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:35:49 INFO - 'NO_EM_RESTART': '1', 15:35:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:35:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:35:49 INFO - 'PWD': '/builds/slave/test', 15:35:49 INFO - 'SHELL': '/bin/bash', 15:35:49 INFO - 'SHLVL': '1', 15:35:49 INFO - 'TERM': 'linux', 15:35:49 INFO - 'TMOUT': '86400', 15:35:49 INFO - 'USER': 'cltbld', 15:35:49 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1505167450.332409-1360272433', 15:35:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:35:49 INFO - '_': '/tools/buildbot/bin/python'} 15:35:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:35:50 INFO - Downloading/unpacking jsonschema==2.5.1 15:35: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 15:35: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 15:35: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 15:35: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 15:35:51 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 15:35:51 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 15:35:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:35:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:35:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:35:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:35:51 INFO - Downloading functools32-3.2.3-2.tar.gz 15:35:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 15:35:51 INFO - warning: no files found matching '*.txt' 15:35:51 INFO - no previously-included directories found matching 'build' 15:35:51 INFO - no previously-included directories found matching 'dist' 15:35:51 INFO - no previously-included directories found matching '.git*' 15:35:51 INFO - Installing collected packages: jsonschema, functools32 15:35:51 INFO - Running setup.py install for functools32 15:35:52 INFO - warning: no files found matching '*.txt' 15:35:52 INFO - no previously-included directories found matching 'build' 15:35:52 INFO - no previously-included directories found matching 'dist' 15:35:52 INFO - no previously-included directories found matching '.git*' 15:35:52 INFO - Successfully installed jsonschema functools32 15:35:52 INFO - Cleaning up... 15:35:52 INFO - Return code: 0 15:35:52 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 15:35: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')]} 15:35:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:35: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')]} 15:35:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:35: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', '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 0x118d1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1356a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14f9a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14fd090>, '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 0x14fdd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14f7f90>, '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': '97facb8ba2ac28944cc45e6b000001d4-1505167450.332409-1360272433', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:35: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', 'functools32==3.2.3-2'] in /builds/slave/test/build 15:35: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 functools32==3.2.3-2 15:35:52 INFO - Using env: {'DISPLAY': ':0', 15:35:52 INFO - 'HOME': '/home/cltbld', 15:35:52 INFO - 'LANG': 'en_US.UTF-8', 15:35:52 INFO - 'LANGUAGE': 'en_US:en', 15:35:52 INFO - 'LOGNAME': 'cltbld', 15:35:52 INFO - 'MAIL': '/var/mail/cltbld', 15:35:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:35:52 INFO - 'MOZ_NO_REMOTE': '1', 15:35:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:35:52 INFO - 'NO_EM_RESTART': '1', 15:35:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:35:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:35:52 INFO - 'PWD': '/builds/slave/test', 15:35:52 INFO - 'SHELL': '/bin/bash', 15:35:52 INFO - 'SHLVL': '1', 15:35:52 INFO - 'TERM': 'linux', 15:35:52 INFO - 'TMOUT': '86400', 15:35:52 INFO - 'USER': 'cltbld', 15:35:52 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1505167450.332409-1360272433', 15:35:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:35:52 INFO - '_': '/tools/buildbot/bin/python'} 15:35:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:35:52 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 15:35:52 INFO - Cleaning up... 15:35:52 INFO - Return code: 0 15:35:52 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 15:35: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')]} 15:35:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:35: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')]} 15:35:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:35: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', '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 0x118d1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1356a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14f9a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14fd090>, '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 0x14fdd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14f7f90>, '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': '97facb8ba2ac28944cc45e6b000001d4-1505167450.332409-1360272433', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:35: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 15:35: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 blobuploader==1.2.4 15:35:52 INFO - Using env: {'DISPLAY': ':0', 15:35:52 INFO - 'HOME': '/home/cltbld', 15:35:52 INFO - 'LANG': 'en_US.UTF-8', 15:35:52 INFO - 'LANGUAGE': 'en_US:en', 15:35:52 INFO - 'LOGNAME': 'cltbld', 15:35:52 INFO - 'MAIL': '/var/mail/cltbld', 15:35:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:35:52 INFO - 'MOZ_NO_REMOTE': '1', 15:35:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:35:52 INFO - 'NO_EM_RESTART': '1', 15:35:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:35:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:35:52 INFO - 'PWD': '/builds/slave/test', 15:35:52 INFO - 'SHELL': '/bin/bash', 15:35:52 INFO - 'SHLVL': '1', 15:35:52 INFO - 'TERM': 'linux', 15:35:52 INFO - 'TMOUT': '86400', 15:35:52 INFO - 'USER': 'cltbld', 15:35:52 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1505167450.332409-1360272433', 15:35:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:35:52 INFO - '_': '/tools/buildbot/bin/python'} 15:35:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:35:52 INFO - Downloading/unpacking blobuploader==1.2.4 15:35: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 15:35: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 15:35: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 15:35: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 15:35:53 INFO - Downloading blobuploader-1.2.4.tar.gz 15:35:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 15:35:53 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 15:35:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:35:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:35:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:35:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:35:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 15:35:54 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 15:35:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:35:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:35:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:35:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:35:54 INFO - Downloading docopt-0.6.1.tar.gz 15:35:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 15:35:54 INFO - Installing collected packages: blobuploader, requests, docopt 15:35:54 INFO - Running setup.py install for blobuploader 15:35:54 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 15:35:54 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 15:35:54 INFO - Running setup.py install for requests 15:35:54 INFO - Running setup.py install for docopt 15:35:54 INFO - Successfully installed blobuploader requests docopt 15:35:54 INFO - Cleaning up... 15:35:54 INFO - Return code: 0 15:35:54 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:35:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:35:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:35:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:35:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:35:54 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x118d1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1356a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14f9a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14fd090>, '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 0x14fdd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14f7f90>, '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': '97facb8ba2ac28944cc45e6b000001d4-1505167450.332409-1360272433', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:35:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 15:35:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 15:35:54 INFO - Using env: {'DISPLAY': ':0', 15:35:54 INFO - 'HOME': '/home/cltbld', 15:35:54 INFO - 'LANG': 'en_US.UTF-8', 15:35:54 INFO - 'LANGUAGE': 'en_US:en', 15:35:54 INFO - 'LOGNAME': 'cltbld', 15:35:54 INFO - 'MAIL': '/var/mail/cltbld', 15:35:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:35:54 INFO - 'MOZ_NO_REMOTE': '1', 15:35:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:35:54 INFO - 'NO_EM_RESTART': '1', 15:35:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:35:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:35:54 INFO - 'PWD': '/builds/slave/test', 15:35:54 INFO - 'SHELL': '/bin/bash', 15:35:54 INFO - 'SHLVL': '1', 15:35:54 INFO - 'TERM': 'linux', 15:35:54 INFO - 'TMOUT': '86400', 15:35:54 INFO - 'USER': 'cltbld', 15:35:54 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1505167450.332409-1360272433', 15:35:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:35:54 INFO - '_': '/tools/buildbot/bin/python'} 15:35:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:35:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:35:55 INFO - Running setup.py (path:/tmp/pip-sXaRRi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:35:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:35:55 INFO - Running setup.py (path:/tmp/pip-wCnQmv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:35:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:35:55 INFO - Running setup.py (path:/tmp/pip-43PePL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:35:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:35:55 INFO - Running setup.py (path:/tmp/pip-JEAXss-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:35:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:35:55 INFO - Running setup.py (path:/tmp/pip-ReEDVi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:35:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:35:55 INFO - Running setup.py (path:/tmp/pip-XcAuF4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:35:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:35:55 INFO - Running setup.py (path:/tmp/pip-mqQoE8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:35:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:35:55 INFO - Running setup.py (path:/tmp/pip-uJE9I_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:35:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:35:55 INFO - Running setup.py (path:/tmp/pip-_4Zjcx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:35:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:35:55 INFO - Running setup.py (path:/tmp/pip-yMiF9u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:35:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:35:55 INFO - Running setup.py (path:/tmp/pip-rB3syd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:35:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:35:55 INFO - Running setup.py (path:/tmp/pip-c6rYbQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:35:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:35:55 INFO - Running setup.py (path:/tmp/pip-nxAS6Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:35:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:35:55 INFO - Running setup.py (path:/tmp/pip-3KTbAX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:35:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:35:56 INFO - Running setup.py (path:/tmp/pip-dF05qs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:35:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:35:56 INFO - Running setup.py (path:/tmp/pip-4DWyQu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:35:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:35:56 INFO - Running setup.py (path:/tmp/pip-4Vx6R2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:35:56 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 15:35:56 INFO - Running setup.py install for manifestparser 15:35:56 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 15:35:56 INFO - Running setup.py install for mozcrash 15:35:56 INFO - Running setup.py install for mozdebug 15:35:56 INFO - Running setup.py install for mozdevice 15:35:56 INFO - Installing dm script to /builds/slave/test/build/venv/bin 15:35:56 INFO - Running setup.py install for mozfile 15:35:56 INFO - Running setup.py install for mozhttpd 15:35:56 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 15:35:56 INFO - Running setup.py install for mozinfo 15:35:56 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 15:35:56 INFO - Running setup.py install for mozInstall 15:35:57 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 15:35:57 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 15:35:57 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 15:35:57 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 15:35:57 INFO - Running setup.py install for mozleak 15:35:57 INFO - Running setup.py install for mozlog 15:35:57 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 15:35:57 INFO - Running setup.py install for moznetwork 15:35:57 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 15:35:57 INFO - Running setup.py install for mozprocess 15:35:57 INFO - Running setup.py install for mozprofile 15:35:57 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 15:35:57 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 15:35:57 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 15:35:57 INFO - Running setup.py install for mozrunner 15:35:57 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 15:35:57 INFO - Running setup.py install for mozscreenshot 15:35:57 INFO - Running setup.py install for moztest 15:35:57 INFO - Running setup.py install for mozversion 15:35:57 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 15:35:58 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 15:35:58 INFO - Cleaning up... 15:35:58 INFO - Return code: 0 15:35:58 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:35:58 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')]} 15:35:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:35:58 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')]} 15:35:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:35:58 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 0x118d1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1356a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14f9a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14fd090>, '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 0x14fdd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14f7f90>, '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': '97facb8ba2ac28944cc45e6b000001d4-1505167450.332409-1360272433', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:35:58 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 15:35:58 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 15:35:58 INFO - Using env: {'DISPLAY': ':0', 15:35:58 INFO - 'HOME': '/home/cltbld', 15:35:58 INFO - 'LANG': 'en_US.UTF-8', 15:35:58 INFO - 'LANGUAGE': 'en_US:en', 15:35:58 INFO - 'LOGNAME': 'cltbld', 15:35:58 INFO - 'MAIL': '/var/mail/cltbld', 15:35:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:35:58 INFO - 'MOZ_NO_REMOTE': '1', 15:35:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:35:58 INFO - 'NO_EM_RESTART': '1', 15:35:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:35:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:35:58 INFO - 'PWD': '/builds/slave/test', 15:35:58 INFO - 'SHELL': '/bin/bash', 15:35:58 INFO - 'SHLVL': '1', 15:35:58 INFO - 'TERM': 'linux', 15:35:58 INFO - 'TMOUT': '86400', 15:35:58 INFO - 'USER': 'cltbld', 15:35:58 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1505167450.332409-1360272433', 15:35:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:35:58 INFO - '_': '/tools/buildbot/bin/python'} 15:35:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:35:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:35:58 INFO - Running setup.py (path:/tmp/pip-l_4nzN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:35:58 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 15:35:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:35:58 INFO - Running setup.py (path:/tmp/pip-g4Zti7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:35:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 15:35:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:35:58 INFO - Running setup.py (path:/tmp/pip-GDGD9v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:35:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 15:35:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:35:58 INFO - Running setup.py (path:/tmp/pip-Rkl14M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:35:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.51 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 15:35:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:35:58 INFO - Running setup.py (path:/tmp/pip-3THLJ6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:35:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 15:35:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:35:58 INFO - Running setup.py (path:/tmp/pip-8Wvo2D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:35:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 15:35:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:35:58 INFO - Running setup.py (path:/tmp/pip-JATIH7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:35:58 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)) 15:35:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:35:58 INFO - Running setup.py (path:/tmp/pip-ZUnx4s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:35:58 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)) 15:35:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:35:58 INFO - Running setup.py (path:/tmp/pip-Y8ikFE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:35:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 15:35:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:35:58 INFO - Running setup.py (path:/tmp/pip-Hun7ye-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:35:58 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)) 15:35:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:35:58 INFO - Running setup.py (path:/tmp/pip-VnnXwt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:35:59 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 15:35:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:35:59 INFO - Running setup.py (path:/tmp/pip-xoRkEl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:35:59 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)) 15:35:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:35:59 INFO - Running setup.py (path:/tmp/pip-hLhbss-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:35:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 15:35:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:35:59 INFO - Running setup.py (path:/tmp/pip-6xpuG3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:35:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 15:35:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:35:59 INFO - Running setup.py (path:/tmp/pip-87cbNP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:35:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 15:35:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:35:59 INFO - Running setup.py (path:/tmp/pip-F9pYr3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:35:59 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 15:35:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:35:59 INFO - Running setup.py (path:/tmp/pip-xa8ph8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:35:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 15:35:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 15:35:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 15:35:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 15:35:59 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)) 15:35:59 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)) 15:35:59 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)) 15:35:59 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 15:35:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:35:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:35:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:35:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:36:00 INFO - Downloading blessings-1.6.tar.gz 15:36:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 15:36:00 INFO - Installing collected packages: blessings 15:36:00 INFO - Running setup.py install for blessings 15:36:00 INFO - Successfully installed blessings 15:36:00 INFO - Cleaning up... 15:36:00 INFO - Return code: 0 15:36:00 INFO - Done creating virtualenv /builds/slave/test/build/venv. 15:36:00 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:36:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:36:00 INFO - Reading from file tmpfile_stdout 15:36:00 INFO - Current package versions: 15:36:00 INFO - argparse == 1.2.1 15:36:00 INFO - blessings == 1.6 15:36:00 INFO - blobuploader == 1.2.4 15:36:00 INFO - docopt == 0.6.1 15:36:00 INFO - functools32 == 3.2.3-2 15:36:00 INFO - jsonschema == 2.5.1 15:36:00 INFO - manifestparser == 1.1 15:36:00 INFO - mozInstall == 1.13 15:36:00 INFO - mozcrash == 1.0 15:36:00 INFO - mozdebug == 0.1 15:36:00 INFO - mozdevice == 0.51 15:36:00 INFO - mozfile == 1.2 15:36:00 INFO - mozhttpd == 0.7 15:36:00 INFO - mozinfo == 0.10 15:36:00 INFO - mozleak == 0.1 15:36:00 INFO - mozlog == 3.5 15:36:00 INFO - moznetwork == 0.27 15:36:00 INFO - mozprocess == 0.25 15:36:00 INFO - mozprofile == 0.28 15:36:00 INFO - mozrunner == 6.13 15:36:00 INFO - mozscreenshot == 0.1 15:36:00 INFO - mozsystemmonitor == 0.3 15:36:00 INFO - moztest == 0.8 15:36:00 INFO - mozversion == 1.4 15:36:00 INFO - psutil == 3.1.1 15:36:00 INFO - requests == 1.2.3 15:36:00 INFO - wsgiref == 0.1.2 15:36:00 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:36:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:36:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:36:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:36:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:36:01 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 0x118d1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1356a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14f9a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14fd090>, '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 0x14fdd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14f7f90>, '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': '97facb8ba2ac28944cc45e6b000001d4-1505167450.332409-1360272433', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:36:01 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 15:36:01 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 15:36:01 INFO - Using env: {'DISPLAY': ':0', 15:36:01 INFO - 'HOME': '/home/cltbld', 15:36:01 INFO - 'LANG': 'en_US.UTF-8', 15:36:01 INFO - 'LANGUAGE': 'en_US:en', 15:36:01 INFO - 'LOGNAME': 'cltbld', 15:36:01 INFO - 'MAIL': '/var/mail/cltbld', 15:36:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:36:01 INFO - 'MOZ_NO_REMOTE': '1', 15:36:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:36:01 INFO - 'NO_EM_RESTART': '1', 15:36:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:36:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:36:01 INFO - 'PWD': '/builds/slave/test', 15:36:01 INFO - 'SHELL': '/bin/bash', 15:36:01 INFO - 'SHLVL': '1', 15:36:01 INFO - 'TERM': 'linux', 15:36:01 INFO - 'TMOUT': '86400', 15:36:01 INFO - 'USER': 'cltbld', 15:36:01 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1505167450.332409-1360272433', 15:36:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:36:01 INFO - '_': '/tools/buildbot/bin/python'} 15:36:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:36:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 15:36:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 15:36:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 15:36:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 15:36:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 15:36:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 15:36:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 15:36:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 15:36:01 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 15:36:01 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 15:36:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:36:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:36:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:36:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:36:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 15:36:02 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 15:36:02 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 15:36:02 INFO - Installing collected packages: simplejson 15:36:02 INFO - Running setup.py install for simplejson 15:36:02 INFO - building 'simplejson._speedups' extension 15:36:02 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 15:36:03 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 15:36:03 INFO - Successfully installed simplejson 15:36:03 INFO - Cleaning up... 15:36:03 INFO - Return code: 0 15:36:03 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 15:36:03 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')]} 15:36:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:36:03 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')]} 15:36:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:36:03 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 0x118d1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1356a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14f9a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14fd090>, '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 0x14fdd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14f7f90>, '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': '97facb8ba2ac28944cc45e6b000001d4-1505167450.332409-1360272433', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:36:03 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 15:36:03 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 15:36:03 INFO - Using env: {'DISPLAY': ':0', 15:36:03 INFO - 'HOME': '/home/cltbld', 15:36:03 INFO - 'LANG': 'en_US.UTF-8', 15:36:03 INFO - 'LANGUAGE': 'en_US:en', 15:36:03 INFO - 'LOGNAME': 'cltbld', 15:36:03 INFO - 'MAIL': '/var/mail/cltbld', 15:36:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:36:03 INFO - 'MOZ_NO_REMOTE': '1', 15:36:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:36:03 INFO - 'NO_EM_RESTART': '1', 15:36:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:36:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:36:03 INFO - 'PWD': '/builds/slave/test', 15:36:03 INFO - 'SHELL': '/bin/bash', 15:36:03 INFO - 'SHLVL': '1', 15:36:03 INFO - 'TERM': 'linux', 15:36:03 INFO - 'TMOUT': '86400', 15:36:03 INFO - 'USER': 'cltbld', 15:36:03 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1505167450.332409-1360272433', 15:36:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:36:03 INFO - '_': '/tools/buildbot/bin/python'} 15:36:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:36:03 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 15:36:03 INFO - Cleaning up... 15:36:03 INFO - Return code: 0 15:36:03 INFO - Running post-action listener: _resource_record_post_action 15:36:03 INFO - Running post-action listener: _start_resource_monitoring 15:36:03 INFO - Starting resource monitoring. 15:36:03 INFO - [mozharness: 2017-09-11 22:36:03.710927Z] Finished create-virtualenv step (success) 15:36:03 INFO - [mozharness: 2017-09-11 22:36:03.711512Z] Running install step. 15:36:03 INFO - Running pre-action listener: _resource_record_pre_action 15:36:03 INFO - Running main action method: install 15:36:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:36:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:36:03 INFO - Reading from file tmpfile_stdout 15:36:03 INFO - Detecting whether we're running mozinstall >=1.0... 15:36:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 15:36:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 15:36:04 INFO - Reading from file tmpfile_stdout 15:36:04 INFO - Output received: 15:36:04 INFO - Usage: mozinstall [options] installer 15:36:04 INFO - Options: 15:36:04 INFO - -h, --help show this help message and exit 15:36:04 INFO - -d DEST, --destination=DEST 15:36:04 INFO - Directory to install application into. [default: 15:36:04 INFO - "/builds/slave/test"] 15:36:04 INFO - --app=APP Application being installed. [default: firefox] 15:36:04 INFO - mkdir: /builds/slave/test/build/application 15:36:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/target.tar.bz2', '--destination', '/builds/slave/test/build/application'] 15:36:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 15:36:20 INFO - Reading from file tmpfile_stdout 15:36:20 INFO - Output received: 15:36:20 INFO - /builds/slave/test/build/application/firefox/firefox 15:36:20 INFO - Running post-action listener: _resource_record_post_action 15:36:20 INFO - [mozharness: 2017-09-11 22:36:20.614030Z] Finished install step (success) 15:36:20 INFO - [mozharness: 2017-09-11 22:36:20.614282Z] Running setup-mitmproxy step. 15:36:20 INFO - Running pre-action listener: _resource_record_pre_action 15:36:20 INFO - Running main action method: setup_mitmproxy 15:36:20 INFO - Skipping: mitmproxy is not required 15:36:20 INFO - Running post-action listener: _resource_record_post_action 15:36:20 INFO - [mozharness: 2017-09-11 22:36:20.615397Z] Finished setup-mitmproxy step (success) 15:36:20 INFO - [mozharness: 2017-09-11 22:36:20.615616Z] Running run-tests step. 15:36:20 INFO - Running pre-action listener: _resource_record_pre_action 15:36:20 INFO - Running pre-action listener: _set_gcov_prefix 15:36:20 INFO - Running main action method: run_tests 15:36:20 WARNING - Try message not found. 15:36:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 15:36:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 15:36:20 INFO - Python 2.7.3 15:36:20 INFO - Return code: 0 15:36:20 INFO - grabbing minidump binary from tooltool 15:36:20 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')]} 15:36:20 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 0x14fd090>, '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 0x14fdd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14f7f90>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 15:36:20 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 15:36:20 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 15:36:20 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 15:36:20 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 15:36:20 INFO - Return code: 0 15:36:20 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 15:36:20 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 15:36:20 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 15:36:20 INFO - ENV: RUST_BACKTRACE is now full 15:36:20 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 15:36:20 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 15:36:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/PxukmEXgQ0mTuA19AmBRIg/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-068', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 15:36:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/PxukmEXgQ0mTuA19AmBRIg/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-068 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 15:36:20 INFO - Using env: {'DISPLAY': ':0', 15:36:20 INFO - 'HOME': '/home/cltbld', 15:36:20 INFO - 'LANG': 'en_US.UTF-8', 15:36:20 INFO - 'LANGUAGE': 'en_US:en', 15:36:20 INFO - 'LOGNAME': 'cltbld', 15:36:20 INFO - 'MAIL': '/var/mail/cltbld', 15:36:20 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 15:36:20 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 15:36:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:36:20 INFO - 'MOZ_NO_REMOTE': '1', 15:36:20 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 15:36:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:36:20 INFO - 'NO_EM_RESTART': '1', 15:36:20 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:36:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:36:20 INFO - 'PWD': '/builds/slave/test', 15:36:20 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 15:36:20 INFO - 'RUST_BACKTRACE': 'full', 15:36:20 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 15:36:20 INFO - 'SHELL': '/bin/bash', 15:36:20 INFO - 'SHLVL': '1', 15:36:20 INFO - 'TERM': 'linux', 15:36:20 INFO - 'TMOUT': '86400', 15:36:20 INFO - 'USER': 'cltbld', 15:36:20 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1505167450.332409-1360272433', 15:36:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:36:20 INFO - '_': '/tools/buildbot/bin/python'} 15:36:20 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/PxukmEXgQ0mTuA19AmBRIg/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-068', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 15:36:20 INFO - mozversion application_buildid: 20170911214158 15:36:20 INFO - mozversion application_changeset: 85157b4b361ab9fdf7b3c3d7cf129bd3d422feac 15:36:20 INFO - mozversion application_display_name: Nightly 15:36:20 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 15:36:20 INFO - mozversion application_name: Firefox 15:36:20 INFO - mozversion application_remotingname: firefox 15:36:20 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 15:36:20 INFO - mozversion application_vendor: Mozilla 15:36:20 INFO - mozversion application_version: 57.0a1 15:36:20 INFO - mozversion platform_buildid: 20170911214158 15:36:20 INFO - mozversion platform_changeset: 85157b4b361ab9fdf7b3c3d7cf129bd3d422feac 15:36:20 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 15:36:20 INFO - mozversion platform_version: 57.0a1 15:36:20 INFO - using testdate: 1505169380 15:36:20 INFO - actual date: 1505169380 15:36:20 INFO - starting webserver on 'localhost:38624' 15:36:20 INFO - SUITE-START | Running 2 tests 15:36:20 INFO - TEST-START | dromaeo_css 15:36:20 INFO - Initialising browser for dromaeo_css test... 15:36:20 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:38624/getInfo.html -profile /tmp/tmpInmZHc/profile 15:36:20 INFO - TEST-INFO | started process 7501 (/builds/slave/test/build/application/firefox/firefox http://localhost:38624/getInfo.html) 15:36:27 INFO - TEST-INFO | 7501: exit 0 15:36:27 INFO - Browser initialized. 15:36:27 INFO - Running cycle 1/1 for dromaeo_css test... 15:36:27 INFO - Using env: {'DISPLAY': ':0', 15:36:27 INFO - 'HOME': '/home/cltbld', 15:36:27 INFO - 'JSGC_DISABLE_POISONING': '1', 15:36:27 INFO - 'LANG': 'en_US.UTF-8', 15:36:27 INFO - 'LANGUAGE': 'en_US:en', 15:36:27 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 15:36:27 INFO - 'LOGNAME': 'cltbld', 15:36:27 INFO - 'MAIL': '/var/mail/cltbld', 15:36:27 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 15:36:27 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 15:36:27 INFO - 'MOZ_CRASHREPORTER': '1', 15:36:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:36:27 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 15:36:27 INFO - 'MOZ_NO_REMOTE': '1', 15:36:27 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 15:36:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:36:27 INFO - 'NO_EM_RESTART': '1', 15:36:27 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:36:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:36:27 INFO - 'PWD': '/builds/slave/test', 15:36:27 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 15:36:27 INFO - 'RUST_BACKTRACE': 'full', 15:36:27 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 15:36:27 INFO - 'SHELL': '/bin/bash', 15:36:27 INFO - 'SHLVL': '1', 15:36:27 INFO - 'TERM': 'linux', 15:36:27 INFO - 'TMOUT': '86400', 15:36:27 INFO - 'USER': 'cltbld', 15:36:27 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1505167450.332409-1360272433', 15:36:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:36:27 INFO - '_': '/tools/buildbot/bin/python'} 15:36:27 INFO - TEST-INFO | started process 7701 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpInmZHc/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 15:36:28 INFO - PID 7701 | 15:36:28 INFO - PID 7701 | (/builds/slave/test/build/application/firefox/firefox:7752): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 15:36:28 INFO - PID 7701 | 15:36:38 INFO - PID 7701 | RSS: Main: 171741184 15:36:38 INFO - PID 7701 | 15:39:35 INFO - PID 7701 | Cycle 1(1): loaded http://localhost:38624/tests/dromaeo/cssquery-dojo.html (next: http://localhost:38624/tests/dromaeo/cssquery-ext.html) 15:39:36 INFO - PID 7701 | RSS: Main: 174059520 15:39:36 INFO - PID 7701 | 15:42:38 INFO - PID 7701 | Cycle 1(1): loaded http://localhost:38624/tests/dromaeo/cssquery-ext.html (next: http://localhost:38624/tests/dromaeo/cssquery-jquery.html) 15:42:39 INFO - PID 7701 | RSS: Main: 169148416 15:42:39 INFO - PID 7701 | 15:45:40 INFO - PID 7701 | Cycle 1(1): loaded http://localhost:38624/tests/dromaeo/cssquery-jquery.html (next: http://localhost:38624/tests/dromaeo/cssquery-mootools.html) 15:45:41 INFO - PID 7701 | RSS: Main: 173166592 15:45:41 INFO - PID 7701 | 15:48:43 INFO - PID 7701 | Cycle 1(1): loaded http://localhost:38624/tests/dromaeo/cssquery-mootools.html (next: http://localhost:38624/tests/dromaeo/cssquery-prototype.html) 15:48:43 INFO - PID 7701 | RSS: Main: 171704320 15:48:43 INFO - PID 7701 | 15:51:47 INFO - PID 7701 | Cycle 1(1): loaded http://localhost:38624/tests/dromaeo/cssquery-prototype.html (next: http://localhost:38624/tests/dromaeo/cssquery-yui.html) 15:51:47 INFO - PID 7701 | RSS: Main: 173273088 15:51:47 INFO - PID 7701 | 15:54:49 INFO - PID 7701 | Cycle 1(1): loaded http://localhost:38624/tests/dromaeo/cssquery-yui.html (next: http://localhost:38624/tests/dromaeo/cssquery-dojo.html) 15:54:49 INFO - PID 7701 | RSS: Main: 175824896 15:54:49 INFO - PID 7701 | 15:54:49 INFO - PID 7701 | __start_tp_report 15:54:49 INFO - PID 7701 | _x_x_mozilla_page_load 15:54:49 INFO - PID 7701 | _x_x_mozilla_page_load_details 15:54:49 INFO - PID 7701 | |i|pagename|runs| 15:54:49 INFO - PID 7701 | |0;dojo.html;3112.5331200319947;3145.6697046810086;3182.379436009979;3194;3195.6005499312587;6218.937810621893;6372.968135159318;6382.329855365184;6407.103005579217;6465.288818229991;6354.396332348431;6369.808905732823;6399.1681081459465;6487.156669632953;6494.415502604765;1342.8124654850683;5893.823185304448;5909.290885093784;5931.169636250928;5944.88110237795;5810.738516766755;5865.149553314767;5939.287285525743;5950.077737950603;5963.194968679238;5858.121281807742;5860.736266868002;5935.050391937312;5936.614120082181;5940.495057920082;5849.561282903799;5853.85365365865;5917.023691090965;5933.821985340403;5938.0499120141;5825.79609713658;5838.883222335572;5896.233489646362;5903.822885313448;5917.674527900964;6233.96883015582;6293.622382657009;6334.588251763621;6369.20384951881;6443.806685799434;6669.866602667919;6749.797506074777;6751.189857217117;6752.122224110834;6768.39084482394;6725.630090345029;6755.2906944771075;6828.795136145924;6847.589144651337;6850.040994260808;6241.906371404432;6244.0633904914175;6261.749530018794;6327.3988971047675;6330.335314791972;6949.617771022642;6972.91919752429;6978.930210697929;6987.965060174666;6993.055937448481;6635.668216589152;6643.468522518187;6657.600543967377;6668.899966500507;6670.866582668319;6783.626900520519;6799.93200067993;6880.552764070319;6887;6889.931100689029;6754.3245675433045;6790.864182716318;6835.692393842289;6861.828454288583;6862.210845752802;6655.334466553403;6740.258571557125;6769.763058292936;6803.795886123424;6893.276205998398;5331.360236771535;5367.812126575551;5375.1131063374105;5389.218563308298;5396.244525766396;4679.766011699401;4720.645951553647;4744.146053710297;4750.002499475149;4773.76131193439;5854.736536855852;5856.795012174639;5927;5939.584229103922;5942.257217847769;6723.361280678328;6820.897686534706;6838.418734407631;6883.139607549057;6900.516963812585;5875.118732190205;5901.17383566301;5909.645421274738;5911.822645320647;5923.911141332884;5838.824835254864;5852.122181672783;5908.881822363529;5908.970455147783;5928.021876390433;6578.27638959714;6601.339866013456;6663.466922646274;6678.532502724763;6692.263850976388;6595.406413422815;6713.362230588086;6774.3225677431865;6819.011243369684;6926.58440493572;6616.338366163345;6634.535582509178;6636.369544893228;6651.43462805667;6657.533972622064;6715.1941766988275;6732.461403087839;6734.831629209309;6788.389044985975;6817.590944543145;6822.556533825285;6867.416269617139;6931.133608298963;6938.653067346713;6952.652367381509;6403.167588213502;6513.2835388108215;6516.218053833571;6517.869642607026;6589.901151482827;6583.275839657538;6592.43964263043;6613.305602911625;6691.631960242234;6700.83247918806;6530.706118224786;6543.1821022372205;6629.502787290876;6630.370114839083;6634.303398143125;6608.537402381787;6703.698333574904;6737.157855268091;6768.7292508299115;6771.052052712723;6311.053341998737;6385.8722825544155;6420.101185834081;6421.678916054085;6428.164338635947 15:54:49 INFO - PID 7701 | |1;ext.html;802.6789284286285;832.6128350317101;834.5910503853112;838.8657814749641;839.8824164616955;37593.248135037284;41437;41439.58560414395;41474.170516589686;41648.79175604118;38226.23547529048;38356.80821595888;38432.03919901997;38479;38480.615193848054;7017.789466316019;7153.177384600785;7465.477416580841;7760.417968652374;7762.068551773795;7597.354224890891;7713.575753333593;7716.151223365426;7717.305442510173;7725.034370703662;7608.923910760877;7765.1070126935565;7809.492382995116;7810.921890781076;7815.218478152196;7719.614019299041;7734.961325193394;7740.922590774133;7757.379409647215;7765.262300081483;7636.160022397532;7670.041244844395;7681.539107653559;7696.730614428524;7703.422243331773;37451.438228426596;37641.24717505662;37742.811285943666;37771;37829.243415131816;3278.8688452461874;3308.983455082733;3312.4700047992446;3315.5026745988052;3316.8341582921;31173.844130779427;31239.06282811519;31292.53061204084;31323.216919576964;31369;5029.522195391469;5175.611829112831;5207.114790485626;5207.843764687065;5225.947740522584;180016;180214.09892950582;180801;180956.57130286112;181452.9999999987;41168.38247426291;42102.15795684069;46675.76662116668;46751.766241168574;47178.29232561514;49966.50033499691;50011;50034.49965500371;50076;50167.74916125469;16216.918915405347;16351.182440877908;16365.42721004783;16379.09914954689;16384.426545070866;13473.124246923919;13492.86507134916;13500.797488037688;13502.594922152155;13621.18272903609;14014.789778153336;14072.226027568582;14095.506657266946;14101.435942562388;14228.510010748078;5768.798092066758;5860.150278209721;5866.2960444746905;5871.64770113786;5895.263092113486;1003.3678782367062;1007.8488226766044;1011.2870426349406;1012.964546240878;1015.0661391519819;22400.215992440513;22469;22469.101235950708;22494;22636.773632263797;1098.8681358237063;1100.6532942123206;1108.6729414822485;1117.2179474367974;1127.4362818590705;11784.175107742376;11948.880511194951;12006.579769708018;12063.276203427822;12118.757624847454;213342;213839;214964;214996;215085;51748.74125629348;52036;52081.21878171831;52131.73934130381;52232;1420.9342992755433;1472.4331132513846;1474.2112969561233;1477.8004969329218;1480.0453707358693;21893.671594926407;21923.451913702283;22088.77911220867;22630.886845566325;22640.66039009449;32753.34493310073;37128.81435592805;37143.25713485661;37147.25705485929;37207;185067;185931;186776;187113;187273;30370.240743981576;30835.69164308418;31132.377352453277;33643.327133457686;33789.15527111842;43587.78206108949;43673.56326436822;43711.78144109259;44041.339379908684;44166.55833441753;31283.530747038356;31890.84054579805;31915.521267181477;32172.678273217905;32785.34429311448;31299.37401252008;31936.840315798272;31951.201219969687;32069.358612827145;32829.34341313112;35015.299694006484;35083.29833403369;35368.82315588508;35873.64126358703;35992.64007359893;30853.8457307712;30927.84536077305;31042.689573104883;31206.21984450407;31363.215919602193;22849.428764281027;22867.542649147257;23290.417739556648;23380.76619233854;23604.29187124389 15:54:49 INFO - PID 7701 | |2;jquery.html;549.601538884309;564.7712676366073;577.8035467940899;578.878435528539;596.3827438601048;22129.336119916406;22727;22745;22790.31629051129;22813.201537946134;19661.508462288413;20089.799102008976;20473.283435079775;23502.17742379017;23636.409089772722;6574.671266436683;6649.634270115142;6696.665166741668;6721.193456785192;6722.092517510123;6241.875162496747;6589.637569933651;6681.565698229624;6682.632455214961;6691.029800678899;6427.132337134497;6433.260175079856;6436.645984470852;6438.806835794933;6442.967785161068;6394.264659564164;6428.260750013738;6433.002884552855;6433.742650294006;6435.388638079398;6132.50939924805;6167.506599472032;6184.412480814315;6191.164192833955;6194.4115309045565;27697.307567310778;28134.155975320773;28162;28181.29546761327;28191.85904070487;2061.093119027623;2065.9586808263903;2066.555690526529;2081.5940891526157;2095.298075144828;18461.076946152774;18918.3378581749;19157.616847663106;19206.231750729956;19277.90361048186;2334.6381310896836;2341.1220792202926;2394.832361734679;2399.2682231919257;2402.651615515758;118748.40625796902;124550;131138;137504.31247843796;145489.27255363762;13876.514321998682;13975.860241397659;14305.499307524395;14459.13245205291;14639;22216.777832221473;22239.666405003936;22255.77744222537;22259.77740222577;22284.220052298093;9853.852192217122;9980.80038399228;10002;10066.949665251626;10209.132223761064;9393.765155871159;9414.211299853006;9426.293028022927;9538.809223815624;9558.426494410358;8564.443311184754;8755.824883502295;8794.824103517894;8906.906876883928;8981.955090224506;2521.0923069242967;2547.936301592475;2572.524083044643;2598.8050896182863;2632.236651371119;957.8563215517728;958.3100167879115;968.2205824311357;986.2750878104588;990.3513198854762;18214.36249731253;18244.270229190948;18425.26298948027;18599.25602975893;18776.436706898814;994.845798901157;1005.4570531912685;1012.6101450941293;1017.4454922067491;1023.4677967457029;10245.7438564035;10277.588896444058;10516.421596812095;10534.104601108991;10632.30889992148;446071;447012.059758803;468807;468967;470749;104126;104316;107854.46072769743;108111;109580;1029.2229366827996;1144.4849817582121;1164.7554013657057;1226.6626677663535;1235.4193529041336;19582.216711331956;19649;19686.310979115664;19917.203311867364;20529.692054619492;57711;58322;58404.707976459846;59568.702156488944;60407.395926040175;73302.63348683223;73586.63206683932;73981.63009184919;74174.25825741673;74773.626131869;18767.624647507248;19256;19358.225670973003;19382.70925936084;19385;21606.675899861828;21773;22017.449563761034;22070.779292207513;22144.889275554164;17596.648067038845;17657.735133973256;17877.106144692974;17903.37338193157;17909.731354029962;15982.360705572111;15986.680266394374;16033.599160020625;16178.757318639995;16492.587685307964;17308.307667693152;18130.909345453187;18284.908575457037;18394.080295985415;18406.81593184051;18803.717944230575;18936.52658683544;18945.810541894403;18975.810241897405;18978.810211897704;16290;16314.918425407797;16409.91795041017;16586.25361858695;16989.66020679604 15:54:49 INFO - PID 7701 | |3;mootools.html;1303.8565757766646;1334.9132306400081;1342.5502456677013;1344.502534062397;1356.9253691047002;14490.855091449082;16032.278547465363;16076.035437873721;16091.275892584861;16093.114878681668;15584.220788960534;15736.842631573709;15741.527754167364;15833.445829395974;15912.76130858038;2662.1348061879917;2723.1422102037795;2726.877290521931;2729.3995321029442;2730.4539092181544;2649.1390298153083;2726.61827344171;2727.154582079552;2727.4136060746937;2727.5090483712925;2607.4524349886547;2656.8405895646324;2661.920142395731;2663.014684566713;2663.4007348346563;2584.5993870949937;2598.6102084687354;2616.921492355232;2617.280247931834;2618.567936290529;2561.5517284475327;2627.789776817869;2660.0822716162893;2683.436478339551;2683.785297176241;14806.481773137995;14958.70082598342;14975.1014939104;14975.550733478012;14986.925065374713;7696.7306144284685;7996.400269979775;8004;8009.239122283374;8011.439199256054;4956.479569645171;5110.054639891632;5183.481651834824;5195.714235717034;5198.194279886624;1707.8548323392527;1853.8053504382115;1857.5077604434834;1858.87917285376;1947.7565304336958;25545.616815747777;25748.098816541333;25782.09762658298;25788.355291117496;25864;6387.648679322682;6390.584612000205;6557.377049180415;6590.340965903467;6636.369544893228;16318.428854990017;16372.426965056165;16385.180740962904;16424.917875410545;16485.34058637665;7661.540307581563;7775.844483110306;7786.922130778733;7790.805229869298;7791;6968.477364197705;7208.603526805971;7258.346748792528;7320.414366850639;7337.26627337262;4986.700797952134;5168.483151684802;5173.818916337986;5174.172132458789;5223.764930578133;1483.7996870422571;1484.2727063738691;1501.8798496120285;1508.2760275068028;1514.6216942582198;830.3813658824093;836.4563034027931;851.3104385447807;854.5385491834339;865.0700496965787;7465.514741541782;7485.401167906554;7523.3981281497345;8074.152214017561;8271.090180080186;626.996865015672;644.3556443556444;653.7483069018463;654.254150268694;656.1797752808989;4968.378952630921;5087.669301495465;5134.460881607378;5303.098473259555;5318.494742999409;19119.617607647768;19818.801811981983;20391.796082039287;20473.48816279605;20474.590508189754;20897.791022089583;21098.472538186666;21349.46626334323;21606.135754569954;21664.24175153862;11030.28303160292;11195.2723073;11215.775684486265;11310.151738619636;11335.319880807177;8256;8336.499810011175;8337.874931876147;8434.451760635538;8510.744677659432;17679.73480397821;18244.635107298047;18414.17136228846;18449.07754612237;18632.97518636488;18575.071246437896;18608.44174674762;18887.716684249473;19064.809351906304;19112.426627201206;10245.385276883411;10364.585416583554;10373;10374.118199953089;10389.37663740178;12114.818277726017;12718.745625087262;12788.552400665933;12798.16811907223;12804.487820487077;10734.946325268324;10831.783364332827;10866.18503612248;10931.125509959025;11067.889321107008;10561.313514621832;10675.66286224743;10703.678889633324;10865.565377385132;11019.44902754843;9781.608735650494;9787.902120978984;9912.801743965225;9990.250731195334;9990.600375984879;6389.424951754364;6392.87214255703;6435.163428754232;6456.289808121197;6574.408303252731;7363.963180184065;7496.475246732894;7529.247075292427;7550.320471157622;7558.773236802905 15:54:49 INFO - PID 7701 | |4;prototype.html;499.7361950364846;499.93640730631125;519.9766010529526;521.2233771680197;529.6610169491526;6226.3151053384145;6418.015622735427;6439.130717353156;6441.710123044462;6452.903206451907;6249.187605611264;6314.810555683325;6342.334054924236;6348.206474190726;6376.649284289362;5225.973870130644;5253.684778913258;5255.213227502648;5267.631265811395;5310.920336194941;4811.254255590389;4999.4000719913665;5164.399036298741;5246.475352464761;5247.553957913582;4905.730184839832;4946.084974279752;4957.380327459067;4986.650934434591;4998.750062496861;4937.308776771255;4948.406191257072;4970.440223285011;5002.199648056312;5013.398392192924;4303.376010478494;4397.384366188736;4429.512753597101;4447.644188464948;4477.171723231213;6003.879922401527;6030.96984515079;6046.183765191687;6053.1828203192445;6112.419320164578;5600.215969764236;5623.775048998035;5648.943510564883;5668.914966275509;5681.176229446748;6501.869962600769;6517.902231466532;6529.151210342625;6538.771143009972;6542.3784740450055;4579.175748365293;4825.565699087064;4851.902961940741;4854.931914978699;4865.8783530411665;6665.733370665168;6749.7300107995625;6796.592204467748;6803.149606299213;6856.725730970706;4888.877778055577;4900.970796132852;4930.950690493121;4966.925496117489;4973.751312434364;4989.3264409305;4991.251312303184;5030.572401345927;5034.270030845507;5039.672421292605;5679.602427830012;5681.204631351614;5684.261046063985;5711.600187986801;5720.656760594377;6585.769498067641;6598.802035938929;6604.735810567524;6627.10534077903;6630.635315057718;1683.6127690630979;1693.5596744846428;1694.8474637282457;1733.4452975048116;1737.695903216932;1130.4347826086957;1199.9400029998465;1204.2894692131683;1206.9318652992165;1213.6237766292302;5617.662940223599;5649.4633009864;5650.660960342392;5686.014842207874;5708.857278568069;6507.674616269168;6568.8357791055605;6605.24039735427;6649.933500664932;6668;5625.54995600351;5657.858553536113;5683.829485115453;5715.6284841486;5720.342160651495;3464.8960531184107;3474.704650104719;3481.3559491494157;3498.772579782306;3551.662592053751;6286.234057014899;6359.713812878432;6413.935860641427;6427.678616069178;6536.444402225769;6782.693884079436;6798.456123510107;6825.249222585511;6852.177738671391;6911.654417279216;6395.424411802867;6412.294647588761;6424.807255782334;6464.967675161688;6499.642519661369;5990.341062483036;6457.773977910751;6595.604263744191;6624.503162262946;6662.600243985376;6481.935180648133;6482.773102941374;6557.737690492327;6564.8358791030605;6599.208095028435;6340.4927605792345;6342.429181373698;6363.87272254543;6389;6442;4774.832880849153;4793.23308270689;4815.422149342101;4871.269309603446;4876.268559716071;6453.899293215662;6526.575772574957;6531.314212007671;6810.897836532555;6845.212800528003;6329.810105696836;6406.967965160145;6534;6538.574992625464;6595.703193356407;6517.185351831021;6529.706163222571;6544.9672751635935;6617.7683781067435;6618.602883826986;6398.392152745481;6468.450181734417;6500.317466666121;6543.3968677674275;6546.574472659262;6515.869682606416;6623.602583844985;6674.733010679518;6675.499337549801;6686;6350.90473642905;6405.135306733531;6425.967870160806;6430.582012169194;6440.194975628046 15:54:49 INFO - PID 7701 | |5;yui.html;856.131027007587;856.6530555125173;866.1079088538803;913.1872633356314;950.6245033211882;16859.32562697492;17094.82905170948;17148.742768858447;17277.999999999967;17285.30858765651;14457.92771036146;15542.5337239883;15548.144852033134;15826.28781704823;15898.84101158988;938.8263171313312;965.9227261819073;969.4813274897931;969.7187815533487;969.8933117357085;951.857221416786;966.1739212972913;973.6251543155901;986.2061040862103;991.1575161113033;1015.035716069733;1015.2994433840627;1019.2763138171907;1023.6468418395679;1026.0150255754484;982.6511588386127;1005.7435353984723;1013.0578561937396;1014.5941623350645;1019.1490105761661;740.3928778401713;740.6666999850089;741.5550669598252;741.929516695913;742.0501757750088;17831.197596108206;17842.10789460522;17864;17911.283548658037;17920.91039544794;21151.576968460544;21951.67072493914;22000.669989950162;22004.88997555018;22099.226527071634;17401.65196696059;17803.73294400585;18065.909670451696;18084.638307233912;18089;3773.471713960048;3786.659200671953;3792.4500947362476;3800.8289626966575;3801.391777315644;133443.33278333643;133978;134498.32750836283;134840.32579837137;137343;16508.42220522276;16632.750508742378;16643.667126657398;16742.66514669724;16764.497065088068;28875;30891.691083089332;31342.686573134433;31352.686473135433;31513;7561.432892532972;7591;7610.048743907012;7612.200718924544;7614.581198034161;4080.367543030835;4117;4199.307114326163;4223.556526564728;4227.556106608762;5296.549793267615;5417.945820541744;5418.376886658006;5424.701641409761;5444.183372494158;944.8677185194078;978.1343510992823;982.3369225772575;982.4596471940404;989.5992123190119;606.1423086332878;611.9571629985858;617.9196704428396;623.1213988276598;642;11351.60269390584;11634.883651163549;12086.093542984136;12109.273443593236;12190.39048047594;560.6019725994508;563.1721369586701;568.116578720086;576.0840263980291;578.8668606220593;5605.915911261334;5613.607047506717;5654.180143879114;5685.090385538294;5781.566382521243;123431;124497;124519;125132.74867251393;125946;105594.47202763936;107403;108456.66701655035;111300;112185.43907280575;91649.54175229081;93472.53263733638;93973.5301323489;95276.52361738146;96471.51764241274;10366.688999330032;10595.523201456108;10677.89322106769;10718.14254859625;10826.56693732242;43269.350959735;43572.78213608912;44289.77855110833;44501.33248001218;44725;56574.71712641411;57302.426975731374;58452.4154758447;58576;59673;15417.306221219847;15715.214239288218;15724;15890.284937177623;15954.282057307217;17099.487015389557;17441.73837392415;17482.562935926704;17483.650326993644;17685.204165812313;14535.85464145345;14554.563363099123;14713.411463541339;14750.778738319148;14838.777418338517;14020.509282175075;14096.577102686935;14100.36548355347;14207.289635517976;14311.499097531536;14132.222727750073;14272.429102835771;14312.57062288133;14379.496717614833;14392.06451580644;11315.773684526099;11422.771544568895;11495.367754773568;11525.884741152817;11700.94691477771;10737.03366697001;10796.89203107959;10835.404052777172;10977.615783447542;11066.778664426827 15:54:49 INFO - PID 7701 | __end_tp_report 15:54:49 INFO - PID 7701 | __start_cc_report 15:54:49 INFO - PID 7701 | _x_x_mozilla_cycle_collect,378 15:54:49 INFO - PID 7701 | __end_cc_report 15:54:49 INFO - PID 7701 | __startTimestamp1505170489557__endTimestamp 15:54:49 INFO - PID 7701 | 15:54:49 INFO - PID 7701 | ------- Summary: start ------- 15:54:49 INFO - PID 7701 | Number of tests: 6 15:54:49 INFO - PID 7701 | 15:54:49 INFO - PID 7701 | [#0] dojo.html Cycles:165 Average:6241.48 Median:6516.22 stddev:834.56 (12.8%) stddev-sans-first:800.21 15:54:49 INFO - PID 7701 | Values: 3112.5 3145.7 3182.4 3194.0 3195.6 6218.9 6373.0 6382.3 6407.1 6465.3 6354.4 6369.8 6399.2 6487.2 6494.4 1342.8 5893.8 5909.3 5931.2 5944.9 5810.7 5865.1 5939.3 5950.1 5963.2 5858.1 5860.7 5935.1 5936.6 5940.5 5849.6 5853.9 5917.0 5933.8 5938.0 5825.8 5838.9 5896.2 5903.8 5917.7 6234.0 6293.6 6334.6 6369.2 6443.8 6669.9 6749.8 6751.2 6752.1 6768.4 6725.6 6755.3 6828.8 6847.6 6850.0 6241.9 6244.1 6261.7 6327.4 6330.3 6949.6 6972.9 6978.9 6988.0 6993.1 6635.7 6643.5 6657.6 6668.9 6670.9 6783.6 6799.9 6880.6 6887.0 6889.9 6754.3 6790.9 6835.7 6861.8 6862.2 6655.3 6740.3 6769.8 6803.8 6893.3 5331.4 5367.8 5375.1 5389.2 5396.2 4679.8 4720.6 4744.1 4750.0 4773.8 5854.7 5856.8 5927.0 5939.6 5942.3 6723.4 6820.9 6838.4 6883.1 6900.5 5875.1 5901.2 5909.6 5911.8 5923.9 5838.8 5852.1 5908.9 5909.0 5928.0 6578.3 6601.3 6663.5 6678.5 6692.3 6595.4 6713.4 6774.3 6819.0 6926.6 6616.3 6634.5 6636.4 6651.4 6657.5 6715.2 6732.5 6734.8 6788.4 6817.6 6822.6 6867.4 6931.1 6938.7 6952.7 6403.2 6513.3 6516.2 6517.9 6589.9 6583.3 6592.4 6613.3 6691.6 6700.8 6530.7 6543.2 6629.5 6630.4 6634.3 6608.5 6703.7 6737.2 6768.7 6771.1 6311.1 6385.9 6420.1 6421.7 6428.2 15:54:49 INFO - PID 7701 | 15:54:49 INFO - PID 7701 | [#1] ext.html Cycles:180 Average:36113.36 Median:3310.73 stddev:50262.33 (1518.2%) stddev-sans-first:50333.39 15:54:49 INFO - PID 7701 | Values: 802.7 832.6 834.6 838.9 839.9 37593.2 41437.0 41439.6 41474.2 41648.8 38226.2 38356.8 38432.0 38479.0 38480.6 7017.8 7153.2 7465.5 7760.4 7762.1 7597.4 7713.6 7716.2 7717.3 7725.0 7608.9 7765.1 7809.5 7810.9 7815.2 7719.6 7735.0 7740.9 7757.4 7765.3 7636.2 7670.0 7681.5 7696.7 7703.4 37451.4 37641.2 37742.8 37771.0 37829.2 3278.9 3309.0 3312.5 3315.5 3316.8 31173.8 31239.1 31292.5 31323.2 31369.0 5029.5 5175.6 5207.1 5207.8 5225.9 180016.0 180214.1 180801.0 180956.6 181453.0 41168.4 42102.2 46675.8 46751.8 47178.3 49966.5 50011.0 50034.5 50076.0 50167.7 16216.9 16351.2 16365.4 16379.1 16384.4 13473.1 13492.9 13500.8 13502.6 13621.2 14014.8 14072.2 14095.5 14101.4 14228.5 5768.8 5860.2 5866.3 5871.6 5895.3 1003.4 1007.8 1011.3 1013.0 1015.1 22400.2 22469.0 22469.1 22494.0 22636.8 1098.9 1100.7 1108.7 1117.2 1127.4 11784.2 11948.9 12006.6 12063.3 12118.8 213342.0 213839.0 214964.0 214996.0 215085.0 51748.7 52036.0 52081.2 52131.7 52232.0 1420.9 1472.4 1474.2 1477.8 1480.0 21893.7 21923.5 22088.8 22630.9 22640.7 32753.3 37128.8 37143.3 37147.3 37207.0 185067.0 185931.0 186776.0 187113.0 187273.0 30370.2 30835.7 31132.4 33643.3 33789.2 43587.8 43673.6 43711.8 44041.3 44166.6 31283.5 31890.8 31915.5 32172.7 32785.3 31299.4 31936.8 31951.2 32069.4 32829.3 35015.3 35083.3 35368.8 35873.6 35992.6 30853.8 30927.8 31042.7 31206.2 31363.2 22849.4 22867.5 23290.4 23380.8 23604.3 15:54:49 INFO - PID 7701 | 15:54:49 INFO - PID 7701 | [#2] jquery.html Cycles:180 Average:33551.46 Median:22180.83 stddev:77635.47 (350.0%) stddev-sans-first:77813.71 15:54:49 INFO - PID 7701 | Values: 549.6 564.8 577.8 578.9 596.4 22129.3 22727.0 22745.0 22790.3 22813.2 19661.5 20089.8 20473.3 23502.2 23636.4 6574.7 6649.6 6696.7 6721.2 6722.1 6241.9 6589.6 6681.6 6682.6 6691.0 6427.1 6433.3 6436.6 6438.8 6443.0 6394.3 6428.3 6433.0 6433.7 6435.4 6132.5 6167.5 6184.4 6191.2 6194.4 27697.3 28134.2 28162.0 28181.3 28191.9 2061.1 2066.0 2066.6 2081.6 2095.3 18461.1 18918.3 19157.6 19206.2 19277.9 2334.6 2341.1 2394.8 2399.3 2402.7 118748.4 124550.0 131138.0 137504.3 145489.3 13876.5 13975.9 14305.5 14459.1 14639.0 22216.8 22239.7 22255.8 22259.8 22284.2 9853.9 9980.8 10002.0 10066.9 10209.1 9393.8 9414.2 9426.3 9538.8 9558.4 8564.4 8755.8 8794.8 8906.9 8982.0 2521.1 2547.9 2572.5 2598.8 2632.2 957.9 958.3 968.2 986.3 990.4 18214.4 18244.3 18425.3 18599.3 18776.4 994.8 1005.5 1012.6 1017.4 1023.5 10245.7 10277.6 10516.4 10534.1 10632.3 446071.0 447012.1 468807.0 468967.0 470749.0 104126.0 104316.0 107854.5 108111.0 109580.0 1029.2 1144.5 1164.8 1226.7 1235.4 19582.2 19649.0 19686.3 19917.2 20529.7 57711.0 58322.0 58404.7 59568.7 60407.4 73302.6 73586.6 73981.6 74174.3 74773.6 18767.6 19256.0 19358.2 19382.7 19385.0 21606.7 21773.0 22017.4 22070.8 22144.9 17596.6 17657.7 17877.1 17903.4 17909.7 15982.4 15986.7 16033.6 16178.8 16492.6 17308.3 18130.9 18284.9 18394.1 18406.8 18803.7 18936.5 18945.8 18975.8 18978.8 16290.0 16314.9 16409.9 16586.3 16989.7 15:54:49 INFO - PID 7701 | 15:54:49 INFO - PID 7701 | [#3] mootools.html Cycles:180 Average:9092.59 Median:2617.92 stddev:6511.53 (248.7%) stddev-sans-first:6503.50 15:54:49 INFO - PID 7701 | Values: 1303.9 1334.9 1342.6 1344.5 1356.9 14490.9 16032.3 16076.0 16091.3 16093.1 15584.2 15736.8 15741.5 15833.4 15912.8 2662.1 2723.1 2726.9 2729.4 2730.5 2649.1 2726.6 2727.2 2727.4 2727.5 2607.5 2656.8 2661.9 2663.0 2663.4 2584.6 2598.6 2616.9 2617.3 2618.6 2561.6 2627.8 2660.1 2683.4 2683.8 14806.5 14958.7 14975.1 14975.6 14986.9 7696.7 7996.4 8004.0 8009.2 8011.4 4956.5 5110.1 5183.5 5195.7 5198.2 1707.9 1853.8 1857.5 1858.9 1947.8 25545.6 25748.1 25782.1 25788.4 25864.0 6387.6 6390.6 6557.4 6590.3 6636.4 16318.4 16372.4 16385.2 16424.9 16485.3 7661.5 7775.8 7786.9 7790.8 7791.0 6968.5 7208.6 7258.3 7320.4 7337.3 4986.7 5168.5 5173.8 5174.2 5223.8 1483.8 1484.3 1501.9 1508.3 1514.6 830.4 836.5 851.3 854.5 865.1 7465.5 7485.4 7523.4 8074.2 8271.1 627.0 644.4 653.7 654.3 656.2 4968.4 5087.7 5134.5 5303.1 5318.5 19119.6 19818.8 20391.8 20473.5 20474.6 20897.8 21098.5 21349.5 21606.1 21664.2 11030.3 11195.3 11215.8 11310.2 11335.3 8256.0 8336.5 8337.9 8434.5 8510.7 17679.7 18244.6 18414.2 18449.1 18633.0 18575.1 18608.4 18887.7 19064.8 19112.4 10245.4 10364.6 10373.0 10374.1 10389.4 12114.8 12718.7 12788.6 12798.2 12804.5 10734.9 10831.8 10866.2 10931.1 11067.9 10561.3 10675.7 10703.7 10865.6 11019.4 9781.6 9787.9 9912.8 9990.3 9990.6 6389.4 6392.9 6435.2 6456.3 6574.4 7364.0 7496.5 7529.2 7550.3 7558.8 15:54:49 INFO - PID 7701 | 15:54:49 INFO - PID 7701 | [#4] prototype.html Cycles:180 Average:5483.85 Median:6169.37 stddev:1543.18 (25.0%) stddev-sans-first:1501.48 15:54:49 INFO - PID 7701 | Values: 499.7 499.9 520.0 521.2 529.7 6226.3 6418.0 6439.1 6441.7 6452.9 6249.2 6314.8 6342.3 6348.2 6376.6 5226.0 5253.7 5255.2 5267.6 5310.9 4811.3 4999.4 5164.4 5246.5 5247.6 4905.7 4946.1 4957.4 4986.7 4998.8 4937.3 4948.4 4970.4 5002.2 5013.4 4303.4 4397.4 4429.5 4447.6 4477.2 6003.9 6031.0 6046.2 6053.2 6112.4 5600.2 5623.8 5648.9 5668.9 5681.2 6501.9 6517.9 6529.2 6538.8 6542.4 4579.2 4825.6 4851.9 4854.9 4865.9 6665.7 6749.7 6796.6 6803.1 6856.7 4888.9 4901.0 4931.0 4966.9 4973.8 4989.3 4991.3 5030.6 5034.3 5039.7 5679.6 5681.2 5684.3 5711.6 5720.7 6585.8 6598.8 6604.7 6627.1 6630.6 1683.6 1693.6 1694.8 1733.4 1737.7 1130.4 1199.9 1204.3 1206.9 1213.6 5617.7 5649.5 5650.7 5686.0 5708.9 6507.7 6568.8 6605.2 6649.9 6668.0 5625.5 5657.9 5683.8 5715.6 5720.3 3464.9 3474.7 3481.4 3498.8 3551.7 6286.2 6359.7 6413.9 6427.7 6536.4 6782.7 6798.5 6825.2 6852.2 6911.7 6395.4 6412.3 6424.8 6465.0 6499.6 5990.3 6457.8 6595.6 6624.5 6662.6 6481.9 6482.8 6557.7 6564.8 6599.2 6340.5 6342.4 6363.9 6389.0 6442.0 4774.8 4793.2 4815.4 4871.3 4876.3 6453.9 6526.6 6531.3 6810.9 6845.2 6329.8 6407.0 6534.0 6538.6 6595.7 6517.2 6529.7 6545.0 6617.8 6618.6 6398.4 6468.5 6500.3 6543.4 6546.6 6515.9 6623.6 6674.7 6675.5 6686.0 6350.9 6405.1 6426.0 6430.6 6440.2 15:54:49 INFO - PID 7701 | 15:54:49 INFO - PID 7701 | [#5] yui.html Cycles:180 Average:23835.82 Median:17993.41 stddev:35083.28 (195.0%) stddev-sans-first:35139.27 15:54:49 INFO - PID 7701 | Values: 856.1 856.7 866.1 913.2 950.6 16859.3 17094.8 17148.7 17278.0 17285.3 14457.9 15542.5 15548.1 15826.3 15898.8 938.8 965.9 969.5 969.7 969.9 951.9 966.2 973.6 986.2 991.2 1015.0 1015.3 1019.3 1023.6 1026.0 982.7 1005.7 1013.1 1014.6 1019.1 740.4 740.7 741.6 741.9 742.1 17831.2 17842.1 17864.0 17911.3 17920.9 21151.6 21951.7 22000.7 22004.9 22099.2 17401.7 17803.7 18065.9 18084.6 18089.0 3773.5 3786.7 3792.5 3800.8 3801.4 133443.3 133978.0 134498.3 134840.3 137343.0 16508.4 16632.8 16643.7 16742.7 16764.5 28875.0 30891.7 31342.7 31352.7 31513.0 7561.4 7591.0 7610.0 7612.2 7614.6 4080.4 4117.0 4199.3 4223.6 4227.6 5296.5 5417.9 5418.4 5424.7 5444.2 944.9 978.1 982.3 982.5 989.6 606.1 612.0 617.9 623.1 642.0 11351.6 11634.9 12086.1 12109.3 12190.4 560.6 563.2 568.1 576.1 578.9 5605.9 5613.6 5654.2 5685.1 5781.6 123431.0 124497.0 124519.0 125132.7 125946.0 105594.5 107403.0 108456.7 111300.0 112185.4 91649.5 93472.5 93973.5 95276.5 96471.5 10366.7 10595.5 10677.9 10718.1 10826.6 43269.4 43572.8 44289.8 44501.3 44725.0 56574.7 57302.4 58452.4 58576.0 59673.0 15417.3 15715.2 15724.0 15890.3 15954.3 17099.5 17441.7 17482.6 17483.7 17685.2 14535.9 14554.6 14713.4 14750.8 14838.8 14020.5 14096.6 14100.4 14207.3 14311.5 14132.2 14272.4 14312.6 14379.5 14392.1 11315.8 11422.8 11495.4 11525.9 11700.9 10737.0 10796.9 10835.4 10977.6 11066.8 15:54:49 INFO - PID 7701 | -------- Summary: end -------- 15:54:49 INFO - PID 7701 | 15:54:50 INFO - TEST-INFO | 7701: exit 0 15:54:50 INFO - TEST-OK | dromaeo_css | took 1109341ms 15:54:50 INFO - TEST-START | kraken 15:54:50 INFO - Initialising browser for kraken test... 15:54:50 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:38624/getInfo.html -profile /tmp/tmpynlXy7/profile 15:54:50 INFO - TEST-INFO | started process 8082 (/builds/slave/test/build/application/firefox/firefox http://localhost:38624/getInfo.html) 15:54:56 INFO - TEST-INFO | 8082: exit 0 15:54:56 INFO - Browser initialized. 15:54:56 INFO - Running cycle 1/1 for kraken test... 15:54:56 INFO - Using env: {'DISPLAY': ':0', 15:54:56 INFO - 'HOME': '/home/cltbld', 15:54:56 INFO - 'JSGC_DISABLE_POISONING': '1', 15:54:56 INFO - 'LANG': 'en_US.UTF-8', 15:54:56 INFO - 'LANGUAGE': 'en_US:en', 15:54:56 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 15:54:56 INFO - 'LOGNAME': 'cltbld', 15:54:56 INFO - 'MAIL': '/var/mail/cltbld', 15:54:56 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 15:54:56 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 15:54:56 INFO - 'MOZ_CRASHREPORTER': '1', 15:54:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:54:56 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 15:54:56 INFO - 'MOZ_NO_REMOTE': '1', 15:54:56 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 15:54:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:54:56 INFO - 'NO_EM_RESTART': '1', 15:54:56 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:54:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:54:56 INFO - 'PWD': '/builds/slave/test', 15:54:56 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 15:54:56 INFO - 'RUST_BACKTRACE': 'full', 15:54:56 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 15:54:56 INFO - 'SHELL': '/bin/bash', 15:54:56 INFO - 'SHLVL': '1', 15:54:56 INFO - 'TERM': 'linux', 15:54:56 INFO - 'TMOUT': '86400', 15:54:56 INFO - 'USER': 'cltbld', 15:54:56 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1505167450.332409-1360272433', 15:54:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:54:56 INFO - '_': '/tools/buildbot/bin/python'} 15:54:56 INFO - TEST-INFO | started process 8282 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpynlXy7/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 15:54:57 INFO - PID 8282 | 15:54:57 INFO - PID 8282 | (/builds/slave/test/build/application/firefox/firefox:8333): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 15:54:57 INFO - PID 8282 | 15:55:07 INFO - PID 8282 | RSS: Main: 167866368 15:55:07 INFO - PID 8282 | 15:55:10 INFO - PID 8282 | Cycle 1(1): loaded http://localhost:38624/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:38624/tests/kraken/driver.html?testName=audio-beat-detection) 15:55:11 INFO - PID 8282 | RSS: Main: 172994560 15:55:11 INFO - PID 8282 | 15:55:14 INFO - PID 8282 | Cycle 1(1): loaded http://localhost:38624/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:38624/tests/kraken/driver.html?testName=audio-dft) 15:55:14 INFO - PID 8282 | RSS: Main: 172871680 15:55:14 INFO - PID 8282 | 15:55:17 INFO - PID 8282 | Cycle 1(1): loaded http://localhost:38624/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:38624/tests/kraken/driver.html?testName=audio-fft) 15:55:18 INFO - PID 8282 | RSS: Main: 168599552 15:55:18 INFO - PID 8282 | 15:55:20 INFO - PID 8282 | Cycle 1(1): loaded http://localhost:38624/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:38624/tests/kraken/driver.html?testName=audio-oscillator) 15:55:21 INFO - PID 8282 | RSS: Main: 169005056 15:55:21 INFO - PID 8282 | 15:55:23 INFO - PID 8282 | Cycle 1(1): loaded http://localhost:38624/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:38624/tests/kraken/driver.html?testName=imaging-gaussian-blur) 15:55:23 INFO - PID 8282 | RSS: Main: 169578496 15:55:23 INFO - PID 8282 | 15:55:27 INFO - PID 8282 | Cycle 1(1): loaded http://localhost:38624/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:38624/tests/kraken/driver.html?testName=imaging-darkroom) 15:55:27 INFO - PID 8282 | RSS: Main: 171659264 15:55:27 INFO - PID 8282 | 15:55:31 INFO - PID 8282 | Cycle 1(1): loaded http://localhost:38624/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:38624/tests/kraken/driver.html?testName=imaging-desaturate) 15:55:32 INFO - PID 8282 | RSS: Main: 171847680 15:55:32 INFO - PID 8282 | 15:55:35 INFO - PID 8282 | Cycle 1(1): loaded http://localhost:38624/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:38624/tests/kraken/driver.html?testName=json-parse-financial) 15:55:35 INFO - PID 8282 | RSS: Main: 172544000 15:55:35 INFO - PID 8282 | 15:55:37 INFO - PID 8282 | Cycle 1(1): loaded http://localhost:38624/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:38624/tests/kraken/driver.html?testName=json-stringify-tinderbox) 15:55:37 INFO - PID 8282 | RSS: Main: 172564480 15:55:37 INFO - PID 8282 | 15:55:39 INFO - PID 8282 | Cycle 1(1): loaded http://localhost:38624/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:38624/tests/kraken/driver.html?testName=stanford-crypto-aes) 15:55:40 INFO - PID 8282 | RSS: Main: 172638208 15:55:40 INFO - PID 8282 | 15:55:42 INFO - PID 8282 | Cycle 1(1): loaded http://localhost:38624/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:38624/tests/kraken/driver.html?testName=stanford-crypto-ccm) 15:55:43 INFO - PID 8282 | RSS: Main: 172621824 15:55:43 INFO - PID 8282 | 15:55:45 INFO - PID 8282 | Cycle 1(1): loaded http://localhost:38624/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:38624/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 15:55:46 INFO - PID 8282 | RSS: Main: 173408256 15:55:46 INFO - PID 8282 | 15:55:49 INFO - PID 8282 | Cycle 1(1): loaded http://localhost:38624/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:38624/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 15:55:49 INFO - PID 8282 | RSS: Main: 173314048 15:55:49 INFO - PID 8282 | 15:55:51 INFO - PID 8282 | Cycle 1(1): loaded http://localhost:38624/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:38624/tests/kraken/driver.html?testName=ai-astar) 15:55:51 INFO - PID 8282 | RSS: Main: 174854144 15:55:51 INFO - PID 8282 | 15:55:51 INFO - PID 8282 | __start_tp_report 15:55:51 INFO - PID 8282 | _x_x_mozilla_page_load 15:55:51 INFO - PID 8282 | _x_x_mozilla_page_load_details 15:55:51 INFO - PID 8282 | |i|pagename|runs| 15:55:51 INFO - PID 8282 | |0;ai-astar;108;107;108;109;111;111;109;107;109;108 15:55:51 INFO - PID 8282 | |1;audio-beat-detection;131;117;118;149;116;116;117;119;118;115 15:55:51 INFO - PID 8282 | |2;audio-dft;165;162;162;162;163;162;166;163;169;171 15:55:51 INFO - PID 8282 | |3;audio-fft;74;80;74;73;73;75;76;147;74;76 15:55:51 INFO - PID 8282 | |4;audio-oscillator;80;79;81;79;80;80;79;79;79;80 15:55:51 INFO - PID 8282 | |5;imaging-gaussian-blur;113;114;114;115;114;117;117;114;113;117 15:55:51 INFO - PID 8282 | |6;imaging-darkroom;149;150;148;148;150;150;150;149;149;151 15:55:51 INFO - PID 8282 | |7;imaging-desaturate;94;95;94;94;93;94;94;94;94;94 15:55:51 INFO - PID 8282 | |8;json-parse-financial;56;53;53;54;56;53;55;55;54;55 15:55:51 INFO - PID 8282 | |9;json-stringify-tinderbox;38;39;38;38;39;43;39;39;38;38 15:55:51 INFO - PID 8282 | |10;stanford-crypto-aes;74;79;75;76;73;76;73;73;76;79 15:55:51 INFO - PID 8282 | |11;stanford-crypto-ccm;111;116;121;112;120;111;119;118;114;111 15:55:51 INFO - PID 8282 | |12;stanford-crypto-pbkdf2;174;175;174;167;168;175;168;168;167;175 15:55:51 INFO - PID 8282 | |13;stanford-crypto-sha256-iterative;65;63;69;67;69;66;64;64;78;65 15:55:51 INFO - PID 8282 | __end_tp_report 15:55:51 INFO - PID 8282 | __start_cc_report 15:55:51 INFO - PID 8282 | _x_x_mozilla_cycle_collect,933 15:55:51 INFO - PID 8282 | __end_cc_report 15:55:51 INFO - PID 8282 | __startTimestamp1505170551958__endTimestamp 15:55:51 INFO - PID 8282 | 15:55:51 INFO - PID 8282 | ------- Summary: start ------- 15:55:51 INFO - PID 8282 | Number of tests: 14 15:55:51 INFO - PID 8282 | 15:55:51 INFO - PID 8282 | [#0] ai-astar Cycles:10 Average:108.70 Median:109.00 stddev:1.42 (1.3%) stddev-sans-first:1.48 15:55:51 INFO - PID 8282 | Values: 108.0 107.0 108.0 109.0 111.0 111.0 109.0 107.0 109.0 108.0 15:55:51 INFO - PID 8282 | 15:55:51 INFO - PID 8282 | [#1] audio-beat-detection Cycles:10 Average:121.60 Median:118.00 stddev:10.65 (9.0%) stddev-sans-first:10.74 15:55:51 INFO - PID 8282 | Values: 131.0 117.0 118.0 149.0 116.0 116.0 117.0 119.0 118.0 115.0 15:55:51 INFO - PID 8282 | 15:55:51 INFO - PID 8282 | [#2] audio-dft Cycles:10 Average:164.50 Median:164.00 stddev:3.24 (2.0%) stddev-sans-first:3.43 15:55:51 INFO - PID 8282 | Values: 165.0 162.0 162.0 162.0 163.0 162.0 166.0 163.0 169.0 171.0 15:55:51 INFO - PID 8282 | 15:55:51 INFO - PID 8282 | [#3] audio-fft Cycles:10 Average:82.20 Median:74.50 stddev:22.86 (30.7%) stddev-sans-first:24.05 15:55:51 INFO - PID 8282 | Values: 74.0 80.0 74.0 73.0 73.0 75.0 76.0 147.0 74.0 76.0 15:55:51 INFO - PID 8282 | 15:55:51 INFO - PID 8282 | [#4] audio-oscillator Cycles:10 Average:79.60 Median:80.00 stddev:0.70 (0.9%) stddev-sans-first:0.73 15:55:51 INFO - PID 8282 | Values: 80.0 79.0 81.0 79.0 80.0 80.0 79.0 79.0 79.0 80.0 15:55:51 INFO - PID 8282 | 15:55:51 INFO - PID 8282 | [#5] imaging-gaussian-blur Cycles:10 Average:114.80 Median:114.50 stddev:1.62 (1.4%) stddev-sans-first:1.58 15:55:51 INFO - PID 8282 | Values: 113.0 114.0 114.0 115.0 114.0 117.0 117.0 114.0 113.0 117.0 15:55:51 INFO - PID 8282 | 15:55:51 INFO - PID 8282 | [#6] imaging-darkroom Cycles:10 Average:149.40 Median:150.00 stddev:0.97 (0.6%) stddev-sans-first:1.01 15:55:51 INFO - PID 8282 | Values: 149.0 150.0 148.0 148.0 150.0 150.0 150.0 149.0 149.0 151.0 15:55:51 INFO - PID 8282 | 15:55:51 INFO - PID 8282 | [#7] imaging-desaturate Cycles:10 Average:94.00 Median:94.00 stddev:0.47 (0.5%) stddev-sans-first:0.50 15:55:51 INFO - PID 8282 | Values: 94.0 95.0 94.0 94.0 93.0 94.0 94.0 94.0 94.0 94.0 15:55:51 INFO - PID 8282 | 15:55:51 INFO - PID 8282 | [#8] json-parse-financial Cycles:10 Average:54.40 Median:55.00 stddev:1.17 (2.1%) stddev-sans-first:1.09 15:55:51 INFO - PID 8282 | Values: 56.0 53.0 53.0 54.0 56.0 53.0 55.0 55.0 54.0 55.0 15:55:51 INFO - PID 8282 | 15:55:51 INFO - PID 8282 | [#9] json-stringify-tinderbox Cycles:10 Average:38.90 Median:39.00 stddev:1.52 (3.9%) stddev-sans-first:1.58 15:55:51 INFO - PID 8282 | Values: 38.0 39.0 38.0 38.0 39.0 43.0 39.0 39.0 38.0 38.0 15:55:51 INFO - PID 8282 | 15:55:51 INFO - PID 8282 | [#10] stanford-crypto-aes Cycles:10 Average:75.40 Median:76.00 stddev:2.27 (3.0%) stddev-sans-first:2.35 15:55:51 INFO - PID 8282 | Values: 74.0 79.0 75.0 76.0 73.0 76.0 73.0 73.0 76.0 79.0 15:55:51 INFO - PID 8282 | 15:55:51 INFO - PID 8282 | [#11] stanford-crypto-ccm Cycles:10 Average:115.30 Median:117.00 stddev:4.00 (3.4%) stddev-sans-first:3.93 15:55:51 INFO - PID 8282 | Values: 111.0 116.0 121.0 112.0 120.0 111.0 119.0 118.0 114.0 111.0 15:55:51 INFO - PID 8282 | 15:55:51 INFO - PID 8282 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:171.10 Median:174.00 stddev:3.73 (2.1%) stddev-sans-first:3.80 15:55:51 INFO - PID 8282 | Values: 174.0 175.0 174.0 167.0 168.0 175.0 168.0 168.0 167.0 175.0 15:55:51 INFO - PID 8282 | 15:55:51 INFO - PID 8282 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.00 Median:66.50 stddev:4.37 (6.6%) stddev-sans-first:4.58 15:55:51 INFO - PID 8282 | Values: 65.0 63.0 69.0 67.0 69.0 66.0 64.0 64.0 78.0 65.0 15:55:51 INFO - PID 8282 | -------- Summary: end -------- 15:55:51 INFO - PID 8282 | 15:55:52 INFO - PID 8282 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 15:55:52 INFO - TEST-INFO | 8282: exit 0 15:55:52 INFO - TEST-OK | kraken | took 62396ms 15:55:52 INFO - SUITE-END | took 1171s 15:55:53 INFO - Completed test suite (00:19:32) 15:55:53 INFO - javascript benchmark 15:55:53 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8370.360047980532, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3112.5331200319947, 3145.6697046810086, 3182.379436009979, 3194.0, 3195.6005499312587, 6218.937810621893, 6372.968135159318, 6382.329855365184, 6407.103005579217, 6465.288818229991, 6354.396332348431, 6369.808905732823, 6399.1681081459465, 6487.156669632953, 6494.415502604765, 1342.8124654850683, 5893.823185304448, 5909.290885093784, 5931.169636250928, 5944.88110237795, 5810.738516766755, 5865.149553314767, 5939.287285525743, 5950.077737950603, 5963.194968679238, 5858.121281807742, 5860.736266868002, 5935.050391937312, 5936.614120082181, 5940.495057920082, 5849.561282903799, 5853.85365365865, 5917.023691090965, 5933.821985340403, 5938.0499120141, 5825.79609713658, 5838.883222335572, 5896.233489646362, 5903.822885313448, 5917.674527900964, 6233.96883015582, 6293.622382657009, 6334.588251763621, 6369.20384951881, 6443.806685799434, 6669.866602667919, 6749.797506074777, 6751.189857217117, 6752.122224110834, 6768.39084482394, 6725.630090345029, 6755.2906944771075, 6828.795136145924, 6847.589144651337, 6850.040994260808, 6241.906371404432, 6244.0633904914175, 6261.749530018794, 6327.3988971047675, 6330.335314791972, 6949.617771022642, 6972.91919752429, 6978.930210697929, 6987.965060174666, 6993.055937448481, 6635.668216589152, 6643.468522518187, 6657.600543967377, 6668.899966500507, 6670.866582668319, 6783.626900520519, 6799.93200067993, 6880.552764070319, 6887.0, 6889.931100689029, 6754.3245675433045, 6790.864182716318, 6835.692393842289, 6861.828454288583, 6862.210845752802, 6655.334466553403, 6740.258571557125, 6769.763058292936, 6803.795886123424, 6893.276205998398, 5331.360236771535, 5367.812126575551, 5375.1131063374105, 5389.218563308298, 5396.244525766396, 4679.766011699401, 4720.645951553647, 4744.146053710297, 4750.002499475149, 4773.76131193439, 5854.736536855852, 5856.795012174639, 5927.0, 5939.584229103922, 5942.257217847769, 6723.361280678328, 6820.897686534706, 6838.418734407631, 6883.139607549057, 6900.516963812585, 5875.118732190205, 5901.17383566301, 5909.645421274738, 5911.822645320647, 5923.911141332884, 5838.824835254864, 5852.122181672783, 5908.881822363529, 5908.970455147783, 5928.021876390433, 6578.27638959714, 6601.339866013456, 6663.466922646274, 6678.532502724763, 6692.263850976388, 6595.406413422815, 6713.362230588086, 6774.3225677431865, 6819.011243369684, 6926.58440493572, 6616.338366163345, 6634.535582509178, 6636.369544893228, 6651.43462805667, 6657.533972622064, 6715.1941766988275, 6732.461403087839, 6734.831629209309, 6788.389044985975, 6817.590944543145, 6822.556533825285, 6867.416269617139, 6931.133608298963, 6938.653067346713, 6952.652367381509, 6403.167588213502, 6513.2835388108215, 6516.218053833571, 6517.869642607026, 6589.901151482827, 6583.275839657538, 6592.43964263043, 6613.305602911625, 6691.631960242234, 6700.83247918806, 6530.706118224786, 6543.1821022372205, 6629.502787290876, 6630.370114839083, 6634.303398143125, 6608.537402381787, 6703.698333574904, 6737.157855268091, 6768.7292508299115, 6771.052052712723, 6311.053341998737, 6385.8722825544155, 6420.101185834081, 6421.678916054085, 6428.164338635947], "value": 6181.109301253449, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [802.6789284286285, 832.6128350317101, 834.5910503853112, 838.8657814749641, 839.8824164616955, 37593.248135037284, 41437.0, 41439.58560414395, 41474.170516589686, 41648.79175604118, 38226.23547529048, 38356.80821595888, 38432.03919901997, 38479.0, 38480.615193848054, 7017.789466316019, 7153.177384600785, 7465.477416580841, 7760.417968652374, 7762.068551773795, 7597.354224890891, 7713.575753333593, 7716.151223365426, 7717.305442510173, 7725.034370703662, 7608.923910760877, 7765.1070126935565, 7809.492382995116, 7810.921890781076, 7815.218478152196, 7719.614019299041, 7734.961325193394, 7740.922590774133, 7757.379409647215, 7765.262300081483, 7636.160022397532, 7670.041244844395, 7681.539107653559, 7696.730614428524, 7703.422243331773, 37451.438228426596, 37641.24717505662, 37742.811285943666, 37771.0, 37829.243415131816, 3278.8688452461874, 3308.983455082733, 3312.4700047992446, 3315.5026745988052, 3316.8341582921, 31173.844130779427, 31239.06282811519, 31292.53061204084, 31323.216919576964, 31369.0, 5029.522195391469, 5175.611829112831, 5207.114790485626, 5207.843764687065, 5225.947740522584, 180016.0, 180214.09892950582, 180801.0, 180956.57130286112, 181452.9999999987, 41168.38247426291, 42102.15795684069, 46675.76662116668, 46751.766241168574, 47178.29232561514, 49966.50033499691, 50011.0, 50034.49965500371, 50076.0, 50167.74916125469, 16216.918915405347, 16351.182440877908, 16365.42721004783, 16379.09914954689, 16384.426545070866, 13473.124246923919, 13492.86507134916, 13500.797488037688, 13502.594922152155, 13621.18272903609, 14014.789778153336, 14072.226027568582, 14095.506657266946, 14101.435942562388, 14228.510010748078, 5768.798092066758, 5860.150278209721, 5866.2960444746905, 5871.64770113786, 5895.263092113486, 1003.3678782367062, 1007.8488226766044, 1011.2870426349406, 1012.964546240878, 1015.0661391519819, 22400.215992440513, 22469.0, 22469.101235950708, 22494.0, 22636.773632263797, 1098.8681358237063, 1100.6532942123206, 1108.6729414822485, 1117.2179474367974, 1127.4362818590705, 11784.175107742376, 11948.880511194951, 12006.579769708018, 12063.276203427822, 12118.757624847454, 213342.0, 213839.0, 214964.0, 214996.0, 215085.0, 51748.74125629348, 52036.0, 52081.21878171831, 52131.73934130381, 52232.0, 1420.9342992755433, 1472.4331132513846, 1474.2112969561233, 1477.8004969329218, 1480.0453707358693, 21893.671594926407, 21923.451913702283, 22088.77911220867, 22630.886845566325, 22640.66039009449, 32753.34493310073, 37128.81435592805, 37143.25713485661, 37147.25705485929, 37207.0, 185067.0, 185931.0, 186776.0, 187113.0, 187273.0, 30370.240743981576, 30835.69164308418, 31132.377352453277, 33643.327133457686, 33789.15527111842, 43587.78206108949, 43673.56326436822, 43711.78144109259, 44041.339379908684, 44166.55833441753, 31283.530747038356, 31890.84054579805, 31915.521267181477, 32172.678273217905, 32785.34429311448, 31299.37401252008, 31936.840315798272, 31951.201219969687, 32069.358612827145, 32829.34341313112, 35015.299694006484, 35083.29833403369, 35368.82315588508, 35873.64126358703, 35992.64007359893, 30853.8457307712, 30927.84536077305, 31042.689573104883, 31206.21984450407, 31363.215919602193, 22849.428764281027, 22867.542649147257, 23290.417739556648, 23380.76619233854, 23604.29187124389], "value": 16835.938227879444, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [549.601538884309, 564.7712676366073, 577.8035467940899, 578.878435528539, 596.3827438601048, 22129.336119916406, 22727.0, 22745.0, 22790.31629051129, 22813.201537946134, 19661.508462288413, 20089.799102008976, 20473.283435079775, 23502.17742379017, 23636.409089772722, 6574.671266436683, 6649.634270115142, 6696.665166741668, 6721.193456785192, 6722.092517510123, 6241.875162496747, 6589.637569933651, 6681.565698229624, 6682.632455214961, 6691.029800678899, 6427.132337134497, 6433.260175079856, 6436.645984470852, 6438.806835794933, 6442.967785161068, 6394.264659564164, 6428.260750013738, 6433.002884552855, 6433.742650294006, 6435.388638079398, 6132.50939924805, 6167.506599472032, 6184.412480814315, 6191.164192833955, 6194.4115309045565, 27697.307567310778, 28134.155975320773, 28162.0, 28181.29546761327, 28191.85904070487, 2061.093119027623, 2065.9586808263903, 2066.555690526529, 2081.5940891526157, 2095.298075144828, 18461.076946152774, 18918.3378581749, 19157.616847663106, 19206.231750729956, 19277.90361048186, 2334.6381310896836, 2341.1220792202926, 2394.832361734679, 2399.2682231919257, 2402.651615515758, 118748.40625796902, 124550.0, 131138.0, 137504.31247843796, 145489.27255363762, 13876.514321998682, 13975.860241397659, 14305.499307524395, 14459.13245205291, 14639.0, 22216.777832221473, 22239.666405003936, 22255.77744222537, 22259.77740222577, 22284.220052298093, 9853.852192217122, 9980.80038399228, 10002.0, 10066.949665251626, 10209.132223761064, 9393.765155871159, 9414.211299853006, 9426.293028022927, 9538.809223815624, 9558.426494410358, 8564.443311184754, 8755.824883502295, 8794.824103517894, 8906.906876883928, 8981.955090224506, 2521.0923069242967, 2547.936301592475, 2572.524083044643, 2598.8050896182863, 2632.236651371119, 957.8563215517728, 958.3100167879115, 968.2205824311357, 986.2750878104588, 990.3513198854762, 18214.36249731253, 18244.270229190948, 18425.26298948027, 18599.25602975893, 18776.436706898814, 994.845798901157, 1005.4570531912685, 1012.6101450941293, 1017.4454922067491, 1023.4677967457029, 10245.7438564035, 10277.588896444058, 10516.421596812095, 10534.104601108991, 10632.30889992148, 446071.0, 447012.059758803, 468807.0, 468967.0, 470749.0, 104126.0, 104316.0, 107854.46072769743, 108111.0, 109580.0, 1029.2229366827996, 1144.4849817582121, 1164.7554013657057, 1226.6626677663535, 1235.4193529041336, 19582.216711331956, 19649.0, 19686.310979115664, 19917.203311867364, 20529.692054619492, 57711.0, 58322.0, 58404.707976459846, 59568.702156488944, 60407.395926040175, 73302.63348683223, 73586.63206683932, 73981.63009184919, 74174.25825741673, 74773.626131869, 18767.624647507248, 19256.0, 19358.225670973003, 19382.70925936084, 19385.0, 21606.675899861828, 21773.0, 22017.449563761034, 22070.779292207513, 22144.889275554164, 17596.648067038845, 17657.735133973256, 17877.106144692974, 17903.37338193157, 17909.731354029962, 15982.360705572111, 15986.680266394374, 16033.599160020625, 16178.757318639995, 16492.587685307964, 17308.307667693152, 18130.909345453187, 18284.908575457037, 18394.080295985415, 18406.81593184051, 18803.717944230575, 18936.52658683544, 18945.810541894403, 18975.810241897405, 18978.810211897704, 16290.0, 16314.918425407797, 16409.91795041017, 16586.25361858695, 16989.66020679604], "value": 11866.09151984574, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1303.8565757766646, 1334.9132306400081, 1342.5502456677013, 1344.502534062397, 1356.9253691047002, 14490.855091449082, 16032.278547465363, 16076.035437873721, 16091.275892584861, 16093.114878681668, 15584.220788960534, 15736.842631573709, 15741.527754167364, 15833.445829395974, 15912.76130858038, 2662.1348061879917, 2723.1422102037795, 2726.877290521931, 2729.3995321029442, 2730.4539092181544, 2649.1390298153083, 2726.61827344171, 2727.154582079552, 2727.4136060746937, 2727.5090483712925, 2607.4524349886547, 2656.8405895646324, 2661.920142395731, 2663.014684566713, 2663.4007348346563, 2584.5993870949937, 2598.6102084687354, 2616.921492355232, 2617.280247931834, 2618.567936290529, 2561.5517284475327, 2627.789776817869, 2660.0822716162893, 2683.436478339551, 2683.785297176241, 14806.481773137995, 14958.70082598342, 14975.1014939104, 14975.550733478012, 14986.925065374713, 7696.7306144284685, 7996.400269979775, 8004.0, 8009.239122283374, 8011.439199256054, 4956.479569645171, 5110.054639891632, 5183.481651834824, 5195.714235717034, 5198.194279886624, 1707.8548323392527, 1853.8053504382115, 1857.5077604434834, 1858.87917285376, 1947.7565304336958, 25545.616815747777, 25748.098816541333, 25782.09762658298, 25788.355291117496, 25864.0, 6387.648679322682, 6390.584612000205, 6557.377049180415, 6590.340965903467, 6636.369544893228, 16318.428854990017, 16372.426965056165, 16385.180740962904, 16424.917875410545, 16485.34058637665, 7661.540307581563, 7775.844483110306, 7786.922130778733, 7790.805229869298, 7791.0, 6968.477364197705, 7208.603526805971, 7258.346748792528, 7320.414366850639, 7337.26627337262, 4986.700797952134, 5168.483151684802, 5173.818916337986, 5174.172132458789, 5223.764930578133, 1483.7996870422571, 1484.2727063738691, 1501.8798496120285, 1508.2760275068028, 1514.6216942582198, 830.3813658824093, 836.4563034027931, 851.3104385447807, 854.5385491834339, 865.0700496965787, 7465.514741541782, 7485.401167906554, 7523.3981281497345, 8074.152214017561, 8271.090180080186, 626.996865015672, 644.3556443556444, 653.7483069018463, 654.254150268694, 656.1797752808989, 4968.378952630921, 5087.669301495465, 5134.460881607378, 5303.098473259555, 5318.494742999409, 19119.617607647768, 19818.801811981983, 20391.796082039287, 20473.48816279605, 20474.590508189754, 20897.791022089583, 21098.472538186666, 21349.46626334323, 21606.135754569954, 21664.24175153862, 11030.28303160292, 11195.2723073, 11215.775684486265, 11310.151738619636, 11335.319880807177, 8256.0, 8336.499810011175, 8337.874931876147, 8434.451760635538, 8510.744677659432, 17679.73480397821, 18244.635107298047, 18414.17136228846, 18449.07754612237, 18632.97518636488, 18575.071246437896, 18608.44174674762, 18887.716684249473, 19064.809351906304, 19112.426627201206, 10245.385276883411, 10364.585416583554, 10373.0, 10374.118199953089, 10389.37663740178, 12114.818277726017, 12718.745625087262, 12788.552400665933, 12798.16811907223, 12804.487820487077, 10734.946325268324, 10831.783364332827, 10866.18503612248, 10931.125509959025, 11067.889321107008, 10561.313514621832, 10675.66286224743, 10703.678889633324, 10865.565377385132, 11019.44902754843, 9781.608735650494, 9787.902120978984, 9912.801743965225, 9990.250731195334, 9990.600375984879, 6389.424951754364, 6392.87214255703, 6435.163428754232, 6456.289808121197, 6574.408303252731, 7363.963180184065, 7496.475246732894, 7529.247075292427, 7550.320471157622, 7558.773236802905], "value": 6442.2643087718325, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [499.7361950364846, 499.93640730631125, 519.9766010529526, 521.2233771680197, 529.6610169491526, 6226.3151053384145, 6418.015622735427, 6439.130717353156, 6441.710123044462, 6452.903206451907, 6249.187605611264, 6314.810555683325, 6342.334054924236, 6348.206474190726, 6376.649284289362, 5225.973870130644, 5253.684778913258, 5255.213227502648, 5267.631265811395, 5310.920336194941, 4811.254255590389, 4999.4000719913665, 5164.399036298741, 5246.475352464761, 5247.553957913582, 4905.730184839832, 4946.084974279752, 4957.380327459067, 4986.650934434591, 4998.750062496861, 4937.308776771255, 4948.406191257072, 4970.440223285011, 5002.199648056312, 5013.398392192924, 4303.376010478494, 4397.384366188736, 4429.512753597101, 4447.644188464948, 4477.171723231213, 6003.879922401527, 6030.96984515079, 6046.183765191687, 6053.1828203192445, 6112.419320164578, 5600.215969764236, 5623.775048998035, 5648.943510564883, 5668.914966275509, 5681.176229446748, 6501.869962600769, 6517.902231466532, 6529.151210342625, 6538.771143009972, 6542.3784740450055, 4579.175748365293, 4825.565699087064, 4851.902961940741, 4854.931914978699, 4865.8783530411665, 6665.733370665168, 6749.7300107995625, 6796.592204467748, 6803.149606299213, 6856.725730970706, 4888.877778055577, 4900.970796132852, 4930.950690493121, 4966.925496117489, 4973.751312434364, 4989.3264409305, 4991.251312303184, 5030.572401345927, 5034.270030845507, 5039.672421292605, 5679.602427830012, 5681.204631351614, 5684.261046063985, 5711.600187986801, 5720.656760594377, 6585.769498067641, 6598.802035938929, 6604.735810567524, 6627.10534077903, 6630.635315057718, 1683.6127690630979, 1693.5596744846428, 1694.8474637282457, 1733.4452975048116, 1737.695903216932, 1130.4347826086957, 1199.9400029998465, 1204.2894692131683, 1206.9318652992165, 1213.6237766292302, 5617.662940223599, 5649.4633009864, 5650.660960342392, 5686.014842207874, 5708.857278568069, 6507.674616269168, 6568.8357791055605, 6605.24039735427, 6649.933500664932, 6668.0, 5625.54995600351, 5657.858553536113, 5683.829485115453, 5715.6284841486, 5720.342160651495, 3464.8960531184107, 3474.704650104719, 3481.3559491494157, 3498.772579782306, 3551.662592053751, 6286.234057014899, 6359.713812878432, 6413.935860641427, 6427.678616069178, 6536.444402225769, 6782.693884079436, 6798.456123510107, 6825.249222585511, 6852.177738671391, 6911.654417279216, 6395.424411802867, 6412.294647588761, 6424.807255782334, 6464.967675161688, 6499.642519661369, 5990.341062483036, 6457.773977910751, 6595.604263744191, 6624.503162262946, 6662.600243985376, 6481.935180648133, 6482.773102941374, 6557.737690492327, 6564.8358791030605, 6599.208095028435, 6340.4927605792345, 6342.429181373698, 6363.87272254543, 6389.0, 6442.0, 4774.832880849153, 4793.23308270689, 4815.422149342101, 4871.269309603446, 4876.268559716071, 6453.899293215662, 6526.575772574957, 6531.314212007671, 6810.897836532555, 6845.212800528003, 6329.810105696836, 6406.967965160145, 6534.0, 6538.574992625464, 6595.703193356407, 6517.185351831021, 6529.706163222571, 6544.9672751635935, 6617.7683781067435, 6618.602883826986, 6398.392152745481, 6468.450181734417, 6500.317466666121, 6543.3968677674275, 6546.574472659262, 6515.869682606416, 6623.602583844985, 6674.733010679518, 6675.499337549801, 6686.0, 6350.90473642905, 6405.135306733531, 6425.967870160806, 6430.582012169194, 6440.194975628046], "value": 5027.140694160543, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [856.131027007587, 856.6530555125173, 866.1079088538803, 913.1872633356314, 950.6245033211882, 16859.32562697492, 17094.82905170948, 17148.742768858447, 17277.999999999967, 17285.30858765651, 14457.92771036146, 15542.5337239883, 15548.144852033134, 15826.28781704823, 15898.84101158988, 938.8263171313312, 965.9227261819073, 969.4813274897931, 969.7187815533487, 969.8933117357085, 951.857221416786, 966.1739212972913, 973.6251543155901, 986.2061040862103, 991.1575161113033, 1015.035716069733, 1015.2994433840627, 1019.2763138171907, 1023.6468418395679, 1026.0150255754484, 982.6511588386127, 1005.7435353984723, 1013.0578561937396, 1014.5941623350645, 1019.1490105761661, 740.3928778401713, 740.6666999850089, 741.5550669598252, 741.929516695913, 742.0501757750088, 17831.197596108206, 17842.10789460522, 17864.0, 17911.283548658037, 17920.91039544794, 21151.576968460544, 21951.67072493914, 22000.669989950162, 22004.88997555018, 22099.226527071634, 17401.65196696059, 17803.73294400585, 18065.909670451696, 18084.638307233912, 18089.0, 3773.471713960048, 3786.659200671953, 3792.4500947362476, 3800.8289626966575, 3801.391777315644, 133443.33278333643, 133978.0, 134498.32750836283, 134840.32579837137, 137343.0, 16508.42220522276, 16632.750508742378, 16643.667126657398, 16742.66514669724, 16764.497065088068, 28875.0, 30891.691083089332, 31342.686573134433, 31352.686473135433, 31513.0, 7561.432892532972, 7591.0, 7610.048743907012, 7612.200718924544, 7614.581198034161, 4080.367543030835, 4117.0, 4199.307114326163, 4223.556526564728, 4227.556106608762, 5296.549793267615, 5417.945820541744, 5418.376886658006, 5424.701641409761, 5444.183372494158, 944.8677185194078, 978.1343510992823, 982.3369225772575, 982.4596471940404, 989.5992123190119, 606.1423086332878, 611.9571629985858, 617.9196704428396, 623.1213988276598, 642.0, 11351.60269390584, 11634.883651163549, 12086.093542984136, 12109.273443593236, 12190.39048047594, 560.6019725994508, 563.1721369586701, 568.116578720086, 576.0840263980291, 578.8668606220593, 5605.915911261334, 5613.607047506717, 5654.180143879114, 5685.090385538294, 5781.566382521243, 123431.0, 124497.0, 124519.0, 125132.74867251393, 125946.0, 105594.47202763936, 107403.0, 108456.66701655035, 111300.0, 112185.43907280575, 91649.54175229081, 93472.53263733638, 93973.5301323489, 95276.52361738146, 96471.51764241274, 10366.688999330032, 10595.523201456108, 10677.89322106769, 10718.14254859625, 10826.56693732242, 43269.350959735, 43572.78213608912, 44289.77855110833, 44501.33248001218, 44725.0, 56574.71712641411, 57302.426975731374, 58452.4154758447, 58576.0, 59673.0, 15417.306221219847, 15715.214239288218, 15724.0, 15890.284937177623, 15954.282057307217, 17099.487015389557, 17441.73837392415, 17482.562935926704, 17483.650326993644, 17685.204165812313, 14535.85464145345, 14554.563363099123, 14713.411463541339, 14750.778738319148, 14838.777418338517, 14020.509282175075, 14096.577102686935, 14100.36548355347, 14207.289635517976, 14311.499097531536, 14132.222727750073, 14272.429102835771, 14312.57062288133, 14379.496717614833, 14392.06451580644, 11315.773684526099, 11422.771544568895, 11495.367754773568, 11525.884741152817, 11700.94691477771, 10737.03366697001, 10796.89203107959, 10835.404052777172, 10977.615783447542, 11066.778664426827], "value": 8599.400366743354, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1436.8999999999999, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [108.0, 107.0, 108.0, 109.0, 111.0, 111.0, 109.0, 107.0, 109.0, 108.0], "value": 108.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [131.0, 117.0, 118.0, 149.0, 116.0, 116.0, 117.0, 119.0, 118.0, 115.0], "value": 121.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 162.0, 162.0, 162.0, 163.0, 162.0, 166.0, 163.0, 169.0, 171.0], "value": 164.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 80.0, 74.0, 73.0, 73.0, 75.0, 76.0, 147.0, 74.0, 76.0], "value": 82.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 79.0, 81.0, 79.0, 80.0, 80.0, 79.0, 79.0, 79.0, 80.0], "value": 79.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 114.0, 114.0, 115.0, 114.0, 117.0, 117.0, 114.0, 113.0, 117.0], "value": 114.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 150.0, 148.0, 148.0, 150.0, 150.0, 150.0, 149.0, 149.0, 151.0], "value": 149.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 94.0, 94.0, 93.0, 94.0, 94.0, 94.0, 94.0, 94.0], "value": 94.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 53.0, 53.0, 54.0, 56.0, 53.0, 55.0, 55.0, 54.0, 55.0], "value": 54.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [38.0, 39.0, 38.0, 38.0, 39.0, 43.0, 39.0, 39.0, 38.0, 38.0], "value": 38.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 79.0, 75.0, 76.0, 73.0, 76.0, 73.0, 73.0, 76.0, 79.0], "value": 75.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 116.0, 121.0, 112.0, 120.0, 111.0, 119.0, 118.0, 114.0, 111.0], "value": 115.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [174.0, 175.0, 174.0, 167.0, 168.0, 175.0, 168.0, 168.0, 167.0, 175.0], "value": 171.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 63.0, 69.0, 67.0, 69.0, 66.0, 64.0, 64.0, 78.0, 65.0], "value": 67.0, "unit": "score"}]}]} 15:55:53 INFO - Return code: 0 15:55:53 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 15:55:53 INFO - # TBPL SUCCESS # 15:55:53 INFO - Running post-action listener: _package_coverage_data 15:55:53 INFO - Running post-action listener: _resource_record_post_action 15:55:53 INFO - [mozharness: 2017-09-11 22:55:53.261187Z] Finished run-tests step (success) 15:55:53 INFO - Running post-run listener: _resource_record_post_run 15:55:53 INFO - Total resource usage - Wall time: 1189s; CPU: 13.0%; Read bytes: 4096; Write bytes: 298319872; Read time: 16; Write time: 167500 15:55:53 INFO - TinderboxPrint: CPU usage
13.1% 15:55:53 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 16 15:55:53 INFO - TinderboxPrint: I/O write bytes / time
298,319,872 / 167,500 15:55:53 INFO - TinderboxPrint: CPU idle
8,236.9 (86.9%) 15:55:53 INFO - TinderboxPrint: CPU user
1,191.9 (12.6%) 15:55:53 INFO - TinderboxPrint: Swap in / out
0 / 0 15:55:53 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 13045760; Read time: 0; Write time: 2512 15:55:53 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 15:55:53 INFO - run-tests - Wall time: 1173s; CPU: 13.0%; Read bytes: 4096; Write bytes: 284872704; Read time: 16; Write time: 164956 15:55:53 INFO - Running post-run listener: _upload_blobber_files 15:55:53 INFO - Blob upload gear active. 15:55:53 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 15:55:53 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 15:55:53 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'] 15:55:53 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 15:55:54 INFO - (blobuploader) - INFO - Open directory for files ... 15:55:54 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 15:55:54 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:55:54 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:55:55 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 15:55:55 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:55:55 INFO - (blobuploader) - INFO - Done attempting. 15:55:55 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 15:55:55 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:55:55 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:55:56 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 15:55:56 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:55:56 INFO - (blobuploader) - INFO - Done attempting. 15:55:56 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 15:55:56 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:55:56 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:56:03 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 15:56:03 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:56:03 INFO - (blobuploader) - INFO - Done attempting. 15:56:03 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 15:56:03 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:56:03 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:56:04 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 15:56:04 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:56:04 INFO - (blobuploader) - INFO - Done attempting. 15:56:04 INFO - (blobuploader) - INFO - Iteration through files over. 15:56:04 INFO - Return code: 0 15:56:04 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 15:56:04 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 15:56:04 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/88271e297e042378c2fc8c72144565544fd8ebd5cac1e86acd9de75baa8628b8c8e03945f2a3ebef7b9e16a7b7e908e8b7d622b6073904af01c921c18ecec900", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/5d73c3fc2a162e6173507674f37da34b838f3e43145c4b1fec0bc2c2f8d1581ba824236a0e43c39ba7dd5d07735b0fd6e43171f92a5babc6720bcc7aeb1aacfd", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/055dd390d56e03ca772be9abb4f7f97e93f6f64cf0eeb793ffa3865924ddf26bfdfcf6d7789023f2ec29b2de69980d8c169d879479b265bba026aafbc668ad3d", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/b1493359e414187242886a01423c15b3c53c652c1c1864987f0926ebd53613c5287ad76dc50a5fbc2908147c0884c5100fa61f23e1da26cf5307f67b4e20dbac"} 15:56:04 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 15:56:04 INFO - Writing to file /builds/slave/test/properties/blobber_files 15:56:04 INFO - Contents: 15:56:04 INFO - blobber_files:{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/88271e297e042378c2fc8c72144565544fd8ebd5cac1e86acd9de75baa8628b8c8e03945f2a3ebef7b9e16a7b7e908e8b7d622b6073904af01c921c18ecec900", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/5d73c3fc2a162e6173507674f37da34b838f3e43145c4b1fec0bc2c2f8d1581ba824236a0e43c39ba7dd5d07735b0fd6e43171f92a5babc6720bcc7aeb1aacfd", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/055dd390d56e03ca772be9abb4f7f97e93f6f64cf0eeb793ffa3865924ddf26bfdfcf6d7789023f2ec29b2de69980d8c169d879479b265bba026aafbc668ad3d", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/b1493359e414187242886a01423c15b3c53c652c1c1864987f0926ebd53613c5287ad76dc50a5fbc2908147c0884c5100fa61f23e1da26cf5307f67b4e20dbac"} 15:56:04 INFO - Running post-run listener: copy_logs_to_upload_dir 15:56:04 INFO - Copying logs to upload dir... 15:56:04 INFO - mkdir: /builds/slave/test/build/upload/logs 15:56:04 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1240.761830 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 40 secs) (at 2017-09-11 15:56:04.825030) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-11 15:56:04.829369) ========= 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=97facb8ba2ac28944cc45e6b000001d4-1505167450.332409-1360272433 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/88271e297e042378c2fc8c72144565544fd8ebd5cac1e86acd9de75baa8628b8c8e03945f2a3ebef7b9e16a7b7e908e8b7d622b6073904af01c921c18ecec900", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/5d73c3fc2a162e6173507674f37da34b838f3e43145c4b1fec0bc2c2f8d1581ba824236a0e43c39ba7dd5d07735b0fd6e43171f92a5babc6720bcc7aeb1aacfd", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/055dd390d56e03ca772be9abb4f7f97e93f6f64cf0eeb793ffa3865924ddf26bfdfcf6d7789023f2ec29b2de69980d8c169d879479b265bba026aafbc668ad3d", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/b1493359e414187242886a01423c15b3c53c652c1c1864987f0926ebd53613c5287ad76dc50a5fbc2908147c0884c5100fa61f23e1da26cf5307f67b4e20dbac"} build_url:https://queue.taskcluster.net/v1/task/PxukmEXgQ0mTuA19AmBRIg/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011311 build_url: 'https://queue.taskcluster.net/v1/task/PxukmEXgQ0mTuA19AmBRIg/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/88271e297e042378c2fc8c72144565544fd8ebd5cac1e86acd9de75baa8628b8c8e03945f2a3ebef7b9e16a7b7e908e8b7d622b6073904af01c921c18ecec900", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/5d73c3fc2a162e6173507674f37da34b838f3e43145c4b1fec0bc2c2f8d1581ba824236a0e43c39ba7dd5d07735b0fd6e43171f92a5babc6720bcc7aeb1aacfd", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/055dd390d56e03ca772be9abb4f7f97e93f6f64cf0eeb793ffa3865924ddf26bfdfcf6d7789023f2ec29b2de69980d8c169d879479b265bba026aafbc668ad3d", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/b1493359e414187242886a01423c15b3c53c652c1c1864987f0926ebd53613c5287ad76dc50a5fbc2908147c0884c5100fa61f23e1da26cf5307f67b4e20dbac"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-11 15:56:04.864242) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-11 15:56:04.864887) ========= 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=97facb8ba2ac28944cc45e6b000001d4-1505167450.332409-1360272433 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004413 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-11 15:56:04.946848) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-11 15:56:04.947206) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-11 15:56:04.947569) ========= ========= Total master_lag: 0.20 =========