builder: mozilla-central_ubuntu64_hw_test-dromaeojs-stylo-disabled-e10s-pgo slave: talos-linux64-ix-067 starttime: 1506143261.6 results: success (0) revision: 9d1fcbc2fdd58011903aa1b987264d58dc1a06b5 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-09-22 22:07:41.600772) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-09-22 22:07:41.601142) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-22 22:07:41.601463) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-22 22:07:41.634922) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-22 22:07:41.635174) ========= 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=e0e61f6f900f4dc42e3e8956000001ad-1506142770.322045-1208929790 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-09-22 22:07:41-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 46.7M=0s 2017-09-22 22:07:41 (46.7 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.124189 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-22 22:07:41.784566) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-22 22:07:41.787884) ========= 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=e0e61f6f900f4dc42e3e8956000001ad-1506142770.322045-1208929790 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.022850 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-22 22:07:41.837311) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-22 22:07:41.837621) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 9d1fcbc2fdd58011903aa1b987264d58dc1a06b5 --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 9d1fcbc2fdd58011903aa1b987264d58dc1a06b5 --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=e0e61f6f900f4dc42e3e8956000001ad-1506142770.322045-1208929790 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-09-22 22:07:41,912 truncating revision to first 12 chars 2017-09-22 22:07:41,912 Setting DEBUG logging. 2017-09-22 22:07:41,912 attempt 1/10 2017-09-22 22:07:41,912 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/9d1fcbc2fdd5?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-09-22 22:07:42,178 unpacking tar archive at: mozilla-central-9d1fcbc2fdd5/testing/mozharness/ program finished with exit code 0 elapsedTime=0.554488 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-22 22:07:42.410555) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-22 22:07:42.413853) ========= script_repo_revision: 9d1fcbc2fdd58011903aa1b987264d58dc1a06b5 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-22 22:07:42.414191) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-22 22:07:42.414443) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-22 22:07:42.427539) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 33 secs) (at 2017-09-22 22:07:42.427843) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-stylo-disabled-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-stylo-disabled-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] 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=e0e61f6f900f4dc42e3e8956000001ad-1506142770.322045-1208929790 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 22:07:42 INFO - MultiFileLogger online at 20170922 22:07:42 in /builds/slave/test 22:07:42 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-stylo-disabled-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 22:07:42 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 22:07:42 INFO - {'append_to_log': False, 22:07:42 INFO - 'base_work_dir': '/builds/slave/test', 22:07:42 INFO - 'blob_upload_branch': 'Firefox', 22:07:42 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 22:07:42 INFO - 'branch': 'Firefox', 22:07:42 INFO - 'buildbot_json_path': 'buildprops.json', 22:07:42 INFO - 'code_coverage': False, 22:07:42 INFO - 'config_files': ('talos/linux_config.py',), 22:07:42 INFO - 'default_actions': ('clobber', 22:07:42 INFO - 'read-buildbot-config', 22:07:42 INFO - 'download-and-extract', 22:07:42 INFO - 'populate-webroot', 22:07:42 INFO - 'create-virtualenv', 22:07:42 INFO - 'install', 22:07:42 INFO - 'setup-mitmproxy', 22:07:42 INFO - 'run-tests'), 22:07:42 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 22:07:42 INFO - 'disable_ccov_upload': False, 22:07:42 INFO - 'disable_stylo': False, 22:07:42 INFO - 'download_minidump_stackwalk': True, 22:07:42 INFO - 'download_symbols': 'ondemand', 22:07:42 INFO - 'enable_stylo': False, 22:07:42 INFO - 'enable_webrender': False, 22:07:42 INFO - 'exes': {'tooltool.py': '/tools/tooltool.py'}, 22:07:42 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 22:07:42 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 22:07:42 INFO - 'gecko_profile': False, 22:07:42 INFO - 'gecko_profile_interval': 0, 22:07:42 INFO - 'installer_path': 'installer.exe', 22:07:42 INFO - 'log_level': 'info', 22:07:42 INFO - 'log_name': 'talos', 22:07:42 INFO - 'log_to_console': True, 22:07:42 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 22:07:42 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 22:07:42 INFO - 'opt_config_files': (), 22:07:42 INFO - 'pip_index': False, 22:07:42 INFO - 'suite': 'dromaeojs-stylo-disabled-e10s', 22:07:42 INFO - 'system_bits': '32', 22:07:42 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 22:07:42 INFO - 'title': 'talos-linux64-ix-067', 22:07:42 INFO - 'tooltool_cache': '/builds/tooltool_cache', 22:07:42 INFO - 'use_talos_json': True, 22:07:42 INFO - 'verify': 'False', 22:07:42 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 22:07:42 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 22:07:42 INFO - 'work_dir': 'build'} 22:07:42 INFO - [mozharness: 2017-09-23 05:07:42.650476Z] Running clobber step. 22:07:42 INFO - Running pre-action listener: _resource_record_pre_action 22:07:42 INFO - Running main action method: clobber 22:07:42 INFO - rmtree: /builds/slave/test/build 22:07:42 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 22:07:43 INFO - Running post-action listener: _resource_record_post_action 22:07:43 INFO - [mozharness: 2017-09-23 05:07:43.641533Z] Finished clobber step (success) 22:07:43 INFO - [mozharness: 2017-09-23 05:07:43.641631Z] Running read-buildbot-config step. 22:07:43 INFO - Running pre-action listener: _resource_record_pre_action 22:07:43 INFO - Running main action method: read_buildbot_config 22:07:43 INFO - Using buildbot properties: 22:07:43 INFO - { 22:07:43 INFO - "project": "", 22:07:43 INFO - "product": "firefox", 22:07:43 INFO - "who": "ffxbld@noreply.mozilla.org", 22:07:43 INFO - "installer_path": "public/build/target.tar.bz2", 22:07:43 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-stylo-disabled-e10s", 22:07:43 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 22:07:43 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs-stylo-disabled-e10s", 22:07:43 INFO - "stage_platform": "linux64-pgo", 22:07:43 INFO - "basedir": "/builds/slave/test", 22:07:43 INFO - "buildnumber": 50, 22:07:43 INFO - "platform": "ubuntu64_hw", 22:07:43 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 22:07:43 INFO - "slavebuilddir": "test", 22:07:43 INFO - "taskId": "PP6kDlJKRGWkwZKFTADpSg", 22:07:43 INFO - "branch": "mozilla-central", 22:07:43 INFO - "script_repo_revision": "production", 22:07:43 INFO - "revision": "9d1fcbc2fdd58011903aa1b987264d58dc1a06b5", 22:07:43 INFO - "slavename": "talos-linux64-ix-067", 22:07:43 INFO - "repo_path": "mozilla-central" 22:07:43 INFO - } 22:07:43 INFO - Finding installer, test and symbols from parent task. 22:07:43 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/PP6kDlJKRGWkwZKFTADpSg'}, attempt #1 22:07:44 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/PP6kDlJKRGWkwZKFTADpSg'}, attempt #1 22:07:44 INFO - Task dependencies: JtWjNlDyQMG39ykVhnRwEg 22:07:44 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/JtWjNlDyQMG39ykVhnRwEg'}, attempt #1 22:07:44 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/JtWjNlDyQMG39ykVhnRwEg/artifacts/public/build/target.tar.bz2 22:07:44 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/JtWjNlDyQMG39ykVhnRwEg/artifacts/public/build/target.test_packages.json 22:07:44 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/JtWjNlDyQMG39ykVhnRwEg/artifacts/public/build/target.crashreporter-symbols.zip 22:07:44 INFO - Running post-action listener: _resource_record_post_action 22:07:44 INFO - [mozharness: 2017-09-23 05:07:44.936391Z] Finished read-buildbot-config step (success) 22:07:44 INFO - [mozharness: 2017-09-23 05:07:44.936608Z] Running download-and-extract step. 22:07:44 INFO - Running pre-action listener: _resource_record_pre_action 22:07:44 INFO - Running main action method: download_and_extract 22:07:44 INFO - mkdir: /builds/slave/test/build/tests 22:07: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')]} 22:07:44 INFO - trying https://queue.taskcluster.net/v1/task/JtWjNlDyQMG39ykVhnRwEg/artifacts/public/build/target.test_packages.json 22:07:44 INFO - Downloading https://queue.taskcluster.net/v1/task/JtWjNlDyQMG39ykVhnRwEg/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 22:07:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/JtWjNlDyQMG39ykVhnRwEg/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 22:07:45 INFO - Downloaded 989 bytes. 22:07:45 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 22:07:45 INFO - Using the following test package requirements: 22:07:45 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 22:07:45 INFO - u'common': [u'target.common.tests.zip'], 22:07:45 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 22:07:45 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 22:07:45 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 22:07:45 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 22:07:45 INFO - u'mozbase': [u'target.common.tests.zip'], 22:07:45 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 22:07:45 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 22:07:45 INFO - u'web-platform': [u'target.common.tests.zip', 22:07:45 INFO - u'target.web-platform.tests.tar.gz'], 22:07:45 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 22:07:45 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite categories: ['common', 'talos'] 22:07:45 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/JtWjNlDyQMG39ykVhnRwEg/artifacts/public/build/target.common.tests.zip 22:07:45 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/JtWjNlDyQMG39ykVhnRwEg/artifacts/public/build/target.common.tests.zip'}, attempt #1 22:07:45 INFO - Fetch https://queue.taskcluster.net/v1/task/JtWjNlDyQMG39ykVhnRwEg/artifacts/public/build/target.common.tests.zip into memory 22:07:48 INFO - Content-Length response header: 55340279 22:07:48 INFO - Bytes received: 55340279 22:07:59 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/JtWjNlDyQMG39ykVhnRwEg/artifacts/public/build/target.talos.tests.zip 22:07:59 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/JtWjNlDyQMG39ykVhnRwEg/artifacts/public/build/target.talos.tests.zip'}, attempt #1 22:07:59 INFO - Fetch https://queue.taskcluster.net/v1/task/JtWjNlDyQMG39ykVhnRwEg/artifacts/public/build/target.talos.tests.zip into memory 22:08:00 INFO - Content-Length response header: 14513823 22:08:00 INFO - Bytes received: 14513823 22:08:01 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')]} 22:08:01 INFO - trying https://queue.taskcluster.net/v1/task/JtWjNlDyQMG39ykVhnRwEg/artifacts/public/build/target.tar.bz2 22:08:01 INFO - Downloading https://queue.taskcluster.net/v1/task/JtWjNlDyQMG39ykVhnRwEg/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 22:08:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/JtWjNlDyQMG39ykVhnRwEg/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 22:08:03 INFO - Downloaded 62444747 bytes. 22:08:03 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/JtWjNlDyQMG39ykVhnRwEg/artifacts/public/build/target.tar.bz2 22:08:03 INFO - mkdir: /builds/slave/test/properties 22:08:03 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 22:08:03 INFO - Writing to file /builds/slave/test/properties/build_url 22:08:03 INFO - Contents: 22:08:03 INFO - build_url:https://queue.taskcluster.net/v1/task/JtWjNlDyQMG39ykVhnRwEg/artifacts/public/build/target.tar.bz2 22:08:03 INFO - Running post-action listener: _resource_record_post_action 22:08:03 INFO - Running post-action listener: find_tests_for_verification 22:08:03 INFO - Running post-action listener: set_extra_try_arguments 22:08:03 INFO - [mozharness: 2017-09-23 05:08:03.854997Z] Finished download-and-extract step (success) 22:08:03 INFO - [mozharness: 2017-09-23 05:08:03.855094Z] Running populate-webroot step. 22:08:03 INFO - Running pre-action listener: _resource_record_pre_action 22:08:03 INFO - Running main action method: populate_webroot 22:08:03 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 22:08:03 INFO - 'chromez-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 22:08:03 INFO - 'tests': ['tresize', 22:08:03 INFO - 'tcanvasmark']}, 22:08:03 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 22:08:03 INFO - 'dromaeojs-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 22:08:03 INFO - 'tests': ['dromaeo_css', 22:08:03 INFO - 'kraken']}, 22:08:03 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 22:08:03 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 22:08:03 INFO - 'g1-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 22:08:03 INFO - 'talos_options': ['--disable-stylo'], 22:08:03 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 22:08:03 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 22:08:03 INFO - 'tests': ['damp', 'tps']}, 22:08:03 INFO - 'g2-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 22:08:03 INFO - 'talos_options': ['--disable-stylo'], 22:08:03 INFO - 'tests': ['damp', 'tps']}, 22:08:03 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 22:08:03 INFO - 'g3-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 22:08:03 INFO - 'tests': ['dromaeo_dom']}, 22:08:03 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 22:08:03 INFO - 'g4-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 22:08:03 INFO - 'tests': ['basic_compositor_video', 22:08:03 INFO - 'glvideo']}, 22:08:03 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 22:08:03 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 22:08:03 INFO - 'g5-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 22:08:03 INFO - 'talos_options': ['--disable-stylo'], 22:08:03 INFO - 'tests': ['ts_paint_webext', 22:08:03 INFO - 'tp5o_webext']}, 22:08:03 INFO - 'other-e10s': {'tests': ['a11yr', 22:08:03 INFO - 'ts_paint', 22:08:03 INFO - 'tpaint', 22:08:03 INFO - 'sessionrestore', 22:08:03 INFO - 'sessionrestore_many_windows', 22:08:03 INFO - 'sessionrestore_no_auto_restore', 22:08:03 INFO - 'tabpaint']}, 22:08:03 INFO - 'other-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 22:08:03 INFO - 'tests': ['a11yr', 22:08:03 INFO - 'ts_paint', 22:08:03 INFO - 'tpaint', 22:08:03 INFO - 'sessionrestore', 22:08:03 INFO - 'sessionrestore_many_windows', 22:08:03 INFO - 'sessionrestore_no_auto_restore', 22:08:03 INFO - 'tabpaint']}, 22:08:03 INFO - 'perf-reftest-e10s': {'tests': ['perf_reftest']}, 22:08:03 INFO - 'perf-reftest-singletons-e10s': {'tests': ['perf_reftest_singletons']}, 22:08:03 INFO - 'perf-reftest-singletons-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 22:08:03 INFO - 'tests': ['perf_reftest_singletons']}, 22:08:03 INFO - 'perf-reftest-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 22:08:03 INFO - 'tests': ['perf_reftest']}, 22:08:03 INFO - 'svgr-e10s': {'tests': ['tsvgx', 22:08:03 INFO - 'tsvgr_opacity', 22:08:03 INFO - 'tart', 22:08:03 INFO - 'tscrollx', 22:08:03 INFO - 'tsvg_static']}, 22:08:03 INFO - 'svgr-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 22:08:03 INFO - 'tests': ['tsvgx', 22:08:03 INFO - 'tsvgr_opacity', 22:08:03 INFO - 'tart', 22:08:03 INFO - 'tscrollx', 22:08:03 INFO - 'tsvg_static']}, 22:08:03 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 22:08:03 INFO - 'tp5o-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 22:08:03 INFO - 'talos_options': ['--disable-stylo'], 22:08:03 INFO - 'tests': ['tp5o']}, 22:08:03 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 22:08:03 INFO - 'mitmproxy_release_bin_osx': 'mitmproxy-2.0.2-osx.tar.gz', 22:08:03 INFO - 'talos_options': ['--mitmproxy', 22:08:03 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 22:08:03 INFO - '--firstNonBlankPaint'], 22:08:03 INFO - 'tests': ['tp6_google', 22:08:03 INFO - 'tp6_youtube', 22:08:03 INFO - 'tp6_amazon', 22:08:03 INFO - 'tp6_facebook']}, 22:08:03 INFO - 'tp6-stylo-disabled-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 22:08:03 INFO - 'mitmproxy_release_bin_osx': 'mitmproxy-2.0.2-osx.tar.gz', 22:08:03 INFO - 'talos_options': ['--disable-stylo', 22:08:03 INFO - '--mitmproxy', 22:08:03 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 22:08:03 INFO - '--firstNonBlankPaint'], 22:08:03 INFO - 'tests': ['tp6_google', 22:08:03 INFO - 'tp6_youtube', 22:08:03 INFO - 'tp6_amazon', 22:08:03 INFO - 'tp6_facebook']}, 22:08:03 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 22:08:03 INFO - 'mitmproxy_release_bin_osx': 'mitmproxy-2.0.2-osx.tar.gz', 22:08:03 INFO - 'talos_options': ['--stylo-threads=1', 22:08:03 INFO - '--mitmproxy', 22:08:03 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 22:08:03 INFO - '--firstNonBlankPaint'], 22:08:03 INFO - 'tests': ['tp6_google', 22:08:03 INFO - 'tp6_youtube', 22:08:03 INFO - 'tp6_amazon', 22:08:03 INFO - 'tp6_facebook']}, 22:08:03 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 22:08:03 INFO - 'talos_options': ['--xperf_path', 22:08:03 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 22:08:03 INFO - 'tests': ['tp5n']}, 22:08:03 INFO - 'xperf-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 22:08:03 INFO - 'talos_options': ['--disable-stylo', 22:08:03 INFO - '--xperf_path', 22:08:03 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 22:08:03 INFO - 'tests': ['tp5n']}}} 22:08:03 INFO - Running post-action listener: _resource_record_post_action 22:08:03 INFO - [mozharness: 2017-09-23 05:08:03.870498Z] Finished populate-webroot step (success) 22:08:03 INFO - [mozharness: 2017-09-23 05:08:03.870586Z] Running create-virtualenv step. 22:08:03 INFO - Running pre-action listener: _resource_record_pre_action 22:08:03 INFO - Running main action method: create_virtualenv 22:08:03 INFO - Creating virtualenv /builds/slave/test/build/venv 22:08:03 INFO - Running command: ['virtualenv', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 22:08:03 INFO - Copy/paste: virtualenv --no-site-packages --distribute /builds/slave/test/build/venv 22:08:03 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 22:08:03 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 22:08:03 INFO - New python executable in /builds/slave/test/build/venv/bin/python 22:08:04 INFO - Installing distribute.............................................................................................................................................................................................done. 22:08:04 INFO - Installing pip...............done. 22:08:04 INFO - Return code: 0 22:08:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 22:08:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 22:08:04 INFO - Reading from file tmpfile_stdout 22:08:04 INFO - Output received: 22:08:04 INFO - pip 1.1 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.1-py2.7.egg (python 2.7) 22:08:04 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 22:08:04 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')]} 22:08:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:08:04 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')]} 22:08:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:08:04 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 0x1d9a1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f62b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21079c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2104d60>, '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 0x2105a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2105ef0>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1506142770.322045-1208929790', '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 22:08:04 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 22:08:04 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 22:08:04 INFO - Using env: {'DISPLAY': ':0', 22:08:04 INFO - 'HOME': '/home/cltbld', 22:08:04 INFO - 'LANG': 'en_US.UTF-8', 22:08:04 INFO - 'LANGUAGE': 'en_US:en', 22:08:04 INFO - 'LOGNAME': 'cltbld', 22:08:04 INFO - 'MAIL': '/var/mail/cltbld', 22:08:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:08:04 INFO - 'MOZ_NO_REMOTE': '1', 22:08:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:08:04 INFO - 'NO_EM_RESTART': '1', 22:08:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:08:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:08:04 INFO - 'PWD': '/builds/slave/test', 22:08:04 INFO - 'SHELL': '/bin/bash', 22:08:04 INFO - 'SHLVL': '1', 22:08:04 INFO - 'TERM': 'linux', 22:08:04 INFO - 'TMOUT': '86400', 22:08:04 INFO - 'USER': 'cltbld', 22:08:04 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1506142770.322045-1208929790', 22:08:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:08:04 INFO - '_': '/tools/buildbot/bin/python'} 22:08:06 INFO - Ignoring indexes: http://pypi.python.org/simple/ 22:08:06 INFO - Downloading/unpacking pip>=1.5 22:08:06 INFO - Running setup.py egg_info for package pip 22:08:06 INFO - warning: no files found matching 'pip/cacert.pem' 22:08:06 INFO - warning: no files found matching '*.html' under directory 'docs' 22:08:06 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 22:08:06 INFO - no previously-included directories found matching 'docs/_build/_sources' 22:08:06 INFO - Installing collected packages: pip 22:08:06 INFO - Found existing installation: pip 1.1 22:08:06 INFO - Uninstalling pip: 22:08:06 INFO - Successfully uninstalled pip 22:08:06 INFO - Running setup.py install for pip 22:08:06 INFO - warning: no files found matching 'pip/cacert.pem' 22:08:06 INFO - warning: no files found matching '*.html' under directory 'docs' 22:08:06 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 22:08:06 INFO - no previously-included directories found matching 'docs/_build/_sources' 22:08:06 INFO - Installing pip script to /builds/slave/test/build/venv/bin 22:08:06 INFO - Installing pip2.7 script to /builds/slave/test/build/venv/bin 22:08:06 INFO - Installing pip2 script to /builds/slave/test/build/venv/bin 22:08:06 INFO - Successfully installed pip 22:08:06 INFO - Cleaning up... 22:08:06 INFO - Return code: 0 22:08:06 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 22:08:06 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')]} 22:08:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:08:06 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')]} 22:08:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:08:06 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 0x1d9a1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f62b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21079c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2104d60>, '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 0x2105a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2105ef0>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1506142770.322045-1208929790', '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 22:08:06 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 22:08:06 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 22:08:06 INFO - Using env: {'DISPLAY': ':0', 22:08:06 INFO - 'HOME': '/home/cltbld', 22:08:06 INFO - 'LANG': 'en_US.UTF-8', 22:08:06 INFO - 'LANGUAGE': 'en_US:en', 22:08:06 INFO - 'LOGNAME': 'cltbld', 22:08:06 INFO - 'MAIL': '/var/mail/cltbld', 22:08:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:08:06 INFO - 'MOZ_NO_REMOTE': '1', 22:08:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:08:06 INFO - 'NO_EM_RESTART': '1', 22:08:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:08:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:08:06 INFO - 'PWD': '/builds/slave/test', 22:08:06 INFO - 'SHELL': '/bin/bash', 22:08:06 INFO - 'SHLVL': '1', 22:08:06 INFO - 'TERM': 'linux', 22:08:06 INFO - 'TMOUT': '86400', 22:08:06 INFO - 'USER': 'cltbld', 22:08:06 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1506142770.322045-1208929790', 22:08:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:08:06 INFO - '_': '/tools/buildbot/bin/python'} 22:08:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:08:06 INFO - Downloading/unpacking psutil>=3.1.1 22:08:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:08:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:08:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:08:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:08:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 22:08:07 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 22:08:07 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 22:08:07 INFO - Installing collected packages: psutil 22:08:07 INFO - Running setup.py install for psutil 22:08:07 INFO - building 'psutil._psutil_linux' extension 22:08:07 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 22:08:07 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 22:08:07 INFO - building 'psutil._psutil_posix' extension 22:08:07 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 22:08:07 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 22:08:08 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 22:08:08 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 22:08:08 INFO - Successfully installed psutil 22:08:08 INFO - Cleaning up... 22:08:08 INFO - Return code: 0 22:08:08 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 22:08:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:08:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:08:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:08:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:08:08 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d9a1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f62b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21079c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2104d60>, '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 0x2105a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2105ef0>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1506142770.322045-1208929790', '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 22:08:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 22:08:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 22:08:08 INFO - Using env: {'DISPLAY': ':0', 22:08:08 INFO - 'HOME': '/home/cltbld', 22:08:08 INFO - 'LANG': 'en_US.UTF-8', 22:08:08 INFO - 'LANGUAGE': 'en_US:en', 22:08:08 INFO - 'LOGNAME': 'cltbld', 22:08:08 INFO - 'MAIL': '/var/mail/cltbld', 22:08:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:08:08 INFO - 'MOZ_NO_REMOTE': '1', 22:08:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:08:08 INFO - 'NO_EM_RESTART': '1', 22:08:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:08:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:08:08 INFO - 'PWD': '/builds/slave/test', 22:08:08 INFO - 'SHELL': '/bin/bash', 22:08:08 INFO - 'SHLVL': '1', 22:08:08 INFO - 'TERM': 'linux', 22:08:08 INFO - 'TMOUT': '86400', 22:08:08 INFO - 'USER': 'cltbld', 22:08:08 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1506142770.322045-1208929790', 22:08:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:08:08 INFO - '_': '/tools/buildbot/bin/python'} 22:08:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:08:09 INFO - Downloading/unpacking mozsystemmonitor==0.3 22:08:09 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 22:08:09 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 22:08:09 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 22:08:09 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 22:08:10 INFO - Downloading mozsystemmonitor-0.3.tar.gz 22:08:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 22:08:10 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 22:08:10 INFO - Installing collected packages: mozsystemmonitor 22:08:10 INFO - Running setup.py install for mozsystemmonitor 22:08:10 INFO - Successfully installed mozsystemmonitor 22:08:10 INFO - Cleaning up... 22:08:10 INFO - Return code: 0 22:08:10 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 22:08:10 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')]} 22:08:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:08:10 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')]} 22:08:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:08:10 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 0x1d9a1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f62b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21079c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2104d60>, '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 0x2105a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2105ef0>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1506142770.322045-1208929790', '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 22:08:10 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 22:08:10 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 22:08:10 INFO - Using env: {'DISPLAY': ':0', 22:08:10 INFO - 'HOME': '/home/cltbld', 22:08:10 INFO - 'LANG': 'en_US.UTF-8', 22:08:10 INFO - 'LANGUAGE': 'en_US:en', 22:08:10 INFO - 'LOGNAME': 'cltbld', 22:08:10 INFO - 'MAIL': '/var/mail/cltbld', 22:08:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:08:10 INFO - 'MOZ_NO_REMOTE': '1', 22:08:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:08:10 INFO - 'NO_EM_RESTART': '1', 22:08:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:08:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:08:10 INFO - 'PWD': '/builds/slave/test', 22:08:10 INFO - 'SHELL': '/bin/bash', 22:08:10 INFO - 'SHLVL': '1', 22:08:10 INFO - 'TERM': 'linux', 22:08:10 INFO - 'TMOUT': '86400', 22:08:10 INFO - 'USER': 'cltbld', 22:08:10 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1506142770.322045-1208929790', 22:08:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:08:10 INFO - '_': '/tools/buildbot/bin/python'} 22:08:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:08:10 INFO - Downloading/unpacking jsonschema==2.5.1 22:08:10 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 22:08:10 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 22:08:10 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 22:08:10 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 22:08:11 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 22:08:11 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 22:08:11 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 22:08:11 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 22:08:11 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 22:08:11 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 22:08:12 INFO - Downloading functools32-3.2.3-2.tar.gz 22:08:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 22:08:12 INFO - warning: no files found matching '*.txt' 22:08:12 INFO - no previously-included directories found matching 'build' 22:08:12 INFO - no previously-included directories found matching 'dist' 22:08:12 INFO - no previously-included directories found matching '.git*' 22:08:12 INFO - Installing collected packages: jsonschema, functools32 22:08:12 INFO - Running setup.py install for functools32 22:08:12 INFO - warning: no files found matching '*.txt' 22:08:12 INFO - no previously-included directories found matching 'build' 22:08:12 INFO - no previously-included directories found matching 'dist' 22:08:12 INFO - no previously-included directories found matching '.git*' 22:08:12 INFO - Successfully installed jsonschema functools32 22:08:12 INFO - Cleaning up... 22:08:12 INFO - Return code: 0 22:08:12 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 22:08:12 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')]} 22:08:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:08:12 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')]} 22:08:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:08:12 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 0x1d9a1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f62b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21079c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2104d60>, '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 0x2105a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2105ef0>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1506142770.322045-1208929790', '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 22:08:12 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 22:08:12 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 22:08:12 INFO - Using env: {'DISPLAY': ':0', 22:08:12 INFO - 'HOME': '/home/cltbld', 22:08:12 INFO - 'LANG': 'en_US.UTF-8', 22:08:12 INFO - 'LANGUAGE': 'en_US:en', 22:08:12 INFO - 'LOGNAME': 'cltbld', 22:08:12 INFO - 'MAIL': '/var/mail/cltbld', 22:08:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:08:12 INFO - 'MOZ_NO_REMOTE': '1', 22:08:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:08:12 INFO - 'NO_EM_RESTART': '1', 22:08:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:08:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:08:12 INFO - 'PWD': '/builds/slave/test', 22:08:12 INFO - 'SHELL': '/bin/bash', 22:08:12 INFO - 'SHLVL': '1', 22:08:12 INFO - 'TERM': 'linux', 22:08:12 INFO - 'TMOUT': '86400', 22:08:12 INFO - 'USER': 'cltbld', 22:08:12 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1506142770.322045-1208929790', 22:08:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:08:12 INFO - '_': '/tools/buildbot/bin/python'} 22:08:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:08:12 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 22:08:12 INFO - Cleaning up... 22:08:12 INFO - Return code: 0 22:08:12 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 22:08:12 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')]} 22:08:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:08:12 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')]} 22:08:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:08:12 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 0x1d9a1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f62b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21079c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2104d60>, '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 0x2105a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2105ef0>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1506142770.322045-1208929790', '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 22:08:12 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 22:08:12 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 22:08:12 INFO - Using env: {'DISPLAY': ':0', 22:08:12 INFO - 'HOME': '/home/cltbld', 22:08:12 INFO - 'LANG': 'en_US.UTF-8', 22:08:12 INFO - 'LANGUAGE': 'en_US:en', 22:08:12 INFO - 'LOGNAME': 'cltbld', 22:08:12 INFO - 'MAIL': '/var/mail/cltbld', 22:08:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:08:12 INFO - 'MOZ_NO_REMOTE': '1', 22:08:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:08:12 INFO - 'NO_EM_RESTART': '1', 22:08:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:08:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:08:12 INFO - 'PWD': '/builds/slave/test', 22:08:12 INFO - 'SHELL': '/bin/bash', 22:08:12 INFO - 'SHLVL': '1', 22:08:12 INFO - 'TERM': 'linux', 22:08:12 INFO - 'TMOUT': '86400', 22:08:12 INFO - 'USER': 'cltbld', 22:08:12 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1506142770.322045-1208929790', 22:08:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:08:12 INFO - '_': '/tools/buildbot/bin/python'} 22:08:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:08:12 INFO - Downloading/unpacking blobuploader==1.2.4 22:08:12 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 22:08:12 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 22:08:12 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 22:08:12 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 22:08:13 INFO - Downloading blobuploader-1.2.4.tar.gz 22:08:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 22:08:13 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 22:08:13 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 22:08:13 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 22:08:13 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 22:08:13 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 22:08:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 22:08:14 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 22:08:14 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 22:08:14 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 22:08:14 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 22:08:14 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 22:08:14 INFO - Downloading docopt-0.6.1.tar.gz 22:08:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 22:08:14 INFO - Installing collected packages: blobuploader, requests, docopt 22:08:14 INFO - Running setup.py install for blobuploader 22:08:14 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 22:08:14 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 22:08:14 INFO - Running setup.py install for requests 22:08:14 INFO - Running setup.py install for docopt 22:08:15 INFO - Successfully installed blobuploader requests docopt 22:08:15 INFO - Cleaning up... 22:08:15 INFO - Return code: 0 22:08:15 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:08:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:08:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:08:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:08:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:08:15 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 0x1d9a1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f62b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21079c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2104d60>, '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 0x2105a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2105ef0>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1506142770.322045-1208929790', '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 22:08:15 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 22:08:15 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 22:08:15 INFO - Using env: {'DISPLAY': ':0', 22:08:15 INFO - 'HOME': '/home/cltbld', 22:08:15 INFO - 'LANG': 'en_US.UTF-8', 22:08:15 INFO - 'LANGUAGE': 'en_US:en', 22:08:15 INFO - 'LOGNAME': 'cltbld', 22:08:15 INFO - 'MAIL': '/var/mail/cltbld', 22:08:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:08:15 INFO - 'MOZ_NO_REMOTE': '1', 22:08:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:08:15 INFO - 'NO_EM_RESTART': '1', 22:08:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:08:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:08:15 INFO - 'PWD': '/builds/slave/test', 22:08:15 INFO - 'SHELL': '/bin/bash', 22:08:15 INFO - 'SHLVL': '1', 22:08:15 INFO - 'TERM': 'linux', 22:08:15 INFO - 'TMOUT': '86400', 22:08:15 INFO - 'USER': 'cltbld', 22:08:15 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1506142770.322045-1208929790', 22:08:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:08:15 INFO - '_': '/tools/buildbot/bin/python'} 22:08:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:08:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 22:08:15 INFO - Running setup.py (path:/tmp/pip-pbt96B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 22:08:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 22:08:15 INFO - Running setup.py (path:/tmp/pip-Yv1RhJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 22:08:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 22:08:15 INFO - Running setup.py (path:/tmp/pip-Je__5a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 22:08:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 22:08:15 INFO - Running setup.py (path:/tmp/pip-9VejPr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 22:08:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 22:08:15 INFO - Running setup.py (path:/tmp/pip-Pqi8Aa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 22:08:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 22:08:15 INFO - Running setup.py (path:/tmp/pip-w2aOb7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 22:08:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 22:08:15 INFO - Running setup.py (path:/tmp/pip-rhHC0W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 22:08:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 22:08:15 INFO - Running setup.py (path:/tmp/pip-AyQWxS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 22:08:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 22:08:15 INFO - Running setup.py (path:/tmp/pip-pvJMTN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 22:08:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 22:08:15 INFO - Running setup.py (path:/tmp/pip-TpaGY5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 22:08:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 22:08:15 INFO - Running setup.py (path:/tmp/pip-5s_Lez-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 22:08:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 22:08:16 INFO - Running setup.py (path:/tmp/pip-GwmS0y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 22:08:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 22:08:16 INFO - Running setup.py (path:/tmp/pip-4Padzi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 22:08:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 22:08:16 INFO - Running setup.py (path:/tmp/pip-eNX0BG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 22:08:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 22:08:16 INFO - Running setup.py (path:/tmp/pip-4YCKx7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 22:08:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 22:08:16 INFO - Running setup.py (path:/tmp/pip-cq0aft-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 22:08:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 22:08:16 INFO - Running setup.py (path:/tmp/pip-mfD3Ml-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 22:08:16 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 22:08:16 INFO - Running setup.py install for manifestparser 22:08:16 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 22:08:16 INFO - Running setup.py install for mozcrash 22:08:16 INFO - Running setup.py install for mozdebug 22:08:16 INFO - Running setup.py install for mozdevice 22:08:16 INFO - Installing dm script to /builds/slave/test/build/venv/bin 22:08:16 INFO - Running setup.py install for mozfile 22:08:16 INFO - Running setup.py install for mozhttpd 22:08:17 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 22:08:17 INFO - Running setup.py install for mozinfo 22:08:17 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 22:08:17 INFO - Running setup.py install for mozInstall 22:08:17 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 22:08:17 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 22:08:17 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 22:08:17 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 22:08:17 INFO - Running setup.py install for mozleak 22:08:17 INFO - Running setup.py install for mozlog 22:08:17 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 22:08:17 INFO - Running setup.py install for moznetwork 22:08:17 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 22:08:17 INFO - Running setup.py install for mozprocess 22:08:17 INFO - Running setup.py install for mozprofile 22:08:17 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 22:08:17 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 22:08:17 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 22:08:17 INFO - Running setup.py install for mozrunner 22:08:17 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 22:08:17 INFO - Running setup.py install for mozscreenshot 22:08:18 INFO - Running setup.py install for moztest 22:08:18 INFO - Running setup.py install for mozversion 22:08:18 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 22:08:18 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 22:08:18 INFO - Cleaning up... 22:08:18 INFO - Return code: 0 22:08:18 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:08:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:08:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:08:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:08:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:08:18 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 0x1d9a1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f62b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21079c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2104d60>, '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 0x2105a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2105ef0>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1506142770.322045-1208929790', '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 22:08:18 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 22:08:18 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 22:08:18 INFO - Using env: {'DISPLAY': ':0', 22:08:18 INFO - 'HOME': '/home/cltbld', 22:08:18 INFO - 'LANG': 'en_US.UTF-8', 22:08:18 INFO - 'LANGUAGE': 'en_US:en', 22:08:18 INFO - 'LOGNAME': 'cltbld', 22:08:18 INFO - 'MAIL': '/var/mail/cltbld', 22:08:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:08:18 INFO - 'MOZ_NO_REMOTE': '1', 22:08:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:08:18 INFO - 'NO_EM_RESTART': '1', 22:08:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:08:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:08:18 INFO - 'PWD': '/builds/slave/test', 22:08:18 INFO - 'SHELL': '/bin/bash', 22:08:18 INFO - 'SHLVL': '1', 22:08:18 INFO - 'TERM': 'linux', 22:08:18 INFO - 'TMOUT': '86400', 22:08:18 INFO - 'USER': 'cltbld', 22:08:18 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1506142770.322045-1208929790', 22:08:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:08:18 INFO - '_': '/tools/buildbot/bin/python'} 22:08:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:08:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 22:08:18 INFO - Running setup.py (path:/tmp/pip-uoYGfL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 22:08:18 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)) 22:08:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 22:08:18 INFO - Running setup.py (path:/tmp/pip-WZNzq_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 22:08:18 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)) 22:08:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 22:08:18 INFO - Running setup.py (path:/tmp/pip-nFoBj9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 22:08:18 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)) 22:08:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 22:08:18 INFO - Running setup.py (path:/tmp/pip-SiXu6a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 22:08:18 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)) 22:08:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 22:08:18 INFO - Running setup.py (path:/tmp/pip-Va0gqn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 22:08:18 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)) 22:08:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 22:08:18 INFO - Running setup.py (path:/tmp/pip-sMNfd3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 22:08:18 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)) 22:08:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 22:08:18 INFO - Running setup.py (path:/tmp/pip-I4wPe_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 22:08:18 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)) 22:08:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 22:08:18 INFO - Running setup.py (path:/tmp/pip-5rD_Fx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 22:08:19 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)) 22:08:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 22:08:19 INFO - Running setup.py (path:/tmp/pip-2_734C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 22:08:19 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)) 22:08:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 22:08:19 INFO - Running setup.py (path:/tmp/pip-ZHjqE5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 22:08:19 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)) 22:08:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 22:08:19 INFO - Running setup.py (path:/tmp/pip-llhkQ7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 22:08:19 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)) 22:08:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 22:08:19 INFO - Running setup.py (path:/tmp/pip-pPfFQ8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 22:08:19 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)) 22:08:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 22:08:19 INFO - Running setup.py (path:/tmp/pip-aan5lp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 22:08:19 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)) 22:08:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 22:08:19 INFO - Running setup.py (path:/tmp/pip-Gmsbw7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 22:08:19 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)) 22:08:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 22:08:19 INFO - Running setup.py (path:/tmp/pip-AHCi7K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 22:08:19 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)) 22:08:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 22:08:19 INFO - Running setup.py (path:/tmp/pip-XLHKgb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 22:08:19 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)) 22:08:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 22:08:19 INFO - Running setup.py (path:/tmp/pip-3PN8FP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 22:08:19 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)) 22:08:19 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)) 22:08:19 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)) 22:08:19 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)) 22:08:19 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)) 22:08:19 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)) 22:08:19 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)) 22:08:19 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 22:08:19 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 22:08:19 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 22:08:19 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 22:08:19 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 22:08:20 INFO - Downloading blessings-1.6.tar.gz 22:08:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 22:08:20 INFO - Installing collected packages: blessings 22:08:20 INFO - Running setup.py install for blessings 22:08:20 INFO - Successfully installed blessings 22:08:20 INFO - Cleaning up... 22:08:21 INFO - Return code: 0 22:08:21 INFO - Done creating virtualenv /builds/slave/test/build/venv. 22:08:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 22:08:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 22:08:21 INFO - Reading from file tmpfile_stdout 22:08:21 INFO - Current package versions: 22:08:21 INFO - argparse == 1.2.1 22:08:21 INFO - blessings == 1.6 22:08:21 INFO - blobuploader == 1.2.4 22:08:21 INFO - docopt == 0.6.1 22:08:21 INFO - functools32 == 3.2.3-2 22:08:21 INFO - jsonschema == 2.5.1 22:08:21 INFO - manifestparser == 1.1 22:08:21 INFO - mozInstall == 1.13 22:08:21 INFO - mozcrash == 1.0 22:08:21 INFO - mozdebug == 0.1 22:08:21 INFO - mozdevice == 0.51 22:08:21 INFO - mozfile == 1.2 22:08:21 INFO - mozhttpd == 0.7 22:08:21 INFO - mozinfo == 0.10 22:08:21 INFO - mozleak == 0.1 22:08:21 INFO - mozlog == 3.5 22:08:21 INFO - moznetwork == 0.27 22:08:21 INFO - mozprocess == 0.25 22:08:21 INFO - mozprofile == 0.28 22:08:21 INFO - mozrunner == 6.13 22:08:21 INFO - mozscreenshot == 0.1 22:08:21 INFO - mozsystemmonitor == 0.3 22:08:21 INFO - moztest == 0.8 22:08:21 INFO - mozversion == 1.4 22:08:21 INFO - psutil == 3.1.1 22:08:21 INFO - requests == 1.2.3 22:08:21 INFO - wsgiref == 0.1.2 22:08:21 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:08:21 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')]} 22:08:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:08:21 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')]} 22:08:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:08:21 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 0x1d9a1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f62b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21079c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2104d60>, '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 0x2105a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2105ef0>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1506142770.322045-1208929790', '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 22:08:21 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 22:08:21 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 22:08:21 INFO - Using env: {'DISPLAY': ':0', 22:08:21 INFO - 'HOME': '/home/cltbld', 22:08:21 INFO - 'LANG': 'en_US.UTF-8', 22:08:21 INFO - 'LANGUAGE': 'en_US:en', 22:08:21 INFO - 'LOGNAME': 'cltbld', 22:08:21 INFO - 'MAIL': '/var/mail/cltbld', 22:08:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:08:21 INFO - 'MOZ_NO_REMOTE': '1', 22:08:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:08:21 INFO - 'NO_EM_RESTART': '1', 22:08:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:08:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:08:21 INFO - 'PWD': '/builds/slave/test', 22:08:21 INFO - 'SHELL': '/bin/bash', 22:08:21 INFO - 'SHLVL': '1', 22:08:21 INFO - 'TERM': 'linux', 22:08:21 INFO - 'TMOUT': '86400', 22:08:21 INFO - 'USER': 'cltbld', 22:08:21 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1506142770.322045-1208929790', 22:08:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:08:21 INFO - '_': '/tools/buildbot/bin/python'} 22:08:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:08:21 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)) 22:08:21 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)) 22:08:21 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)) 22:08:21 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)) 22:08:21 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)) 22:08:21 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)) 22:08:21 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)) 22:08:21 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)) 22:08:21 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)) 22:08:21 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 22:08:21 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 22:08:21 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 22:08:21 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 22:08:21 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 22:08:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 22:08:22 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)) 22:08:22 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)) 22:08:22 INFO - Installing collected packages: simplejson 22:08:22 INFO - Running setup.py install for simplejson 22:08:22 INFO - building 'simplejson._speedups' extension 22:08:22 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 22:08:23 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 22:08:23 INFO - Successfully installed simplejson 22:08:23 INFO - Cleaning up... 22:08:23 INFO - Return code: 0 22:08:23 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 22:08:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:08:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:08:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:08:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:08:23 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d9a1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f62b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21079c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2104d60>, '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 0x2105a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2105ef0>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1506142770.322045-1208929790', '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 22:08:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 22:08:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 22:08:23 INFO - Using env: {'DISPLAY': ':0', 22:08:23 INFO - 'HOME': '/home/cltbld', 22:08:23 INFO - 'LANG': 'en_US.UTF-8', 22:08:23 INFO - 'LANGUAGE': 'en_US:en', 22:08:23 INFO - 'LOGNAME': 'cltbld', 22:08:23 INFO - 'MAIL': '/var/mail/cltbld', 22:08:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:08:23 INFO - 'MOZ_NO_REMOTE': '1', 22:08:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:08:23 INFO - 'NO_EM_RESTART': '1', 22:08:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:08:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:08:23 INFO - 'PWD': '/builds/slave/test', 22:08:23 INFO - 'SHELL': '/bin/bash', 22:08:23 INFO - 'SHLVL': '1', 22:08:23 INFO - 'TERM': 'linux', 22:08:23 INFO - 'TMOUT': '86400', 22:08:23 INFO - 'USER': 'cltbld', 22:08:23 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1506142770.322045-1208929790', 22:08:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:08:23 INFO - '_': '/tools/buildbot/bin/python'} 22:08:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:08:23 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 22:08:23 INFO - Cleaning up... 22:08:23 INFO - Return code: 0 22:08:23 INFO - Running post-action listener: _resource_record_post_action 22:08:23 INFO - Running post-action listener: _start_resource_monitoring 22:08:23 INFO - Starting resource monitoring. 22:08:23 INFO - [mozharness: 2017-09-23 05:08:23.966097Z] Finished create-virtualenv step (success) 22:08:23 INFO - [mozharness: 2017-09-23 05:08:23.966617Z] Running install step. 22:08:23 INFO - Running pre-action listener: _resource_record_pre_action 22:08:23 INFO - Running main action method: install 22:08:23 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 22:08:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 22:08:24 INFO - Reading from file tmpfile_stdout 22:08:24 INFO - Detecting whether we're running mozinstall >=1.0... 22:08:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 22:08:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 22:08:24 INFO - Reading from file tmpfile_stdout 22:08:24 INFO - Output received: 22:08:24 INFO - Usage: mozinstall [options] installer 22:08:24 INFO - Options: 22:08:24 INFO - -h, --help show this help message and exit 22:08:24 INFO - -d DEST, --destination=DEST 22:08:24 INFO - Directory to install application into. [default: 22:08:24 INFO - "/builds/slave/test"] 22:08:24 INFO - --app=APP Application being installed. [default: firefox] 22:08:24 INFO - mkdir: /builds/slave/test/build/application 22:08:24 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'] 22:08:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 22:08:41 INFO - Reading from file tmpfile_stdout 22:08:41 INFO - Output received: 22:08:41 INFO - /builds/slave/test/build/application/firefox/firefox 22:08:41 INFO - Running post-action listener: _resource_record_post_action 22:08:41 INFO - [mozharness: 2017-09-23 05:08:41.944130Z] Finished install step (success) 22:08:41 INFO - [mozharness: 2017-09-23 05:08:41.944382Z] Running setup-mitmproxy step. 22:08:41 INFO - Running pre-action listener: _resource_record_pre_action 22:08:41 INFO - Running main action method: setup_mitmproxy 22:08:41 INFO - Skipping: mitmproxy is not required 22:08:41 INFO - Running post-action listener: _resource_record_post_action 22:08:41 INFO - [mozharness: 2017-09-23 05:08:41.945510Z] Finished setup-mitmproxy step (success) 22:08:41 INFO - [mozharness: 2017-09-23 05:08:41.945731Z] Running run-tests step. 22:08:41 INFO - Running pre-action listener: _resource_record_pre_action 22:08:41 INFO - Running pre-action listener: _set_gcov_prefix 22:08:41 INFO - Running main action method: run_tests 22:08:41 WARNING - Try message not found. 22:08:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 22:08:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 22:08:41 INFO - Python 2.7.3 22:08:41 INFO - Return code: 0 22:08:41 INFO - grabbing minidump binary from tooltool 22:08:41 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')]} 22:08:41 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 0x2104d60>, '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 0x2105a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2105ef0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 22:08:41 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 22:08:41 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 22:08:41 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 22:08:42 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 22:08:42 INFO - Return code: 0 22:08:42 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 22:08:42 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 22:08:42 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 22:08:42 INFO - ENV: RUST_BACKTRACE is now full 22:08:42 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 22:08:42 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 22:08:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-stylo-disabled-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/JtWjNlDyQMG39ykVhnRwEg/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-067', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_raw.log'] in /builds/slave/test/build 22:08:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-stylo-disabled-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/JtWjNlDyQMG39ykVhnRwEg/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-067 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_raw.log 22:08:42 INFO - Using env: {'DISPLAY': ':0', 22:08:42 INFO - 'HOME': '/home/cltbld', 22:08:42 INFO - 'LANG': 'en_US.UTF-8', 22:08:42 INFO - 'LANGUAGE': 'en_US:en', 22:08:42 INFO - 'LOGNAME': 'cltbld', 22:08:42 INFO - 'MAIL': '/var/mail/cltbld', 22:08:42 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 22:08:42 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 22:08:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:08:42 INFO - 'MOZ_NO_REMOTE': '1', 22:08:42 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 22:08:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:08:42 INFO - 'NO_EM_RESTART': '1', 22:08:42 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:08:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:08:42 INFO - 'PWD': '/builds/slave/test', 22:08:42 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 22:08:42 INFO - 'RUST_BACKTRACE': 'full', 22:08:42 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 22:08:42 INFO - 'SHELL': '/bin/bash', 22:08:42 INFO - 'SHLVL': '1', 22:08:42 INFO - 'TERM': 'linux', 22:08:42 INFO - 'TMOUT': '86400', 22:08:42 INFO - 'USER': 'cltbld', 22:08:42 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1506142770.322045-1208929790', 22:08:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:08:42 INFO - '_': '/tools/buildbot/bin/python'} 22:08:42 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-stylo-disabled-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/JtWjNlDyQMG39ykVhnRwEg/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-067', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_raw.log'] with output_timeout 3600 22:08:42 INFO - mozversion application_buildid: 20170923034137 22:08:42 INFO - mozversion application_changeset: 9d1fcbc2fdd58011903aa1b987264d58dc1a06b5 22:08:42 INFO - mozversion application_display_name: Nightly 22:08:42 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 22:08:42 INFO - mozversion application_name: Firefox 22:08:42 INFO - mozversion application_remotingname: firefox 22:08:42 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 22:08:42 INFO - mozversion application_vendor: Mozilla 22:08:42 INFO - mozversion application_version: 58.0a1 22:08:42 INFO - mozversion platform_buildid: 20170923034137 22:08:42 INFO - mozversion platform_changeset: 9d1fcbc2fdd58011903aa1b987264d58dc1a06b5 22:08:42 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 22:08:42 INFO - mozversion platform_version: 58.0a1 22:08:42 INFO - using testdate: 1506143322 22:08:42 INFO - actual date: 1506143322 22:08:42 INFO - starting webserver on 'localhost:48983' 22:08:42 INFO - SUITE-START | Running 2 tests 22:08:42 INFO - TEST-START | dromaeo_css 22:08:42 INFO - Initialising browser for dromaeo_css test... 22:08:42 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:48983/getInfo.html -profile /tmp/tmpLq1nD9/profile 22:08:42 INFO - TEST-INFO | started process 9531 (/builds/slave/test/build/application/firefox/firefox http://localhost:48983/getInfo.html) 22:08:47 INFO - TEST-INFO | 9531: exit 0 22:08:47 INFO - Browser initialized. 22:08:47 INFO - Running cycle 1/1 for dromaeo_css test... 22:08:47 INFO - Using env: {'DISPLAY': ':0', 22:08:47 INFO - 'HOME': '/home/cltbld', 22:08:47 INFO - 'JSGC_DISABLE_POISONING': '1', 22:08:47 INFO - 'LANG': 'en_US.UTF-8', 22:08:47 INFO - 'LANGUAGE': 'en_US:en', 22:08:47 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 22:08:47 INFO - 'LOGNAME': 'cltbld', 22:08:47 INFO - 'MAIL': '/var/mail/cltbld', 22:08:47 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 22:08:47 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 22:08:47 INFO - 'MOZ_CRASHREPORTER': '1', 22:08:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:08:47 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 22:08:47 INFO - 'MOZ_NO_REMOTE': '1', 22:08:47 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 22:08:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:08:47 INFO - 'NO_EM_RESTART': '1', 22:08:47 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:08:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:08:47 INFO - 'PWD': '/builds/slave/test', 22:08:47 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 22:08:47 INFO - 'RUST_BACKTRACE': 'full', 22:08:47 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 22:08:47 INFO - 'SHELL': '/bin/bash', 22:08:47 INFO - 'SHLVL': '1', 22:08:47 INFO - 'STYLO_FORCE_DISABLED': '1', 22:08:47 INFO - 'TERM': 'linux', 22:08:47 INFO - 'TMOUT': '86400', 22:08:47 INFO - 'USER': 'cltbld', 22:08:47 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1506142770.322045-1208929790', 22:08:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:08:47 INFO - '_': '/tools/buildbot/bin/python'} 22:08:47 INFO - TEST-INFO | started process 9776 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpLq1nD9/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 22:08:48 INFO - PID 9776 | 22:08:48 INFO - PID 9776 | (/builds/slave/test/build/application/firefox/firefox:9826): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 22:08:48 INFO - PID 9776 | 22:08:58 INFO - PID 9776 | RSS: Main: 145051648 22:08:58 INFO - PID 9776 | 22:11:55 INFO - PID 9776 | Cycle 1(1): loaded http://localhost:48983/tests/dromaeo/cssquery-dojo.html (next: http://localhost:48983/tests/dromaeo/cssquery-ext.html) 22:11:56 INFO - PID 9776 | RSS: Main: 148819968 22:11:56 INFO - PID 9776 | 22:14:58 INFO - PID 9776 | Cycle 1(1): loaded http://localhost:48983/tests/dromaeo/cssquery-ext.html (next: http://localhost:48983/tests/dromaeo/cssquery-jquery.html) 22:14:58 INFO - PID 9776 | RSS: Main: 146313216 22:14:58 INFO - PID 9776 | 22:18:00 INFO - PID 9776 | Cycle 1(1): loaded http://localhost:48983/tests/dromaeo/cssquery-jquery.html (next: http://localhost:48983/tests/dromaeo/cssquery-mootools.html) 22:18:00 INFO - PID 9776 | RSS: Main: 148602880 22:18:00 INFO - PID 9776 | 22:21:02 INFO - PID 9776 | Cycle 1(1): loaded http://localhost:48983/tests/dromaeo/cssquery-mootools.html (next: http://localhost:48983/tests/dromaeo/cssquery-prototype.html) 22:21:03 INFO - PID 9776 | RSS: Main: 146886656 22:21:03 INFO - PID 9776 | 22:24:05 INFO - PID 9776 | Cycle 1(1): loaded http://localhost:48983/tests/dromaeo/cssquery-prototype.html (next: http://localhost:48983/tests/dromaeo/cssquery-yui.html) 22:24:06 INFO - PID 9776 | RSS: Main: 146542592 22:24:06 INFO - PID 9776 | 22:27:07 INFO - PID 9776 | Cycle 1(1): loaded http://localhost:48983/tests/dromaeo/cssquery-yui.html (next: http://localhost:48983/tests/dromaeo/cssquery-dojo.html) 22:27:08 INFO - PID 9776 | RSS: Main: 150945792 22:27:08 INFO - PID 9776 | 22:27:08 INFO - PID 9776 | __start_tp_report 22:27:08 INFO - PID 9776 | _x_x_mozilla_page_load 22:27:08 INFO - PID 9776 | _x_x_mozilla_page_load_details 22:27:08 INFO - PID 9776 | |i|pagename|runs| 22:27:08 INFO - PID 9776 | |0;dojo.html;3835.4822099016624;3852.614738526148;3872.2061977294657;3873.6320049595297;3895.279373315935;6217.28501222359;6276.309605943343;6362.745490180388;6441.549091563593;6451.161349024626;6336.493080553568;6388.073729309247;6394.584352017116;6415.518836087301;6429.132067170931;5695.34503532095;5793.507551858097;5799;5811.27359080115;5822.446867547597;58.53373006194816;5788.47903688668;5842.561807864406;5872.61827981182;5875.148103524986;5349.465053494639;5697.886042279152;5705.343885453184;5804.187413762077;5811.796587119452;5695.401982791788;5728.484436400702;5785.016547186989;5786.421357864222;5795.246617939683;5667.291588551431;5703.087505999062;5762.049261871786;5772.480476757112;5777.7977770777825;6252.367565843256;6344.111824344549;6412.262589802186;6415.743370265184;6419.101325814389;6627.701753421107;6768.932310676929;6846.075779769767;6891.689873955684;6969.9303006969785;6803.081583986148;7007.299270073003;7060.611666358348;7066.7173313067415;7070.36366726997;6366.840828979312;6382.648954307511;6473.643949582771;6480.416762491352;6512.218533775977;7022.824429389306;7180.640967951582;7189.1013623297085;7202.279772022755;7205.819854503679;6793.490488213404;6824.351686589766;6840.076589660432;6887.449004079762;6909.27452617478;6780.796576102626;6858.039874417585;6892.379685828299;6912.274211207851;6984.615846128511;6904.1024666794;6905.998630198593;6916.688749006306;6965.82585435358;6969.05917701114;6838.179418469816;6878.209005964278;6971.407430368374;6978.895316570255;6990.405815505637;5026.447090820006;5050.545450909362;5076.390833100052;5108.335916330928;5119.1553393690365;4418.138462999685;4512.435945506812;4548.340490628906;4561.794719237642;4640.86077417678;6307.621542707452;6312.747490100436;6382.266039405435;6384.32964538726;6395.2645445773405;6732.7643532477105;6804.353586409283;6827.829304267433;6898.413634840995;6930.029795828588;6260.780872669526;6264.749410023639;6282.465990390868;6304.936950630527;6309.873802523924;5593.636413633101;5618.494335509824;5620.325560932714;5628.634138780966;5653.180288858175;7147.070880785464;7148.35664790161;7226.783196504113;7266.636668166676;7283.70865165398;6811.182658081062;6893.241743408221;6903.689333979883;6907;7001.474889383317;7080.929190708233;7148.213696493485;7166.247544007804;7167.892481612885;7175.641217939186;6794.048833163262;6872.209695885037;6925.3074692530345;6935.6878940446795;6953.582785032914;6795;6885.690143943635;6888.070110535214;6891.655417229219;6957.7216911325;6664.067030615621;6750.797476075725;6800.28596997328;6801.761938332134;6803.047573339637;6694.59832410057;6713.832154196184;6766.458683305225;6780.627065511247;6790.151231096113;6519.934800651933;6621.33786621334;6634.336566343327;6651.401373876374;6732.764353247613;6745.561538499982;6796.218434880052;6805.727770889109;6814.488913331421;6826.8634627308165;6556.606603603608;6608.173978252718;6634.436072933855;6648.20221573395;6649.501287403561 22:27:08 INFO - PID 9776 | |1;ext.html;892.8482158033136;953.0897992417242;953.8950715421303;999.3304485994383;1004.3220825942497;44425.55574444254;45292.54707452925;45384.546154538446;45427.77286113573;45476.726163691805;40701.38947915776;41197.7940110299;41447.58552414475;41646.16707665845;41653.16693666125;7668.578228197447;7824.530528168328;7859.371250299962;7868.960655196716;7875.251851074138;7734.419918506106;7828.590853646341;7834.608269586526;7851.254130857559;7879.881801772949;8412.453190542627;8615.612297446598;8618.052014278455;8637.697680581181;8660.047394786568;8491.320694344438;8565.95717021414;8599.527026013568;8602;8603.010653774802;7976.0827504836525;8161.428699991003;8202.425830191889;8406.621702023362;8559.27246184075;40669.18661626751;40974.180516389504;40977.38533921994;41037.384439233436;41055;3634.9273014539563;3676.356637588438;3693.833777479993;3696;3701.7038636908983;33597.16007099818;33850;33872.322553548795;33932.15169620755;34056.48915266273;5455.754491047913;5500.3949565547755;5514.979728750194;5537.861553461195;5544.695041772701;214044;214602;214705;215970;216020;54466.45533544614;54610.45389546054;54674;54738;54956.450435495135;56707.43292567022;56928.43071569314;56974.715126424104;56999.71500142473;57101.428985710445;16633.916830415772;16960.915195423942;16993.235304411082;17022.233999470052;17041;13608.523701670592;13616.591502254949;13712.794308085387;13722.794158087636;13734.519291824738;15466.149361784985;15497.690046199014;15623.218839058001;15671.764923526156;15678.9216053919;6266.561340706106;6282.4974002079725;6291.7797877075;6332.905006424908;6372.107904893319;1065.8347956066823;1072.1155047086186;1072.1529991306936;1078.7680648660576;1108.5621179634;25288.494230115295;25489;25851.353716157246;25894.611580826302;25909.61135582968;1175.670812172593;1186.2467333243453;1193.0813273779142;1203.272020427646;1210.9394530273628;13315.600531984055;13361.66595835112;13452.394642241123;13460.528881489101;13770;287880;289337;290013;290140;290190;57891.131633025536;58186.709066454394;63203.6839815798;64103;64278.35721642817;1474.7714104313634;1487.851214878525;1489.247929795468;1515.8484151584973;1525.1916484263359;30411.69588304177;30827.845860770554;30946.381072378877;30994.225144371572;31056.689433106283;40727.389089163094;40753.38869917013;40810.38784418296;40875.7956210217;40901.38647920224;234533;235323;235516;235909;237131;34561.827190863885;35692.10769730777;35731;35737.28525429529;35866.28267434584;45843.541564583924;46283;47185;47229.52770472251;47314;34405.311893761485;34735.478967815;34773.82613086919;34903.65096349004;35005.82497087498;32733;33885.32229355448;33914.49128263029;34075.65924340824;34100.488492672135;40153.79923100366;40210.597894021856;40646.1870762589;40677;40777.59222407738;33240.33519329648;33519.16202094967;33933.49099763456;33973.150671232426;34195.658043419244;24420;25220.74779252184;25227.369315767253;25667.229983100537;25880.741192587833 22:27:08 INFO - PID 9776 | |2;jquery.html;617.6788070203493;623.4973713350826;627.1126356205968;627.2629660149323;643.5913195121099;22427.32718018458;23464.530709385803;24328.75671243287;24370.878145609247;24403.26790196297;24694.50610987779;25221.369465763364;25278.115265965695;25304.620430693554;25317.11390101347;6664.73341066358;6787.796366109;6802.965985170067;6810.727570897183;6852.554583952052;6378.394052564999;6652.900206496882;6690.6654667266685;6703.229128650194;6708.698108585126;6607.93392066078;6631.237407698104;6640.203175618933;6665.6333901635635;6684.565503242298;6576.93423065768;6578.144841170665;6642.734290628369;6648.301928297532;6662.700178491979;6171.259448866164;6187.752489900398;6188.659623720693;6212.565120441571;6222.315545290015;28167.295817604518;28888;29750;29931.551026734618;29965.700342996508;2167.371462275938;2205.3383984804495;2206.8344874134345;2211.9889400553056;2214.357836227492;19942.102605382646;20530;20537.589248215103;20551.691724624143;20632.27787027447;2362.2913126062112;2482.391814005562;2486.17956074495;2499.262717498324;2565.602331638599;142897;148465;159483;166427;166955.16522417433;15226.238688065552;15769.763453548207;15819.762703559456;15849.603759906095;16033.198340082949;25417;25660;25661.075419343622;25737.099201527857;25812.48375032489;10197.439140847177;10277.691669249934;10365.689029329133;10535;10611.363318200933;9341.859872101924;9387.812243755223;9429.764255893657;9430.245580353556;9532.285078618992;9406.811863762687;9764.951175244078;9836.78672298727;9978.158409012582;9987.700368988943;2958.6153800005864;2983.045425463874;2987.357718090621;2989.4170636726067;2995.2062703383185;1017.8829434614966;1048.910842578374;1050.3330385205297;1053.7049626104704;1060.734816295926;20727;21051.473713156985;21058.262960796605;21241;21344.679829802564;1067.055655744656;1071.3411252079916;1072.4208927179236;1084.6366467233565;1096.17786660005;11466.254693445066;11587.594434194763;11601;11667.6499705009;11728.472218750177;573572;580643;589877;590199.0980090144;591680;130420.3478982599;133030.33484832707;133324;134904;136494;1119.8992090711874;1156.0520373293818;1206.5113628980102;1221.4564518789055;1269.2765123879485;22003.889980549993;22462.213822516132;22510.437239069153;22628.321150365515;22806.657900131842;64922;65381;65726;66167.33832661805;67566.66216668885;81152.59423702843;81957;82091.58954205191;82347.5882620583;82477.58761206156;15069.924650377117;15547.455839045579;15612.609684757972;15674.059556426651;15702.607434814221;23852.04591816308;24319.756802431748;24408.51182976366;24659.136930208075;24856.254312370656;19002.23991040343;19324.710129348354;19662.508437289183;19850.90074549618;20020.49948751293;17039.233234504725;17336;17725.113744312992;17988.190531425855;18191.727124092886;19956.3015294464;20027.098780554617;20233.898830505754;20381.49046273855;20426.28508002272;15257;15258.694826103194;15280.541583752505;15375.154366509501;15418.768718469008;18750.156242968827;18805.529861753566;19281.325153620117;19529.902350488155;19644.705329420354 22:27:08 INFO - PID 9776 | |3;mootools.html;1396.1553260277533;1517.9316930738116;1517.977230341545;1518.5975716435153;1519.6808670179275;18287.634247315047;18879.811201888013;18891.811081889176;18894.338698145566;18909.62180756384;18100.366487172952;18227.72658410125;18350.908245458755;18365.265389384444;18399.26402943884;2830.775865871409;2839.219214715949;2879.9136025919256;2881.8126821756623;2884.697106803787;2941.8970336038137;2972.8364939928297;2979.8808047678067;2984.6418429788346;2986.2832920099127;2841.460122576714;2868.254253893992;2943.9852800735966;2945.661248956376;2950.129711735043;2725.141580402167;2726.6727992640913;2755;2755.435135797167;2755.9035433759923;2727.7408646178583;2798.748112669849;2809.7190280971945;2822.153353993814;2828.349479619699;16930.238139283763;17059.317627294895;17066.48800535986;17081.206473320246;17114.31542738289;8650.697225597074;8809.119088091204;8900.154485323885;8912.24245939096;8938.463692178426;6206.472449841769;6246.344133865924;6325.272593651697;6350.26971898233;6351.396617321393;2015.9617308959616;2093.7906209379094;2112.387407651779;2131.6802479628027;2170.5550362175873;30895;30981.8450907744;31048.844755776077;31054.689453105406;31085.533716994265;7421.703131874665;7453.217412171643;7510.474266801271;7622.085349757954;7669.463137580316;19953.60092798136;19971.700424493643;19999.800001999793;20045.298414555422;20046.198152073754;8475.533845638549;8712;8717.346199034972;8724;8737.169968852948;7458.254174582498;7572.4699271050495;7576.545407275581;7753.457257991887;7870.212978702199;5575.776968921197;5666.263385759825;5673.290838645169;5728.914066289009;5745.368009518949;1639.8606118480063;1653;1664.083611508508;1677.7064013797537;1699.1419333236636;952.7618095476131;973.1873885305849;974.6880998080688;991.5240684471494;1002.9348092373972;8557.10150434208;8606;8661.566921653892;9554.283428742872;10062.144717699077;711.1750369571273;731.5427857589007;732.2713899669862;741.8182545276334;743.5538676793989;5269.499397557226;5816.621919575298;5846.912296315559;5848.88302233953;6019.277686677627;22501.549969000527;25397.746022539908;25795.226143215732;25835.74164258371;25857.353566160997;24355.878220608785;24372;24804;24846;25463.61804572933;12118.39408029595;12144.817827732591;12409.937950310372;12479.875201248053;12538.81191782124;9381.694982810857;10173.338732982333;10345.793084138124;10361.896381036395;10428.478576071318;21732.45668858291;21885;22099.447513812283;22114.77885221127;22149.889250553642;22288.888555557765;22461.887690562096;22661.773382265965;22726;22928.656070159293;13723.931380343034;13757.17456952586;13995.720085598434;14009.43962241499;14012.929935350257;15851.207439628202;15884.205789710699;16027.439039633557;16044.839551604335;16054.759178612563;12904.935475322563;12976.805347919977;13112.147710398793;13180.209187448783;13322.200667959953;12717.745645087232;12720.87279127197;12865.163764355288;12898.419571119135;13052.804207936699;10645.680629581126;10894.346339219672;10896.673099807018;10899.29154604948;10917.344959302467;8137.819682261275;8186.058603260463;8202.17978202175;8291.792705182419;8315.085340612648;8727.301815854844;8788.91211087881;8791.340649451444;8804.60379282921;8893.421927574687 22:27:08 INFO - PID 9776 | |4;prototype.html;548.183207021538;557.9302587176602;565.0704590947894;570.96859672718;573.9913901291479;6291.307956124829;6293.874122517547;6360.681965901704;6379.681015949207;6443.581167224127;6242.219722534684;6276.497880169587;6279.497640188785;6293.332266949251;6309.4636955858805;5047.722375269359;5101.795928162887;5170.405403378622;5171.112543921479;5193.091209038422;4844.733539655317;5058.2412638104215;5103.540681338679;5111.591072714174;5169.6898186108765;4973.477784832595;4995.200767877141;5025.874353141164;5034.723090230036;5052;4934.185859333205;4990.750462476898;5008.173651347523;5027.648064635477;5038.496150384932;4550.931736023962;4560;4561.129936725926;4572.337011133401;4573;6274.529410294246;6278.30938596754;6285.9057114143325;6292.080915320826;6296.622202667854;5923.733431995571;5936.821895343147;5954.8809023819285;5969.26891201551;5982.431668991482;6499.805005849832;6559.163434238373;6659.9354200198095;6668.5329227569855;6754.142610782025;4975.378077740283;5055.115354812893;5058.3929928408825;5071.949280507185;5078.162103252959;6678.888816732684;6834.214065382445;6837.9059350503685;6896.310368963113;6918.446524278096;5152.845414637492;5196.688198708014;5226.398964119175;5233.267342572043;5236.109861323508;5302.602304827154;5318.893622127536;5319.973400132974;5322.520973112361;5333.253344531769;5780.624259423124;5854.560907931922;5867.970660146672;5902.6458412495385;5906.911396329058;6751.392374686302;6764.425023873026;6765.830854228585;6779.5254332197255;6782.626955517395;1830.6704793137096;1836.5867679771945;1840.484664293973;1844.3913508542148;1847.9743742223195;1254.5295514182183;1289.509986205236;1308.8102225177297;1312.4094157628915;1325.6619562011626;6079.817605471843;6124.356942520971;6131.540134489931;6192.907106393408;6196.380361963767;6683.298253683391;6739;6740;6775;6828.726850926007;6058.091286307089;6132.792194809865;6193.81418557444;6199.814005579749;6233.937660623426;3541.5927168375965;3563.94654080189;3583.498310236569;3599.964000359963;3615.186583018852;6800.829979250559;6807.727690892408;6860.245373008965;6897.482553838147;7010.474214433836;6801.4898882584;6823.69293381799;6894.758683446055;6917.89623155653;6982.1970473395195;6939.6877140528795;7043.597751405372;7048.321637777714;7052.294770522906;7079.451397496897;6783.660816959034;6793.252742198255;6825.795226143224;6848.486363522856;6873.965630171817;6684.465242780663;6732.697028633625;6815.943528753051;6816.113905192294;6835.7949261522235;6838.487113466411;7000.159980802337;7005.859882802417;7023.438124949889;7051.858962820612;5671.688057156896;5685.48830605231;5724.398938111438;5743.908657355089;5790.131480277992;6606.306337834651;6692.933070669231;6722.159730033746;6772.39048485619;6834.931650683429;6530.987696906987;6599.96700016516;6603.900941485786;6612.933870661232;6638.53530252897;6387.361263873576;6563.967180164069;6572;6597;6604.546999660067;6387.5209359297305;6401.231852177769;6476.967615161894;6501.414872661483;6507.642079685663;6574.309697481695;6592.71442068792;6607.669616519059;6608.966955165386;6680.9331906682255;6370.745170193326;6376.171097757448;6423.4861211103935;6441.742330306923;6456.192975878015 22:27:08 INFO - PID 9776 | |5;yui.html;944.2917811641269;962.4802606592441;981.0434826044608;981.5239608789738;982.047414008412;17756.467305980826;18118.184681689338;18216.362427315045;18233.814802037858;18312.175952082154;16748.83251167488;17021.659566808656;17141.228644710987;17180.828191718112;17246.0514671693;969.6896992962237;996.6412091647002;997.8952210017952;999.420336205003;1001.1190152665644;1052.0373857919994;1053.146950969717;1068.3322923173016;1069.2408390043079;1073.9624113156042;1066.7706443114728;1116.1238427834153;1116.2799994003863;1117.1677100560094;1119.0711709281277;1086.8478413022183;1101.9944900275527;1102.1458369763418;1102.6636875752931;1102.779444111173;789.2659826361481;800.5236884054037;801.046754362307;808.6603626476893;813.259933460548;18073.457796266;18158.09209539518;18183.090845457806;18201.36295229674;18223.45329640113;22760.20339288117;22870.428239293986;23383.649245261335;23503.882480587657;23614.527709445716;17282.395116171;17398.826011739846;17516.12419379026;17606.471805845846;17740.29038838445;4032.4152997815445;4060.9187816243807;4086.0806318578084;4088.9795551022053;4089.795510224477;160337;160832.19583902005;163160.18419907824;163656;164455;15701.371945122295;15874.52376428709;15970.201489925457;15996.76004859928;16133.67732645364;28217.012404565743;28365.149045528666;28374.432511349656;28376.858115709703;28478.430431391254;9173.541322933826;9210.539473026322;9388.8591671125;9426.340156189139;9472.715818525456;4155.168966206771;4220.620144187038;4248.129133527619;4250.574942505725;4260.318349064135;5984.640921544721;5986.970065149733;6023.247094113236;6082.695865206722;6107.633541987495;1095.1403148528368;1100.1583788401879;1115.8005144469566;1116.5198964445367;1124.3928278729559;684.3088480634495;691.6645426967916;697.292248367907;707.0278367245038;708.2563308526027;12427.627171184698;12745.362731863555;12746.235225886476;13290.136141150795;13372.465101395836;734.0494060192065;734.8640501507239;735.8675438421136;741.5143081281769;749.4229443328607;6287.528435367366;6411.487081033506;6435.066915297256;6435.581687190318;6528.053432252297;147429;147790;148876;151013;152150.23924880306;118358;119560;119888;120897;124648;113635.43182284036;114871;115309;115831;119450.80549194397;11993.940030299793;12126.211796233216;12193.268403895794;12254.019678425882;12257.877421225674;56104.71947640236;56223;56310.7184464075;57300;58573.414265856794;71366.64316678383;72211;72475.63762181155;72494.27505725087;73741;16749.497515074567;16830.747538786683;16922.32310707558;16925.069121198452;17016.404425845038;17131.91434042822;17501.47495575135;17566.648667026842;17573.736393953845;17619.64760704753;17407.7388839165;17712.645747084727;17736.91131544334;17840.3755868544;17842.643147137245;15110.093394396372;15272.770908436605;15387.923060385074;15490.9225453872;15624.453144139901;17472.82527174712;17479.563010924827;17504.82495175032;17520.649587007934;17738.733918991482;12934.805977910151;13062.412191451598;13065.477380904656;13116.934415327862;13446.596602101952;12053;12135;12462.813057804322;12963.740725185255;13109 22:27:08 INFO - PID 9776 | __end_tp_report 22:27:08 INFO - PID 9776 | __start_cc_report 22:27:08 INFO - PID 9776 | _x_x_mozilla_cycle_collect,279 22:27:08 INFO - PID 9776 | __end_cc_report 22:27:08 INFO - PID 9776 | __startTimestamp1506144428225__endTimestamp 22:27:08 INFO - PID 9776 | 22:27:08 INFO - PID 9776 | ------- Summary: start ------- 22:27:08 INFO - PID 9776 | Number of tests: 6 22:27:08 INFO - PID 9776 | 22:27:08 INFO - PID 9776 | [#0] dojo.html Cycles:165 Average:6332.30 Median:6648.20 stddev:908.71 (13.7%) stddev-sans-first:890.14 22:27:08 INFO - PID 9776 | Values: 3835.5 3852.6 3872.2 3873.6 3895.3 6217.3 6276.3 6362.7 6441.5 6451.2 6336.5 6388.1 6394.6 6415.5 6429.1 5695.3 5793.5 5799.0 5811.3 5822.4 58.5 5788.5 5842.6 5872.6 5875.1 5349.5 5697.9 5705.3 5804.2 5811.8 5695.4 5728.5 5785.0 5786.4 5795.2 5667.3 5703.1 5762.0 5772.5 5777.8 6252.4 6344.1 6412.3 6415.7 6419.1 6627.7 6768.9 6846.1 6891.7 6969.9 6803.1 7007.3 7060.6 7066.7 7070.4 6366.8 6382.6 6473.6 6480.4 6512.2 7022.8 7180.6 7189.1 7202.3 7205.8 6793.5 6824.4 6840.1 6887.4 6909.3 6780.8 6858.0 6892.4 6912.3 6984.6 6904.1 6906.0 6916.7 6965.8 6969.1 6838.2 6878.2 6971.4 6978.9 6990.4 5026.4 5050.5 5076.4 5108.3 5119.2 4418.1 4512.4 4548.3 4561.8 4640.9 6307.6 6312.7 6382.3 6384.3 6395.3 6732.8 6804.4 6827.8 6898.4 6930.0 6260.8 6264.7 6282.5 6304.9 6309.9 5593.6 5618.5 5620.3 5628.6 5653.2 7147.1 7148.4 7226.8 7266.6 7283.7 6811.2 6893.2 6903.7 6907.0 7001.5 7080.9 7148.2 7166.2 7167.9 7175.6 6794.0 6872.2 6925.3 6935.7 6953.6 6795.0 6885.7 6888.1 6891.7 6957.7 6664.1 6750.8 6800.3 6801.8 6803.0 6694.6 6713.8 6766.5 6780.6 6790.2 6519.9 6621.3 6634.3 6651.4 6732.8 6745.6 6796.2 6805.7 6814.5 6826.9 6556.6 6608.2 6634.4 6648.2 6649.5 22:27:08 INFO - PID 9776 | 22:27:08 INFO - PID 9776 | [#1] ext.html Cycles:180 Average:42872.85 Median:19750.60 stddev:64701.99 (327.6%) stddev-sans-first:64806.71 22:27:08 INFO - PID 9776 | Values: 892.8 953.1 953.9 999.3 1004.3 44425.6 45292.5 45384.5 45427.8 45476.7 40701.4 41197.8 41447.6 41646.2 41653.2 7668.6 7824.5 7859.4 7869.0 7875.3 7734.4 7828.6 7834.6 7851.3 7879.9 8412.5 8615.6 8618.1 8637.7 8660.0 8491.3 8566.0 8599.5 8602.0 8603.0 7976.1 8161.4 8202.4 8406.6 8559.3 40669.2 40974.2 40977.4 41037.4 41055.0 3634.9 3676.4 3693.8 3696.0 3701.7 33597.2 33850.0 33872.3 33932.2 34056.5 5455.8 5500.4 5515.0 5537.9 5544.7 214044.0 214602.0 214705.0 215970.0 216020.0 54466.5 54610.5 54674.0 54738.0 54956.5 56707.4 56928.4 56974.7 56999.7 57101.4 16633.9 16960.9 16993.2 17022.2 17041.0 13608.5 13616.6 13712.8 13722.8 13734.5 15466.1 15497.7 15623.2 15671.8 15678.9 6266.6 6282.5 6291.8 6332.9 6372.1 1065.8 1072.1 1072.2 1078.8 1108.6 25288.5 25489.0 25851.4 25894.6 25909.6 1175.7 1186.2 1193.1 1203.3 1210.9 13315.6 13361.7 13452.4 13460.5 13770.0 287880.0 289337.0 290013.0 290140.0 290190.0 57891.1 58186.7 63203.7 64103.0 64278.4 1474.8 1487.9 1489.2 1515.8 1525.2 30411.7 30827.8 30946.4 30994.2 31056.7 40727.4 40753.4 40810.4 40875.8 40901.4 234533.0 235323.0 235516.0 235909.0 237131.0 34561.8 35692.1 35731.0 35737.3 35866.3 45843.5 46283.0 47185.0 47229.5 47314.0 34405.3 34735.5 34773.8 34903.7 35005.8 32733.0 33885.3 33914.5 34075.7 34100.5 40153.8 40210.6 40646.2 40677.0 40777.6 33240.3 33519.2 33933.5 33973.2 34195.7 24420.0 25220.7 25227.4 25667.2 25880.7 22:27:08 INFO - PID 9776 | 22:27:08 INFO - PID 9776 | [#2] jquery.html Cycles:180 Average:39581.76 Median:23135.59 stddev:98491.29 (425.7%) stddev-sans-first:98724.13 22:27:08 INFO - PID 9776 | Values: 617.7 623.5 627.1 627.3 643.6 22427.3 23464.5 24328.8 24370.9 24403.3 24694.5 25221.4 25278.1 25304.6 25317.1 6664.7 6787.8 6803.0 6810.7 6852.6 6378.4 6652.9 6690.7 6703.2 6708.7 6607.9 6631.2 6640.2 6665.6 6684.6 6576.9 6578.1 6642.7 6648.3 6662.7 6171.3 6187.8 6188.7 6212.6 6222.3 28167.3 28888.0 29750.0 29931.6 29965.7 2167.4 2205.3 2206.8 2212.0 2214.4 19942.1 20530.0 20537.6 20551.7 20632.3 2362.3 2482.4 2486.2 2499.3 2565.6 142897.0 148465.0 159483.0 166427.0 166955.2 15226.2 15769.8 15819.8 15849.6 16033.2 25417.0 25660.0 25661.1 25737.1 25812.5 10197.4 10277.7 10365.7 10535.0 10611.4 9341.9 9387.8 9429.8 9430.2 9532.3 9406.8 9765.0 9836.8 9978.2 9987.7 2958.6 2983.0 2987.4 2989.4 2995.2 1017.9 1048.9 1050.3 1053.7 1060.7 20727.0 21051.5 21058.3 21241.0 21344.7 1067.1 1071.3 1072.4 1084.6 1096.2 11466.3 11587.6 11601.0 11667.6 11728.5 573572.0 580643.0 589877.0 590199.1 591680.0 130420.3 133030.3 133324.0 134904.0 136494.0 1119.9 1156.1 1206.5 1221.5 1269.3 22003.9 22462.2 22510.4 22628.3 22806.7 64922.0 65381.0 65726.0 66167.3 67566.7 81152.6 81957.0 82091.6 82347.6 82477.6 15069.9 15547.5 15612.6 15674.1 15702.6 23852.0 24319.8 24408.5 24659.1 24856.3 19002.2 19324.7 19662.5 19850.9 20020.5 17039.2 17336.0 17725.1 17988.2 18191.7 19956.3 20027.1 20233.9 20381.5 20426.3 15257.0 15258.7 15280.5 15375.2 15418.8 18750.2 18805.5 19281.3 19529.9 19644.7 22:27:08 INFO - PID 9776 | 22:27:08 INFO - PID 9776 | [#3] mootools.html Cycles:180 Average:10737.35 Median:14291.25 stddev:7910.95 (55.4%) stddev-sans-first:7902.01 22:27:08 INFO - PID 9776 | Values: 1396.2 1517.9 1518.0 1518.6 1519.7 18287.6 18879.8 18891.8 18894.3 18909.6 18100.4 18227.7 18350.9 18365.3 18399.3 2830.8 2839.2 2879.9 2881.8 2884.7 2941.9 2972.8 2979.9 2984.6 2986.3 2841.5 2868.3 2944.0 2945.7 2950.1 2725.1 2726.7 2755.0 2755.4 2755.9 2727.7 2798.7 2809.7 2822.2 2828.3 16930.2 17059.3 17066.5 17081.2 17114.3 8650.7 8809.1 8900.2 8912.2 8938.5 6206.5 6246.3 6325.3 6350.3 6351.4 2016.0 2093.8 2112.4 2131.7 2170.6 30895.0 30981.8 31048.8 31054.7 31085.5 7421.7 7453.2 7510.5 7622.1 7669.5 19953.6 19971.7 19999.8 20045.3 20046.2 8475.5 8712.0 8717.3 8724.0 8737.2 7458.3 7572.5 7576.5 7753.5 7870.2 5575.8 5666.3 5673.3 5728.9 5745.4 1639.9 1653.0 1664.1 1677.7 1699.1 952.8 973.2 974.7 991.5 1002.9 8557.1 8606.0 8661.6 9554.3 10062.1 711.2 731.5 732.3 741.8 743.6 5269.5 5816.6 5846.9 5848.9 6019.3 22501.5 25397.7 25795.2 25835.7 25857.4 24355.9 24372.0 24804.0 24846.0 25463.6 12118.4 12144.8 12409.9 12479.9 12538.8 9381.7 10173.3 10345.8 10361.9 10428.5 21732.5 21885.0 22099.4 22114.8 22149.9 22288.9 22461.9 22661.8 22726.0 22928.7 13723.9 13757.2 13995.7 14009.4 14012.9 15851.2 15884.2 16027.4 16044.8 16054.8 12904.9 12976.8 13112.1 13180.2 13322.2 12717.7 12720.9 12865.2 12898.4 13052.8 10645.7 10894.3 10896.7 10899.3 10917.3 8137.8 8186.1 8202.2 8291.8 8315.1 8727.3 8788.9 8791.3 8804.6 8893.4 22:27:08 INFO - PID 9776 | 22:27:08 INFO - PID 9776 | [#4] prototype.html Cycles:180 Average:5669.75 Median:6288.61 stddev:1568.99 (24.9%) stddev-sans-first:1525.58 22:27:08 INFO - PID 9776 | Values: 548.2 557.9 565.1 571.0 574.0 6291.3 6293.9 6360.7 6379.7 6443.6 6242.2 6276.5 6279.5 6293.3 6309.5 5047.7 5101.8 5170.4 5171.1 5193.1 4844.7 5058.2 5103.5 5111.6 5169.7 4973.5 4995.2 5025.9 5034.7 5052.0 4934.2 4990.8 5008.2 5027.6 5038.5 4550.9 4560.0 4561.1 4572.3 4573.0 6274.5 6278.3 6285.9 6292.1 6296.6 5923.7 5936.8 5954.9 5969.3 5982.4 6499.8 6559.2 6659.9 6668.5 6754.1 4975.4 5055.1 5058.4 5071.9 5078.2 6678.9 6834.2 6837.9 6896.3 6918.4 5152.8 5196.7 5226.4 5233.3 5236.1 5302.6 5318.9 5320.0 5322.5 5333.3 5780.6 5854.6 5868.0 5902.6 5906.9 6751.4 6764.4 6765.8 6779.5 6782.6 1830.7 1836.6 1840.5 1844.4 1848.0 1254.5 1289.5 1308.8 1312.4 1325.7 6079.8 6124.4 6131.5 6192.9 6196.4 6683.3 6739.0 6740.0 6775.0 6828.7 6058.1 6132.8 6193.8 6199.8 6233.9 3541.6 3563.9 3583.5 3600.0 3615.2 6800.8 6807.7 6860.2 6897.5 7010.5 6801.5 6823.7 6894.8 6917.9 6982.2 6939.7 7043.6 7048.3 7052.3 7079.5 6783.7 6793.3 6825.8 6848.5 6874.0 6684.5 6732.7 6815.9 6816.1 6835.8 6838.5 7000.2 7005.9 7023.4 7051.9 5671.7 5685.5 5724.4 5743.9 5790.1 6606.3 6692.9 6722.2 6772.4 6834.9 6531.0 6600.0 6603.9 6612.9 6638.5 6387.4 6564.0 6572.0 6597.0 6604.5 6387.5 6401.2 6477.0 6501.4 6507.6 6574.3 6592.7 6607.7 6609.0 6680.9 6370.7 6376.2 6423.5 6441.7 6456.2 22:27:08 INFO - PID 9776 | 22:27:08 INFO - PID 9776 | [#5] yui.html Cycles:180 Average:27516.81 Median:17543.65 stddev:41987.94 (239.3%) stddev-sans-first:42058.32 22:27:08 INFO - PID 9776 | Values: 944.3 962.5 981.0 981.5 982.0 17756.5 18118.2 18216.4 18233.8 18312.2 16748.8 17021.7 17141.2 17180.8 17246.1 969.7 996.6 997.9 999.4 1001.1 1052.0 1053.1 1068.3 1069.2 1074.0 1066.8 1116.1 1116.3 1117.2 1119.1 1086.8 1102.0 1102.1 1102.7 1102.8 789.3 800.5 801.0 808.7 813.3 18073.5 18158.1 18183.1 18201.4 18223.5 22760.2 22870.4 23383.6 23503.9 23614.5 17282.4 17398.8 17516.1 17606.5 17740.3 4032.4 4060.9 4086.1 4089.0 4089.8 160337.0 160832.2 163160.2 163656.0 164455.0 15701.4 15874.5 15970.2 15996.8 16133.7 28217.0 28365.1 28374.4 28376.9 28478.4 9173.5 9210.5 9388.9 9426.3 9472.7 4155.2 4220.6 4248.1 4250.6 4260.3 5984.6 5987.0 6023.2 6082.7 6107.6 1095.1 1100.2 1115.8 1116.5 1124.4 684.3 691.7 697.3 707.0 708.3 12427.6 12745.4 12746.2 13290.1 13372.5 734.0 734.9 735.9 741.5 749.4 6287.5 6411.5 6435.1 6435.6 6528.1 147429.0 147790.0 148876.0 151013.0 152150.2 118358.0 119560.0 119888.0 120897.0 124648.0 113635.4 114871.0 115309.0 115831.0 119450.8 11993.9 12126.2 12193.3 12254.0 12257.9 56104.7 56223.0 56310.7 57300.0 58573.4 71366.6 72211.0 72475.6 72494.3 73741.0 16749.5 16830.7 16922.3 16925.1 17016.4 17131.9 17501.5 17566.6 17573.7 17619.6 17407.7 17712.6 17736.9 17840.4 17842.6 15110.1 15272.8 15387.9 15490.9 15624.5 17472.8 17479.6 17504.8 17520.6 17738.7 12934.8 13062.4 13065.5 13116.9 13446.6 12053.0 12135.0 12462.8 12963.7 13109.0 22:27:08 INFO - PID 9776 | -------- Summary: end -------- 22:27:08 INFO - PID 9776 | 22:27:08 INFO - TEST-INFO | 9776: exit 0 22:27:08 INFO - TEST-OK | dromaeo_css | took 1106561ms 22:27:08 INFO - TEST-START | kraken 22:27:08 INFO - Initialising browser for kraken test... 22:27:08 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:48983/getInfo.html -profile /tmp/tmp7lgaAX/profile 22:27:08 INFO - TEST-INFO | started process 10146 (/builds/slave/test/build/application/firefox/firefox http://localhost:48983/getInfo.html) 22:27:13 INFO - TEST-INFO | 10146: exit 0 22:27:13 INFO - Browser initialized. 22:27:13 INFO - Running cycle 1/1 for kraken test... 22:27:13 INFO - Using env: {'DISPLAY': ':0', 22:27:13 INFO - 'HOME': '/home/cltbld', 22:27:13 INFO - 'JSGC_DISABLE_POISONING': '1', 22:27:13 INFO - 'LANG': 'en_US.UTF-8', 22:27:13 INFO - 'LANGUAGE': 'en_US:en', 22:27:13 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 22:27:13 INFO - 'LOGNAME': 'cltbld', 22:27:13 INFO - 'MAIL': '/var/mail/cltbld', 22:27:13 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 22:27:13 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 22:27:13 INFO - 'MOZ_CRASHREPORTER': '1', 22:27:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:27:13 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 22:27:13 INFO - 'MOZ_NO_REMOTE': '1', 22:27:13 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 22:27:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:27:13 INFO - 'NO_EM_RESTART': '1', 22:27:13 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:27:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:27:13 INFO - 'PWD': '/builds/slave/test', 22:27:13 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 22:27:13 INFO - 'RUST_BACKTRACE': 'full', 22:27:13 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 22:27:13 INFO - 'SHELL': '/bin/bash', 22:27:13 INFO - 'SHLVL': '1', 22:27:13 INFO - 'STYLO_FORCE_DISABLED': '1', 22:27:13 INFO - 'TERM': 'linux', 22:27:13 INFO - 'TMOUT': '86400', 22:27:13 INFO - 'USER': 'cltbld', 22:27:13 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1506142770.322045-1208929790', 22:27:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:27:13 INFO - '_': '/tools/buildbot/bin/python'} 22:27:13 INFO - TEST-INFO | started process 10385 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp7lgaAX/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 22:27:14 INFO - PID 10385 | 22:27:14 INFO - PID 10385 | (/builds/slave/test/build/application/firefox/firefox:10435): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 22:27:14 INFO - PID 10385 | 22:27:25 INFO - PID 10385 | RSS: Main: 144695296 22:27:25 INFO - PID 10385 | 22:27:27 INFO - PID 10385 | Cycle 1(1): loaded http://localhost:48983/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:48983/tests/kraken/driver.html?testName=audio-beat-detection) 22:27:28 INFO - PID 10385 | RSS: Main: 152162304 22:27:28 INFO - PID 10385 | 22:27:30 INFO - PID 10385 | Cycle 1(1): loaded http://localhost:48983/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:48983/tests/kraken/driver.html?testName=audio-dft) 22:27:31 INFO - PID 10385 | RSS: Main: 152125440 22:27:31 INFO - PID 10385 | 22:27:34 INFO - PID 10385 | Cycle 1(1): loaded http://localhost:48983/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:48983/tests/kraken/driver.html?testName=audio-fft) 22:27:34 INFO - PID 10385 | RSS: Main: 147488768 22:27:34 INFO - PID 10385 | 22:27:37 INFO - PID 10385 | Cycle 1(1): loaded http://localhost:48983/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:48983/tests/kraken/driver.html?testName=audio-oscillator) 22:27:37 INFO - PID 10385 | RSS: Main: 148406272 22:27:37 INFO - PID 10385 | 22:27:39 INFO - PID 10385 | Cycle 1(1): loaded http://localhost:48983/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:48983/tests/kraken/driver.html?testName=imaging-gaussian-blur) 22:27:40 INFO - PID 10385 | RSS: Main: 148430848 22:27:40 INFO - PID 10385 | 22:27:43 INFO - PID 10385 | Cycle 1(1): loaded http://localhost:48983/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:48983/tests/kraken/driver.html?testName=imaging-darkroom) 22:27:44 INFO - PID 10385 | RSS: Main: 148742144 22:27:44 INFO - PID 10385 | 22:27:47 INFO - PID 10385 | Cycle 1(1): loaded http://localhost:48983/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:48983/tests/kraken/driver.html?testName=imaging-desaturate) 22:27:48 INFO - PID 10385 | RSS: Main: 149397504 22:27:48 INFO - PID 10385 | 22:27:51 INFO - PID 10385 | Cycle 1(1): loaded http://localhost:48983/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:48983/tests/kraken/driver.html?testName=json-parse-financial) 22:27:51 INFO - PID 10385 | RSS: Main: 151601152 22:27:51 INFO - PID 10385 | 22:27:53 INFO - PID 10385 | Cycle 1(1): loaded http://localhost:48983/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:48983/tests/kraken/driver.html?testName=json-stringify-tinderbox) 22:27:53 INFO - PID 10385 | RSS: Main: 151695360 22:27:53 INFO - PID 10385 | 22:27:55 INFO - PID 10385 | Cycle 1(1): loaded http://localhost:48983/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:48983/tests/kraken/driver.html?testName=stanford-crypto-aes) 22:27:56 INFO - PID 10385 | RSS: Main: 151257088 22:27:56 INFO - PID 10385 | 22:27:58 INFO - PID 10385 | Cycle 1(1): loaded http://localhost:48983/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:48983/tests/kraken/driver.html?testName=stanford-crypto-ccm) 22:27:58 INFO - PID 10385 | RSS: Main: 147857408 22:27:58 INFO - PID 10385 | 22:28:01 INFO - PID 10385 | Cycle 1(1): loaded http://localhost:48983/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:48983/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 22:28:01 INFO - PID 10385 | RSS: Main: 148287488 22:28:01 INFO - PID 10385 | 22:28:04 INFO - PID 10385 | Cycle 1(1): loaded http://localhost:48983/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:48983/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 22:28:05 INFO - PID 10385 | RSS: Main: 148402176 22:28:05 INFO - PID 10385 | 22:28:06 INFO - PID 10385 | Cycle 1(1): loaded http://localhost:48983/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:48983/tests/kraken/driver.html?testName=ai-astar) 22:28:07 INFO - PID 10385 | RSS: Main: 150290432 22:28:07 INFO - PID 10385 | 22:28:07 INFO - PID 10385 | __start_tp_report 22:28:07 INFO - PID 10385 | _x_x_mozilla_page_load 22:28:07 INFO - PID 10385 | _x_x_mozilla_page_load_details 22:28:07 INFO - PID 10385 | |i|pagename|runs| 22:28:07 INFO - PID 10385 | |0;ai-astar;104;107;106;106;104;105;96;106;106;109 22:28:07 INFO - PID 10385 | |1;audio-beat-detection;116;113;112;111;111;112;111;138;113;114 22:28:07 INFO - PID 10385 | |2;audio-dft;163;161;163;162;162;162;162;163;162;163 22:28:07 INFO - PID 10385 | |3;audio-fft;74;75;72;73;74;73;74;74;87;79 22:28:07 INFO - PID 10385 | |4;audio-oscillator;80;78;78;78;79;78;79;79;78;77 22:28:07 INFO - PID 10385 | |5;imaging-gaussian-blur;114;113;114;113;113;117;114;115;114;115 22:28:07 INFO - PID 10385 | |6;imaging-darkroom;149;150;155;152;151;149;150;150;151;150 22:28:07 INFO - PID 10385 | |7;imaging-desaturate;94;95;94;94;94;94;94;95;95;94 22:28:07 INFO - PID 10385 | |8;json-parse-financial;44;45;44;45;44;48;49;44;44;44 22:28:07 INFO - PID 10385 | |9;json-stringify-tinderbox;37;36;36;38;36;36;37;36;37;36 22:28:07 INFO - PID 10385 | |10;stanford-crypto-aes;73;71;74;71;76;70;69;71;71;72 22:28:07 INFO - PID 10385 | |11;stanford-crypto-ccm;108;104;109;106;105;113;114;109;105;108 22:28:07 INFO - PID 10385 | |12;stanford-crypto-pbkdf2;163;162;156;151;152;152;160;155;156;160 22:28:07 INFO - PID 10385 | |13;stanford-crypto-sha256-iterative;60;62;71;63;63;62;62;61;61;63 22:28:07 INFO - PID 10385 | __end_tp_report 22:28:07 INFO - PID 10385 | __start_cc_report 22:28:07 INFO - PID 10385 | _x_x_mozilla_cycle_collect,679 22:28:07 INFO - PID 10385 | __end_cc_report 22:28:07 INFO - PID 10385 | __startTimestamp1506144487087__endTimestamp 22:28:07 INFO - PID 10385 | 22:28:07 INFO - PID 10385 | ------- Summary: start ------- 22:28:07 INFO - PID 10385 | Number of tests: 14 22:28:07 INFO - PID 10385 | 22:28:07 INFO - PID 10385 | [#0] ai-astar Cycles:10 Average:104.90 Median:106.00 stddev:3.45 (3.3%) stddev-sans-first:3.64 22:28:07 INFO - PID 10385 | Values: 104.0 107.0 106.0 106.0 104.0 105.0 96.0 106.0 106.0 109.0 22:28:07 INFO - PID 10385 | 22:28:07 INFO - PID 10385 | [#1] audio-beat-detection Cycles:10 Average:115.10 Median:113.00 stddev:8.20 (7.3%) stddev-sans-first:8.69 22:28:07 INFO - PID 10385 | Values: 116.0 113.0 112.0 111.0 111.0 112.0 111.0 138.0 113.0 114.0 22:28:07 INFO - PID 10385 | 22:28:07 INFO - PID 10385 | [#2] audio-dft Cycles:10 Average:162.30 Median:162.50 stddev:0.67 (0.4%) stddev-sans-first:0.67 22:28:07 INFO - PID 10385 | Values: 163.0 161.0 163.0 162.0 162.0 162.0 162.0 163.0 162.0 163.0 22:28:07 INFO - PID 10385 | 22:28:07 INFO - PID 10385 | [#3] audio-fft Cycles:10 Average:75.50 Median:74.00 stddev:4.45 (6.0%) stddev-sans-first:4.69 22:28:07 INFO - PID 10385 | Values: 74.0 75.0 72.0 73.0 74.0 73.0 74.0 74.0 87.0 79.0 22:28:07 INFO - PID 10385 | 22:28:07 INFO - PID 10385 | [#4] audio-oscillator Cycles:10 Average:78.40 Median:78.50 stddev:0.84 (1.1%) stddev-sans-first:0.67 22:28:07 INFO - PID 10385 | Values: 80.0 78.0 78.0 78.0 79.0 78.0 79.0 79.0 78.0 77.0 22:28:07 INFO - PID 10385 | 22:28:07 INFO - PID 10385 | [#5] imaging-gaussian-blur Cycles:10 Average:114.20 Median:114.00 stddev:1.23 (1.1%) stddev-sans-first:1.30 22:28:07 INFO - PID 10385 | Values: 114.0 113.0 114.0 113.0 113.0 117.0 114.0 115.0 114.0 115.0 22:28:07 INFO - PID 10385 | 22:28:07 INFO - PID 10385 | [#6] imaging-darkroom Cycles:10 Average:150.70 Median:150.50 stddev:1.77 (1.2%) stddev-sans-first:1.76 22:28:07 INFO - PID 10385 | Values: 149.0 150.0 155.0 152.0 151.0 149.0 150.0 150.0 151.0 150.0 22:28:07 INFO - PID 10385 | 22:28:07 INFO - PID 10385 | [#7] imaging-desaturate Cycles:10 Average:94.30 Median:94.00 stddev:0.48 (0.5%) stddev-sans-first:0.50 22:28:07 INFO - PID 10385 | Values: 94.0 95.0 94.0 94.0 94.0 94.0 94.0 95.0 95.0 94.0 22:28:07 INFO - PID 10385 | 22:28:07 INFO - PID 10385 | [#8] json-parse-financial Cycles:10 Average:45.10 Median:44.50 stddev:1.85 (4.2%) stddev-sans-first:1.92 22:28:07 INFO - PID 10385 | Values: 44.0 45.0 44.0 45.0 44.0 48.0 49.0 44.0 44.0 44.0 22:28:07 INFO - PID 10385 | 22:28:07 INFO - PID 10385 | [#9] json-stringify-tinderbox Cycles:10 Average:36.50 Median:36.50 stddev:0.71 (1.9%) stddev-sans-first:0.73 22:28:07 INFO - PID 10385 | Values: 37.0 36.0 36.0 38.0 36.0 36.0 37.0 36.0 37.0 36.0 22:28:07 INFO - PID 10385 | 22:28:07 INFO - PID 10385 | [#10] stanford-crypto-aes Cycles:10 Average:71.80 Median:71.50 stddev:2.04 (2.9%) stddev-sans-first:2.12 22:28:07 INFO - PID 10385 | Values: 73.0 71.0 74.0 71.0 76.0 70.0 69.0 71.0 71.0 72.0 22:28:07 INFO - PID 10385 | 22:28:07 INFO - PID 10385 | [#11] stanford-crypto-ccm Cycles:10 Average:108.10 Median:108.50 stddev:3.35 (3.1%) stddev-sans-first:3.55 22:28:07 INFO - PID 10385 | Values: 108.0 104.0 109.0 106.0 105.0 113.0 114.0 109.0 105.0 108.0 22:28:07 INFO - PID 10385 | 22:28:07 INFO - PID 10385 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:156.70 Median:158.00 stddev:4.35 (2.8%) stddev-sans-first:3.97 22:28:07 INFO - PID 10385 | Values: 163.0 162.0 156.0 151.0 152.0 152.0 160.0 155.0 156.0 160.0 22:28:07 INFO - PID 10385 | 22:28:07 INFO - PID 10385 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:62.80 Median:62.50 stddev:3.05 (4.9%) stddev-sans-first:3.06 22:28:07 INFO - PID 10385 | Values: 60.0 62.0 71.0 63.0 63.0 62.0 62.0 61.0 61.0 63.0 22:28:07 INFO - PID 10385 | -------- Summary: end -------- 22:28:07 INFO - PID 10385 | 22:28:07 INFO - PID 10385 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 22:28:07 INFO - TEST-INFO | 10385: exit 0 22:28:07 INFO - TEST-OK | kraken | took 58877ms 22:28:07 INFO - SUITE-END | took 1165s 22:28:08 INFO - Completed test suite (00:19:25) 22:28:08 INFO - javascript benchmark 22:28:08 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s", "stylo_disabled"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 9072.083016003533, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3835.4822099016624, 3852.614738526148, 3872.2061977294657, 3873.6320049595297, 3895.279373315935, 6217.28501222359, 6276.309605943343, 6362.745490180388, 6441.549091563593, 6451.161349024626, 6336.493080553568, 6388.073729309247, 6394.584352017116, 6415.518836087301, 6429.132067170931, 5695.34503532095, 5793.507551858097, 5799.0, 5811.27359080115, 5822.446867547597, 58.53373006194816, 5788.47903688668, 5842.561807864406, 5872.61827981182, 5875.148103524986, 5349.465053494639, 5697.886042279152, 5705.343885453184, 5804.187413762077, 5811.796587119452, 5695.401982791788, 5728.484436400702, 5785.016547186989, 5786.421357864222, 5795.246617939683, 5667.291588551431, 5703.087505999062, 5762.049261871786, 5772.480476757112, 5777.7977770777825, 6252.367565843256, 6344.111824344549, 6412.262589802186, 6415.743370265184, 6419.101325814389, 6627.701753421107, 6768.932310676929, 6846.075779769767, 6891.689873955684, 6969.9303006969785, 6803.081583986148, 7007.299270073003, 7060.611666358348, 7066.7173313067415, 7070.36366726997, 6366.840828979312, 6382.648954307511, 6473.643949582771, 6480.416762491352, 6512.218533775977, 7022.824429389306, 7180.640967951582, 7189.1013623297085, 7202.279772022755, 7205.819854503679, 6793.490488213404, 6824.351686589766, 6840.076589660432, 6887.449004079762, 6909.27452617478, 6780.796576102626, 6858.039874417585, 6892.379685828299, 6912.274211207851, 6984.615846128511, 6904.1024666794, 6905.998630198593, 6916.688749006306, 6965.82585435358, 6969.05917701114, 6838.179418469816, 6878.209005964278, 6971.407430368374, 6978.895316570255, 6990.405815505637, 5026.447090820006, 5050.545450909362, 5076.390833100052, 5108.335916330928, 5119.1553393690365, 4418.138462999685, 4512.435945506812, 4548.340490628906, 4561.794719237642, 4640.86077417678, 6307.621542707452, 6312.747490100436, 6382.266039405435, 6384.32964538726, 6395.2645445773405, 6732.7643532477105, 6804.353586409283, 6827.829304267433, 6898.413634840995, 6930.029795828588, 6260.780872669526, 6264.749410023639, 6282.465990390868, 6304.936950630527, 6309.873802523924, 5593.636413633101, 5618.494335509824, 5620.325560932714, 5628.634138780966, 5653.180288858175, 7147.070880785464, 7148.35664790161, 7226.783196504113, 7266.636668166676, 7283.70865165398, 6811.182658081062, 6893.241743408221, 6903.689333979883, 6907.0, 7001.474889383317, 7080.929190708233, 7148.213696493485, 7166.247544007804, 7167.892481612885, 7175.641217939186, 6794.048833163262, 6872.209695885037, 6925.3074692530345, 6935.6878940446795, 6953.582785032914, 6795.0, 6885.690143943635, 6888.070110535214, 6891.655417229219, 6957.7216911325, 6664.067030615621, 6750.797476075725, 6800.28596997328, 6801.761938332134, 6803.047573339637, 6694.59832410057, 6713.832154196184, 6766.458683305225, 6780.627065511247, 6790.151231096113, 6519.934800651933, 6621.33786621334, 6634.336566343327, 6651.401373876374, 6732.764353247613, 6745.561538499982, 6796.218434880052, 6805.727770889109, 6814.488913331421, 6826.8634627308165, 6556.606603603608, 6608.173978252718, 6634.436072933855, 6648.20221573395, 6649.501287403561], "value": 6272.266564289199, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [892.8482158033136, 953.0897992417242, 953.8950715421303, 999.3304485994383, 1004.3220825942497, 44425.55574444254, 45292.54707452925, 45384.546154538446, 45427.77286113573, 45476.726163691805, 40701.38947915776, 41197.7940110299, 41447.58552414475, 41646.16707665845, 41653.16693666125, 7668.578228197447, 7824.530528168328, 7859.371250299962, 7868.960655196716, 7875.251851074138, 7734.419918506106, 7828.590853646341, 7834.608269586526, 7851.254130857559, 7879.881801772949, 8412.453190542627, 8615.612297446598, 8618.052014278455, 8637.697680581181, 8660.047394786568, 8491.320694344438, 8565.95717021414, 8599.527026013568, 8602.0, 8603.010653774802, 7976.0827504836525, 8161.428699991003, 8202.425830191889, 8406.621702023362, 8559.27246184075, 40669.18661626751, 40974.180516389504, 40977.38533921994, 41037.384439233436, 41055.0, 3634.9273014539563, 3676.356637588438, 3693.833777479993, 3696.0, 3701.7038636908983, 33597.16007099818, 33850.0, 33872.322553548795, 33932.15169620755, 34056.48915266273, 5455.754491047913, 5500.3949565547755, 5514.979728750194, 5537.861553461195, 5544.695041772701, 214044.0, 214602.0, 214705.0, 215970.0, 216020.0, 54466.45533544614, 54610.45389546054, 54674.0, 54738.0, 54956.450435495135, 56707.43292567022, 56928.43071569314, 56974.715126424104, 56999.71500142473, 57101.428985710445, 16633.916830415772, 16960.915195423942, 16993.235304411082, 17022.233999470052, 17041.0, 13608.523701670592, 13616.591502254949, 13712.794308085387, 13722.794158087636, 13734.519291824738, 15466.149361784985, 15497.690046199014, 15623.218839058001, 15671.764923526156, 15678.9216053919, 6266.561340706106, 6282.4974002079725, 6291.7797877075, 6332.905006424908, 6372.107904893319, 1065.8347956066823, 1072.1155047086186, 1072.1529991306936, 1078.7680648660576, 1108.5621179634, 25288.494230115295, 25489.0, 25851.353716157246, 25894.611580826302, 25909.61135582968, 1175.670812172593, 1186.2467333243453, 1193.0813273779142, 1203.272020427646, 1210.9394530273628, 13315.600531984055, 13361.66595835112, 13452.394642241123, 13460.528881489101, 13770.0, 287880.0, 289337.0, 290013.0, 290140.0, 290190.0, 57891.131633025536, 58186.709066454394, 63203.6839815798, 64103.0, 64278.35721642817, 1474.7714104313634, 1487.851214878525, 1489.247929795468, 1515.8484151584973, 1525.1916484263359, 30411.69588304177, 30827.845860770554, 30946.381072378877, 30994.225144371572, 31056.689433106283, 40727.389089163094, 40753.38869917013, 40810.38784418296, 40875.7956210217, 40901.38647920224, 234533.0, 235323.0, 235516.0, 235909.0, 237131.0, 34561.827190863885, 35692.10769730777, 35731.0, 35737.28525429529, 35866.28267434584, 45843.541564583924, 46283.0, 47185.0, 47229.52770472251, 47314.0, 34405.311893761485, 34735.478967815, 34773.82613086919, 34903.65096349004, 35005.82497087498, 32733.0, 33885.32229355448, 33914.49128263029, 34075.65924340824, 34100.488492672135, 40153.79923100366, 40210.597894021856, 40646.1870762589, 40677.0, 40777.59222407738, 33240.33519329648, 33519.16202094967, 33933.49099763456, 33973.150671232426, 34195.658043419244, 24420.0, 25220.74779252184, 25227.369315767253, 25667.229983100537, 25880.741192587833], "value": 18758.68729459954, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [617.6788070203493, 623.4973713350826, 627.1126356205968, 627.2629660149323, 643.5913195121099, 22427.32718018458, 23464.530709385803, 24328.75671243287, 24370.878145609247, 24403.26790196297, 24694.50610987779, 25221.369465763364, 25278.115265965695, 25304.620430693554, 25317.11390101347, 6664.73341066358, 6787.796366109, 6802.965985170067, 6810.727570897183, 6852.554583952052, 6378.394052564999, 6652.900206496882, 6690.6654667266685, 6703.229128650194, 6708.698108585126, 6607.93392066078, 6631.237407698104, 6640.203175618933, 6665.6333901635635, 6684.565503242298, 6576.93423065768, 6578.144841170665, 6642.734290628369, 6648.301928297532, 6662.700178491979, 6171.259448866164, 6187.752489900398, 6188.659623720693, 6212.565120441571, 6222.315545290015, 28167.295817604518, 28888.0, 29750.0, 29931.551026734618, 29965.700342996508, 2167.371462275938, 2205.3383984804495, 2206.8344874134345, 2211.9889400553056, 2214.357836227492, 19942.102605382646, 20530.0, 20537.589248215103, 20551.691724624143, 20632.27787027447, 2362.2913126062112, 2482.391814005562, 2486.17956074495, 2499.262717498324, 2565.602331638599, 142897.0, 148465.0, 159483.0, 166427.0, 166955.16522417433, 15226.238688065552, 15769.763453548207, 15819.762703559456, 15849.603759906095, 16033.198340082949, 25417.0, 25660.0, 25661.075419343622, 25737.099201527857, 25812.48375032489, 10197.439140847177, 10277.691669249934, 10365.689029329133, 10535.0, 10611.363318200933, 9341.859872101924, 9387.812243755223, 9429.764255893657, 9430.245580353556, 9532.285078618992, 9406.811863762687, 9764.951175244078, 9836.78672298727, 9978.158409012582, 9987.700368988943, 2958.6153800005864, 2983.045425463874, 2987.357718090621, 2989.4170636726067, 2995.2062703383185, 1017.8829434614966, 1048.910842578374, 1050.3330385205297, 1053.7049626104704, 1060.734816295926, 20727.0, 21051.473713156985, 21058.262960796605, 21241.0, 21344.679829802564, 1067.055655744656, 1071.3411252079916, 1072.4208927179236, 1084.6366467233565, 1096.17786660005, 11466.254693445066, 11587.594434194763, 11601.0, 11667.6499705009, 11728.472218750177, 573572.0, 580643.0, 589877.0, 590199.0980090144, 591680.0, 130420.3478982599, 133030.33484832707, 133324.0, 134904.0, 136494.0, 1119.8992090711874, 1156.0520373293818, 1206.5113628980102, 1221.4564518789055, 1269.2765123879485, 22003.889980549993, 22462.213822516132, 22510.437239069153, 22628.321150365515, 22806.657900131842, 64922.0, 65381.0, 65726.0, 66167.33832661805, 67566.66216668885, 81152.59423702843, 81957.0, 82091.58954205191, 82347.5882620583, 82477.58761206156, 15069.924650377117, 15547.455839045579, 15612.609684757972, 15674.059556426651, 15702.607434814221, 23852.04591816308, 24319.756802431748, 24408.51182976366, 24659.136930208075, 24856.254312370656, 19002.23991040343, 19324.710129348354, 19662.508437289183, 19850.90074549618, 20020.49948751293, 17039.233234504725, 17336.0, 17725.113744312992, 17988.190531425855, 18191.727124092886, 19956.3015294464, 20027.098780554617, 20233.898830505754, 20381.49046273855, 20426.28508002272, 15257.0, 15258.694826103194, 15280.541583752505, 15375.154366509501, 15418.768718469008, 18750.156242968827, 18805.529861753566, 19281.325153620117, 19529.902350488155, 19644.705329420354], "value": 12773.180023584275, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1396.1553260277533, 1517.9316930738116, 1517.977230341545, 1518.5975716435153, 1519.6808670179275, 18287.634247315047, 18879.811201888013, 18891.811081889176, 18894.338698145566, 18909.62180756384, 18100.366487172952, 18227.72658410125, 18350.908245458755, 18365.265389384444, 18399.26402943884, 2830.775865871409, 2839.219214715949, 2879.9136025919256, 2881.8126821756623, 2884.697106803787, 2941.8970336038137, 2972.8364939928297, 2979.8808047678067, 2984.6418429788346, 2986.2832920099127, 2841.460122576714, 2868.254253893992, 2943.9852800735966, 2945.661248956376, 2950.129711735043, 2725.141580402167, 2726.6727992640913, 2755.0, 2755.435135797167, 2755.9035433759923, 2727.7408646178583, 2798.748112669849, 2809.7190280971945, 2822.153353993814, 2828.349479619699, 16930.238139283763, 17059.317627294895, 17066.48800535986, 17081.206473320246, 17114.31542738289, 8650.697225597074, 8809.119088091204, 8900.154485323885, 8912.24245939096, 8938.463692178426, 6206.472449841769, 6246.344133865924, 6325.272593651697, 6350.26971898233, 6351.396617321393, 2015.9617308959616, 2093.7906209379094, 2112.387407651779, 2131.6802479628027, 2170.5550362175873, 30895.0, 30981.8450907744, 31048.844755776077, 31054.689453105406, 31085.533716994265, 7421.703131874665, 7453.217412171643, 7510.474266801271, 7622.085349757954, 7669.463137580316, 19953.60092798136, 19971.700424493643, 19999.800001999793, 20045.298414555422, 20046.198152073754, 8475.533845638549, 8712.0, 8717.346199034972, 8724.0, 8737.169968852948, 7458.254174582498, 7572.4699271050495, 7576.545407275581, 7753.457257991887, 7870.212978702199, 5575.776968921197, 5666.263385759825, 5673.290838645169, 5728.914066289009, 5745.368009518949, 1639.8606118480063, 1653.0, 1664.083611508508, 1677.7064013797537, 1699.1419333236636, 952.7618095476131, 973.1873885305849, 974.6880998080688, 991.5240684471494, 1002.9348092373972, 8557.10150434208, 8606.0, 8661.566921653892, 9554.283428742872, 10062.144717699077, 711.1750369571273, 731.5427857589007, 732.2713899669862, 741.8182545276334, 743.5538676793989, 5269.499397557226, 5816.621919575298, 5846.912296315559, 5848.88302233953, 6019.277686677627, 22501.549969000527, 25397.746022539908, 25795.226143215732, 25835.74164258371, 25857.353566160997, 24355.878220608785, 24372.0, 24804.0, 24846.0, 25463.61804572933, 12118.39408029595, 12144.817827732591, 12409.937950310372, 12479.875201248053, 12538.81191782124, 9381.694982810857, 10173.338732982333, 10345.793084138124, 10361.896381036395, 10428.478576071318, 21732.45668858291, 21885.0, 22099.447513812283, 22114.77885221127, 22149.889250553642, 22288.888555557765, 22461.887690562096, 22661.773382265965, 22726.0, 22928.656070159293, 13723.931380343034, 13757.17456952586, 13995.720085598434, 14009.43962241499, 14012.929935350257, 15851.207439628202, 15884.205789710699, 16027.439039633557, 16044.839551604335, 16054.759178612563, 12904.935475322563, 12976.805347919977, 13112.147710398793, 13180.209187448783, 13322.200667959953, 12717.745645087232, 12720.87279127197, 12865.163764355288, 12898.419571119135, 13052.804207936699, 10645.680629581126, 10894.346339219672, 10896.673099807018, 10899.29154604948, 10917.344959302467, 8137.819682261275, 8186.058603260463, 8202.17978202175, 8291.792705182419, 8315.085340612648, 8727.301815854844, 8788.91211087881, 8791.340649451444, 8804.60379282921, 8893.421927574687], "value": 7445.294278981135, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [548.183207021538, 557.9302587176602, 565.0704590947894, 570.96859672718, 573.9913901291479, 6291.307956124829, 6293.874122517547, 6360.681965901704, 6379.681015949207, 6443.581167224127, 6242.219722534684, 6276.497880169587, 6279.497640188785, 6293.332266949251, 6309.4636955858805, 5047.722375269359, 5101.795928162887, 5170.405403378622, 5171.112543921479, 5193.091209038422, 4844.733539655317, 5058.2412638104215, 5103.540681338679, 5111.591072714174, 5169.6898186108765, 4973.477784832595, 4995.200767877141, 5025.874353141164, 5034.723090230036, 5052.0, 4934.185859333205, 4990.750462476898, 5008.173651347523, 5027.648064635477, 5038.496150384932, 4550.931736023962, 4560.0, 4561.129936725926, 4572.337011133401, 4573.0, 6274.529410294246, 6278.30938596754, 6285.9057114143325, 6292.080915320826, 6296.622202667854, 5923.733431995571, 5936.821895343147, 5954.8809023819285, 5969.26891201551, 5982.431668991482, 6499.805005849832, 6559.163434238373, 6659.9354200198095, 6668.5329227569855, 6754.142610782025, 4975.378077740283, 5055.115354812893, 5058.3929928408825, 5071.949280507185, 5078.162103252959, 6678.888816732684, 6834.214065382445, 6837.9059350503685, 6896.310368963113, 6918.446524278096, 5152.845414637492, 5196.688198708014, 5226.398964119175, 5233.267342572043, 5236.109861323508, 5302.602304827154, 5318.893622127536, 5319.973400132974, 5322.520973112361, 5333.253344531769, 5780.624259423124, 5854.560907931922, 5867.970660146672, 5902.6458412495385, 5906.911396329058, 6751.392374686302, 6764.425023873026, 6765.830854228585, 6779.5254332197255, 6782.626955517395, 1830.6704793137096, 1836.5867679771945, 1840.484664293973, 1844.3913508542148, 1847.9743742223195, 1254.5295514182183, 1289.509986205236, 1308.8102225177297, 1312.4094157628915, 1325.6619562011626, 6079.817605471843, 6124.356942520971, 6131.540134489931, 6192.907106393408, 6196.380361963767, 6683.298253683391, 6739.0, 6740.0, 6775.0, 6828.726850926007, 6058.091286307089, 6132.792194809865, 6193.81418557444, 6199.814005579749, 6233.937660623426, 3541.5927168375965, 3563.94654080189, 3583.498310236569, 3599.964000359963, 3615.186583018852, 6800.829979250559, 6807.727690892408, 6860.245373008965, 6897.482553838147, 7010.474214433836, 6801.4898882584, 6823.69293381799, 6894.758683446055, 6917.89623155653, 6982.1970473395195, 6939.6877140528795, 7043.597751405372, 7048.321637777714, 7052.294770522906, 7079.451397496897, 6783.660816959034, 6793.252742198255, 6825.795226143224, 6848.486363522856, 6873.965630171817, 6684.465242780663, 6732.697028633625, 6815.943528753051, 6816.113905192294, 6835.7949261522235, 6838.487113466411, 7000.159980802337, 7005.859882802417, 7023.438124949889, 7051.858962820612, 5671.688057156896, 5685.48830605231, 5724.398938111438, 5743.908657355089, 5790.131480277992, 6606.306337834651, 6692.933070669231, 6722.159730033746, 6772.39048485619, 6834.931650683429, 6530.987696906987, 6599.96700016516, 6603.900941485786, 6612.933870661232, 6638.53530252897, 6387.361263873576, 6563.967180164069, 6572.0, 6597.0, 6604.546999660067, 6387.5209359297305, 6401.231852177769, 6476.967615161894, 6501.414872661483, 6507.642079685663, 6574.309697481695, 6592.71442068792, 6607.669616519059, 6608.966955165386, 6680.9331906682255, 6370.745170193326, 6376.171097757448, 6423.4861211103935, 6441.742330306923, 6456.192975878015], "value": 5217.52748273943, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [944.2917811641269, 962.4802606592441, 981.0434826044608, 981.5239608789738, 982.047414008412, 17756.467305980826, 18118.184681689338, 18216.362427315045, 18233.814802037858, 18312.175952082154, 16748.83251167488, 17021.659566808656, 17141.228644710987, 17180.828191718112, 17246.0514671693, 969.6896992962237, 996.6412091647002, 997.8952210017952, 999.420336205003, 1001.1190152665644, 1052.0373857919994, 1053.146950969717, 1068.3322923173016, 1069.2408390043079, 1073.9624113156042, 1066.7706443114728, 1116.1238427834153, 1116.2799994003863, 1117.1677100560094, 1119.0711709281277, 1086.8478413022183, 1101.9944900275527, 1102.1458369763418, 1102.6636875752931, 1102.779444111173, 789.2659826361481, 800.5236884054037, 801.046754362307, 808.6603626476893, 813.259933460548, 18073.457796266, 18158.09209539518, 18183.090845457806, 18201.36295229674, 18223.45329640113, 22760.20339288117, 22870.428239293986, 23383.649245261335, 23503.882480587657, 23614.527709445716, 17282.395116171, 17398.826011739846, 17516.12419379026, 17606.471805845846, 17740.29038838445, 4032.4152997815445, 4060.9187816243807, 4086.0806318578084, 4088.9795551022053, 4089.795510224477, 160337.0, 160832.19583902005, 163160.18419907824, 163656.0, 164455.0, 15701.371945122295, 15874.52376428709, 15970.201489925457, 15996.76004859928, 16133.67732645364, 28217.012404565743, 28365.149045528666, 28374.432511349656, 28376.858115709703, 28478.430431391254, 9173.541322933826, 9210.539473026322, 9388.8591671125, 9426.340156189139, 9472.715818525456, 4155.168966206771, 4220.620144187038, 4248.129133527619, 4250.574942505725, 4260.318349064135, 5984.640921544721, 5986.970065149733, 6023.247094113236, 6082.695865206722, 6107.633541987495, 1095.1403148528368, 1100.1583788401879, 1115.8005144469566, 1116.5198964445367, 1124.3928278729559, 684.3088480634495, 691.6645426967916, 697.292248367907, 707.0278367245038, 708.2563308526027, 12427.627171184698, 12745.362731863555, 12746.235225886476, 13290.136141150795, 13372.465101395836, 734.0494060192065, 734.8640501507239, 735.8675438421136, 741.5143081281769, 749.4229443328607, 6287.528435367366, 6411.487081033506, 6435.066915297256, 6435.581687190318, 6528.053432252297, 147429.0, 147790.0, 148876.0, 151013.0, 152150.23924880306, 118358.0, 119560.0, 119888.0, 120897.0, 124648.0, 113635.43182284036, 114871.0, 115309.0, 115831.0, 119450.80549194397, 11993.940030299793, 12126.211796233216, 12193.268403895794, 12254.019678425882, 12257.877421225674, 56104.71947640236, 56223.0, 56310.7184464075, 57300.0, 58573.414265856794, 71366.64316678383, 72211.0, 72475.63762181155, 72494.27505725087, 73741.0, 16749.497515074567, 16830.747538786683, 16922.32310707558, 16925.069121198452, 17016.404425845038, 17131.91434042822, 17501.47495575135, 17566.648667026842, 17573.736393953845, 17619.64760704753, 17407.7388839165, 17712.645747084727, 17736.91131544334, 17840.3755868544, 17842.643147137245, 15110.093394396372, 15272.770908436605, 15387.923060385074, 15490.9225453872, 15624.453144139901, 17472.82527174712, 17479.563010924827, 17504.82495175032, 17520.649587007934, 17738.733918991482, 12934.805977910151, 13062.412191451598, 13065.477380904656, 13116.934415327862, 13446.596602101952, 12053.0, 12135.0, 12462.813057804322, 12963.740725185255, 13109.0], "value": 9548.67886910638, "unit": "score"}]}, {"extraOptions": ["e10s", "stylo_disabled"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1376.4, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [104.0, 107.0, 106.0, 106.0, 104.0, 105.0, 96.0, 106.0, 106.0, 109.0], "value": 104.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 113.0, 112.0, 111.0, 111.0, 112.0, 111.0, 138.0, 113.0, 114.0], "value": 115.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 161.0, 163.0, 162.0, 162.0, 162.0, 162.0, 163.0, 162.0, 163.0], "value": 162.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 75.0, 72.0, 73.0, 74.0, 73.0, 74.0, 74.0, 87.0, 79.0], "value": 75.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 78.0, 78.0, 78.0, 79.0, 78.0, 79.0, 79.0, 78.0, 77.0], "value": 78.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 113.0, 114.0, 113.0, 113.0, 117.0, 114.0, 115.0, 114.0, 115.0], "value": 114.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 150.0, 155.0, 152.0, 151.0, 149.0, 150.0, 150.0, 151.0, 150.0], "value": 150.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 94.0, 94.0, 94.0, 94.0, 94.0, 95.0, 95.0, 94.0], "value": 94.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [44.0, 45.0, 44.0, 45.0, 44.0, 48.0, 49.0, 44.0, 44.0, 44.0], "value": 45.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [37.0, 36.0, 36.0, 38.0, 36.0, 36.0, 37.0, 36.0, 37.0, 36.0], "value": 36.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 71.0, 74.0, 71.0, 76.0, 70.0, 69.0, 71.0, 71.0, 72.0], "value": 71.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [108.0, 104.0, 109.0, 106.0, 105.0, 113.0, 114.0, 109.0, 105.0, 108.0], "value": 108.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 162.0, 156.0, 151.0, 152.0, 152.0, 160.0, 155.0, 156.0, 160.0], "value": 156.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 62.0, 71.0, 63.0, 63.0, 62.0, 62.0, 61.0, 61.0, 63.0], "value": 62.8, "unit": "score"}]}]} 22:28:08 INFO - Return code: 0 22:28:08 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 22:28:08 INFO - # TBPL SUCCESS # 22:28:08 INFO - Running post-action listener: _package_coverage_data 22:28:08 INFO - Running post-action listener: _resource_record_post_action 22:28:08 INFO - [mozharness: 2017-09-23 05:28:08.342344Z] Finished run-tests step (success) 22:28:08 INFO - Running post-run listener: _resource_record_post_run 22:28:08 INFO - Total resource usage - Wall time: 1184s; CPU: 13.0%; Read bytes: 53248; Write bytes: 389226496; Read time: 344; Write time: 204888 22:28:08 INFO - TinderboxPrint: CPU usage
13.1% 22:28:08 INFO - TinderboxPrint: I/O read bytes / time
53,248 / 344 22:28:08 INFO - TinderboxPrint: I/O write bytes / time
389,226,496 / 204,888 22:28:08 INFO - TinderboxPrint: CPU idle
8,206.5 (86.9%) 22:28:08 INFO - TinderboxPrint: CPU user
1,187.3 (12.6%) 22:28:08 INFO - TinderboxPrint: Swap in / out
0 / 0 22:28:08 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 75251712; Read time: 0; Write time: 36684 22:28:08 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 22:28:08 INFO - run-tests - Wall time: 1166s; CPU: 13.0%; Read bytes: 53248; Write bytes: 313974784; Read time: 344; Write time: 168204 22:28:08 INFO - Running post-run listener: _upload_blobber_files 22:28:08 INFO - Blob upload gear active. 22:28:08 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 22:28:08 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 22:28:08 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', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 22:28:08 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 -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 22:28:09 INFO - (blobuploader) - INFO - Open directory for files ... 22:28:09 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_errorsummary.log ... 22:28:09 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:28:09 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:28:10 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-stylo-disabled-e10s_errorsummary.log: uploaded 22:28:10 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:28:10 INFO - (blobuploader) - INFO - Done attempting. 22:28:10 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 22:28:10 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:28:10 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:28:11 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 22:28:11 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:28:11 INFO - (blobuploader) - INFO - Done attempting. 22:28:11 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 22:28:11 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:28:11 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:28:14 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 22:28:14 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:28:14 INFO - (blobuploader) - INFO - Done attempting. 22:28:14 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_raw.log ... 22:28:14 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:28:14 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:28:15 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-stylo-disabled-e10s_raw.log: uploaded 22:28:15 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:28:15 INFO - (blobuploader) - INFO - Done attempting. 22:28:15 INFO - (blobuploader) - INFO - Iteration through files over. 22:28:15 INFO - Return code: 0 22:28:15 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 22:28:15 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 22:28:15 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e988c5109ca5a4cd55533b76e127c79a62df7d643f7a59ead927f08748ac2ef12fb3df755886a5d081b1741cca713ace8e6453620ff433cb390cefc76a382452", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1ffcf3e3e9017fe78d2c519fd0c6791ea02bb07b33b67e1c2d8dbeb138bec62d04a7466a441af3effcb10abdbd3b0f974cf31a613923e05d0362ff35d74d1a1f", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/655a4da2c25fc26eb270226d646eb7fd9b06739b787ba12c5c8e538e98b30af0c270d2b41f4d66ce822bb2ed474360bfa09e78d67c4c4f2e2760fd261195b0f7", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/961ac6b6e2ddb23e0e6ef96d372c46e0a8623fd7ebfb97a064409f13287faf65e430fd7aa4a62b86f04838013fab8ef844087c2e66a7b35ace9598ee37d136f2"} 22:28:15 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 22:28:15 INFO - Writing to file /builds/slave/test/properties/blobber_files 22:28:15 INFO - Contents: 22:28:15 INFO - blobber_files:{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e988c5109ca5a4cd55533b76e127c79a62df7d643f7a59ead927f08748ac2ef12fb3df755886a5d081b1741cca713ace8e6453620ff433cb390cefc76a382452", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1ffcf3e3e9017fe78d2c519fd0c6791ea02bb07b33b67e1c2d8dbeb138bec62d04a7466a441af3effcb10abdbd3b0f974cf31a613923e05d0362ff35d74d1a1f", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/655a4da2c25fc26eb270226d646eb7fd9b06739b787ba12c5c8e538e98b30af0c270d2b41f4d66ce822bb2ed474360bfa09e78d67c4c4f2e2760fd261195b0f7", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/961ac6b6e2ddb23e0e6ef96d372c46e0a8623fd7ebfb97a064409f13287faf65e430fd7aa4a62b86f04838013fab8ef844087c2e66a7b35ace9598ee37d136f2"} 22:28:15 INFO - Running post-run listener: copy_logs_to_upload_dir 22:28:15 INFO - Copying logs to upload dir... 22:28:15 INFO - mkdir: /builds/slave/test/build/upload/logs 22:28:15 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1233.346097 ========= master_lag: 0.06 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 33 secs) (at 2017-09-22 22:28:15.831172) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-22 22:28:15.836185) ========= 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=e0e61f6f900f4dc42e3e8956000001ad-1506142770.322045-1208929790 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/sha512/e988c5109ca5a4cd55533b76e127c79a62df7d643f7a59ead927f08748ac2ef12fb3df755886a5d081b1741cca713ace8e6453620ff433cb390cefc76a382452", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1ffcf3e3e9017fe78d2c519fd0c6791ea02bb07b33b67e1c2d8dbeb138bec62d04a7466a441af3effcb10abdbd3b0f974cf31a613923e05d0362ff35d74d1a1f", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/655a4da2c25fc26eb270226d646eb7fd9b06739b787ba12c5c8e538e98b30af0c270d2b41f4d66ce822bb2ed474360bfa09e78d67c4c4f2e2760fd261195b0f7", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/961ac6b6e2ddb23e0e6ef96d372c46e0a8623fd7ebfb97a064409f13287faf65e430fd7aa4a62b86f04838013fab8ef844087c2e66a7b35ace9598ee37d136f2"} build_url:https://queue.taskcluster.net/v1/task/JtWjNlDyQMG39ykVhnRwEg/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011368 build_url: 'https://queue.taskcluster.net/v1/task/JtWjNlDyQMG39ykVhnRwEg/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e988c5109ca5a4cd55533b76e127c79a62df7d643f7a59ead927f08748ac2ef12fb3df755886a5d081b1741cca713ace8e6453620ff433cb390cefc76a382452", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1ffcf3e3e9017fe78d2c519fd0c6791ea02bb07b33b67e1c2d8dbeb138bec62d04a7466a441af3effcb10abdbd3b0f974cf31a613923e05d0362ff35d74d1a1f", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/655a4da2c25fc26eb270226d646eb7fd9b06739b787ba12c5c8e538e98b30af0c270d2b41f4d66ce822bb2ed474360bfa09e78d67c4c4f2e2760fd261195b0f7", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/961ac6b6e2ddb23e0e6ef96d372c46e0a8623fd7ebfb97a064409f13287faf65e430fd7aa4a62b86f04838013fab8ef844087c2e66a7b35ace9598ee37d136f2"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-22 22:28:15.867923) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-22 22:28:15.868284) ========= 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=e0e61f6f900f4dc42e3e8956000001ad-1506142770.322045-1208929790 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004530 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-22 22:28:15.950480) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-22 22:28:15.950803) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-22 22:28:15.951143) ========= ========= Total master_lag: 0.23 =========