builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-069 starttime: 1505686766.51 results: success (0) revision: dd87b8587fc1d63e57ebdadcbabba89c6d172969 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-09-17 15:19:26.505498) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-09-17 15:19:26.505940) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-17 15:19:26.506213) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-17 15:19:26.809669) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-17 15:19:26.809939) ========= 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=05b19d94dfa9f3ce7b6e62cc000001f7-1505686321.954831-1980373633 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-09-17 15:19:27-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 111M=0s 2017-09-17 15:19:27 (111 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.088635 ========= master_lag: 0.10 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-17 15:19:26.999073) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-17 15:19:26.999361) ========= 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=05b19d94dfa9f3ce7b6e62cc000001f7-1505686321.954831-1980373633 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.021376 ========= master_lag: 0.09 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-17 15:19:27.106996) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 12 secs) (at 2017-09-17 15:19:27.107321) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev dd87b8587fc1d63e57ebdadcbabba89c6d172969 --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 dd87b8587fc1d63e57ebdadcbabba89c6d172969 --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=05b19d94dfa9f3ce7b6e62cc000001f7-1505686321.954831-1980373633 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-09-17 15:19:27,322 truncating revision to first 12 chars 2017-09-17 15:19:27,322 Setting DEBUG logging. 2017-09-17 15:19:27,322 attempt 1/10 2017-09-17 15:19:27,323 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/dd87b8587fc1?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-09-17 15:19:28,732 attempt 1/10 2017-09-17 15:19:29,544 current task status: no status available at this point. state: STARTED 2017-09-17 15:19:29,545 sleeping for 9.00s (attempt 1/10) 2017-09-17 15:19:38,554 attempt 2/10 2017-09-17 15:19:38,886 current task status: Task completed! Check 's3_urls' for upload locations. state: SUCCESS 2017-09-17 15:19:39,068 unpacking tar archive at: mozilla-central-dd87b8587fc1/testing/mozharness/ program finished with exit code 0 elapsedTime=12.017361 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 12 secs) (at 2017-09-17 15:19:39.152390) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-17 15:19:39.152709) ========= script_repo_revision: dd87b8587fc1d63e57ebdadcbabba89c6d172969 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-17 15:19:39.153079) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-17 15:19:39.153343) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-17 15:19:39.169961) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 40 secs) (at 2017-09-17 15:19:39.170323) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=05b19d94dfa9f3ce7b6e62cc000001f7-1505686321.954831-1980373633 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 15:19:39 INFO - MultiFileLogger online at 20170917 15:19:39 in /builds/slave/test 15:19:39 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 15:19:39 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 15:19:39 INFO - {'append_to_log': False, 15:19:39 INFO - 'base_work_dir': '/builds/slave/test', 15:19:39 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 15:19:39 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 15:19:39 INFO - 'branch': 'Firefox-Non-PGO', 15:19:39 INFO - 'buildbot_json_path': 'buildprops.json', 15:19:39 INFO - 'code_coverage': False, 15:19:39 INFO - 'config_files': ('talos/linux_config.py',), 15:19:39 INFO - 'default_actions': ('clobber', 15:19:39 INFO - 'read-buildbot-config', 15:19:39 INFO - 'download-and-extract', 15:19:39 INFO - 'populate-webroot', 15:19:39 INFO - 'create-virtualenv', 15:19:39 INFO - 'install', 15:19:39 INFO - 'setup-mitmproxy', 15:19:39 INFO - 'run-tests'), 15:19:39 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 15:19:39 INFO - 'disable_ccov_upload': False, 15:19:39 INFO - 'disable_stylo': False, 15:19:39 INFO - 'download_minidump_stackwalk': True, 15:19:39 INFO - 'download_symbols': 'ondemand', 15:19:39 INFO - 'enable_stylo': False, 15:19:39 INFO - 'enable_webrender': False, 15:19:39 INFO - 'exes': {'tooltool.py': '/tools/tooltool.py'}, 15:19:39 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 15:19:39 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 15:19:39 INFO - 'gecko_profile': False, 15:19:39 INFO - 'gecko_profile_interval': 0, 15:19:39 INFO - 'installer_path': 'installer.exe', 15:19:39 INFO - 'log_level': 'info', 15:19:39 INFO - 'log_name': 'talos', 15:19:39 INFO - 'log_to_console': True, 15:19:39 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 15:19:39 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 15:19:39 INFO - 'opt_config_files': (), 15:19:39 INFO - 'pip_index': False, 15:19:39 INFO - 'suite': 'dromaeojs-e10s', 15:19:39 INFO - 'system_bits': '32', 15:19:39 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 15:19:39 INFO - 'title': 'talos-linux64-ix-069', 15:19:39 INFO - 'tooltool_cache': '/builds/tooltool_cache', 15:19:39 INFO - 'use_talos_json': True, 15:19:39 INFO - 'verify': 'False', 15:19:39 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 15:19:39 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 15:19:39 INFO - 'work_dir': 'build'} 15:19:39 INFO - [mozharness: 2017-09-17 22:19:39.511112Z] Running clobber step. 15:19:39 INFO - Running pre-action listener: _resource_record_pre_action 15:19:39 INFO - Running main action method: clobber 15:19:39 INFO - rmtree: /builds/slave/test/build 15:19:39 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 15:19:40 INFO - Running post-action listener: _resource_record_post_action 15:19:40 INFO - [mozharness: 2017-09-17 22:19:40.495383Z] Finished clobber step (success) 15:19:40 INFO - [mozharness: 2017-09-17 22:19:40.495480Z] Running read-buildbot-config step. 15:19:40 INFO - Running pre-action listener: _resource_record_pre_action 15:19:40 INFO - Running main action method: read_buildbot_config 15:19:40 INFO - Using buildbot properties: 15:19:40 INFO - { 15:19:40 INFO - "project": "", 15:19:40 INFO - "product": "firefox", 15:19:40 INFO - "who": "archaeopteryx@coole-files.de", 15:19:40 INFO - "installer_path": "public/build/target.tar.bz2", 15:19:40 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 15:19:40 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 15:19:40 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-e10s", 15:19:40 INFO - "stage_platform": "linux64", 15:19:40 INFO - "basedir": "/builds/slave/test", 15:19:40 INFO - "buildnumber": 842, 15:19:40 INFO - "platform": "ubuntu64_hw", 15:19:40 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 15:19:40 INFO - "slavebuilddir": "test", 15:19:40 INFO - "taskId": "CZvljFoLQkmGOSwhFZfFNQ", 15:19:40 INFO - "branch": "mozilla-central", 15:19:40 INFO - "script_repo_revision": "production", 15:19:40 INFO - "revision": "dd87b8587fc1d63e57ebdadcbabba89c6d172969", 15:19:40 INFO - "slavename": "talos-linux64-ix-069", 15:19:40 INFO - "repo_path": "mozilla-central" 15:19:40 INFO - } 15:19:40 INFO - Finding installer, test and symbols from parent task. 15:19:40 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/CZvljFoLQkmGOSwhFZfFNQ'}, attempt #1 15:19:40 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/CZvljFoLQkmGOSwhFZfFNQ'}, attempt #1 15:19:41 INFO - Task dependencies: Mt_FquQNTb2zZxQoyb7pNg 15:19:41 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Mt_FquQNTb2zZxQoyb7pNg'}, attempt #1 15:19:41 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/Mt_FquQNTb2zZxQoyb7pNg/artifacts/public/build/target.tar.bz2 15:19:41 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/Mt_FquQNTb2zZxQoyb7pNg/artifacts/public/build/target.test_packages.json 15:19:41 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/Mt_FquQNTb2zZxQoyb7pNg/artifacts/public/build/target.crashreporter-symbols.zip 15:19:41 INFO - Running post-action listener: _resource_record_post_action 15:19:41 INFO - [mozharness: 2017-09-17 22:19:41.904669Z] Finished read-buildbot-config step (success) 15:19:41 INFO - [mozharness: 2017-09-17 22:19:41.904886Z] Running download-and-extract step. 15:19:41 INFO - Running pre-action listener: _resource_record_pre_action 15:19:41 INFO - Running main action method: download_and_extract 15:19:41 INFO - mkdir: /builds/slave/test/build/tests 15:19: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')]} 15:19:41 INFO - trying https://queue.taskcluster.net/v1/task/Mt_FquQNTb2zZxQoyb7pNg/artifacts/public/build/target.test_packages.json 15:19:41 INFO - Downloading https://queue.taskcluster.net/v1/task/Mt_FquQNTb2zZxQoyb7pNg/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 15:19:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Mt_FquQNTb2zZxQoyb7pNg/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 15:19:42 INFO - Downloaded 989 bytes. 15:19:42 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 15:19:42 INFO - Using the following test package requirements: 15:19:42 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 15:19:42 INFO - u'common': [u'target.common.tests.zip'], 15:19:42 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 15:19:42 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 15:19:42 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 15:19:42 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 15:19:42 INFO - u'mozbase': [u'target.common.tests.zip'], 15:19:42 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 15:19:42 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 15:19:42 INFO - u'web-platform': [u'target.common.tests.zip', 15:19:42 INFO - u'target.web-platform.tests.tar.gz'], 15:19:42 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 15:19:42 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite categories: ['common', 'talos'] 15:19:42 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Mt_FquQNTb2zZxQoyb7pNg/artifacts/public/build/target.common.tests.zip 15:19:42 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Mt_FquQNTb2zZxQoyb7pNg/artifacts/public/build/target.common.tests.zip'}, attempt #1 15:19:42 INFO - Fetch https://queue.taskcluster.net/v1/task/Mt_FquQNTb2zZxQoyb7pNg/artifacts/public/build/target.common.tests.zip into memory 15:19:43 INFO - Content-Length response header: 54731175 15:19:43 INFO - Bytes received: 54731175 15:19:54 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Mt_FquQNTb2zZxQoyb7pNg/artifacts/public/build/target.talos.tests.zip 15:19:54 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Mt_FquQNTb2zZxQoyb7pNg/artifacts/public/build/target.talos.tests.zip'}, attempt #1 15:19:54 INFO - Fetch https://queue.taskcluster.net/v1/task/Mt_FquQNTb2zZxQoyb7pNg/artifacts/public/build/target.talos.tests.zip into memory 15:19:55 INFO - Content-Length response header: 14508748 15:19:55 INFO - Bytes received: 14508748 15:19:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:19:55 INFO - trying https://queue.taskcluster.net/v1/task/Mt_FquQNTb2zZxQoyb7pNg/artifacts/public/build/target.tar.bz2 15:19:55 INFO - Downloading https://queue.taskcluster.net/v1/task/Mt_FquQNTb2zZxQoyb7pNg/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 15:19:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Mt_FquQNTb2zZxQoyb7pNg/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 15:19:57 INFO - Downloaded 61556082 bytes. 15:19:57 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Mt_FquQNTb2zZxQoyb7pNg/artifacts/public/build/target.tar.bz2 15:19:57 INFO - mkdir: /builds/slave/test/properties 15:19:57 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 15:19:57 INFO - Writing to file /builds/slave/test/properties/build_url 15:19:57 INFO - Contents: 15:19:57 INFO - build_url:https://queue.taskcluster.net/v1/task/Mt_FquQNTb2zZxQoyb7pNg/artifacts/public/build/target.tar.bz2 15:19:57 INFO - Running post-action listener: _resource_record_post_action 15:19:57 INFO - Running post-action listener: find_tests_for_verification 15:19:57 INFO - Running post-action listener: set_extra_try_arguments 15:19:57 INFO - [mozharness: 2017-09-17 22:19:57.173499Z] Finished download-and-extract step (success) 15:19:57 INFO - [mozharness: 2017-09-17 22:19:57.173597Z] Running populate-webroot step. 15:19:57 INFO - Running pre-action listener: _resource_record_pre_action 15:19:57 INFO - Running main action method: populate_webroot 15:19:57 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 15:19:57 INFO - 'chromez-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 15:19:57 INFO - 'tests': ['tresize', 15:19:57 INFO - 'tcanvasmark']}, 15:19:57 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 15:19:57 INFO - 'dromaeojs-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 15:19:57 INFO - 'tests': ['dromaeo_css', 15:19:57 INFO - 'kraken']}, 15:19:57 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 15:19:57 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:19:57 INFO - 'g1-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 15:19:57 INFO - 'talos_options': ['--disable-stylo'], 15:19:57 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:19:57 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 15:19:57 INFO - 'tests': ['damp', 'tps']}, 15:19:57 INFO - 'g2-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 15:19:57 INFO - 'talos_options': ['--disable-stylo'], 15:19:57 INFO - 'tests': ['damp', 'tps']}, 15:19:57 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 15:19:57 INFO - 'g3-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 15:19:57 INFO - 'tests': ['dromaeo_dom']}, 15:19:57 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 15:19:57 INFO - 'g4-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 15:19:57 INFO - 'tests': ['basic_compositor_video', 15:19:57 INFO - 'glvideo']}, 15:19:57 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 15:19:57 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 15:19:57 INFO - 'g5-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 15:19:57 INFO - 'talos_options': ['--disable-stylo'], 15:19:57 INFO - 'tests': ['ts_paint_webext', 15:19:57 INFO - 'tp5o_webext']}, 15:19:57 INFO - 'other-e10s': {'tests': ['a11yr', 15:19:57 INFO - 'ts_paint', 15:19:57 INFO - 'tpaint', 15:19:57 INFO - 'sessionrestore', 15:19:57 INFO - 'sessionrestore_many_windows', 15:19:57 INFO - 'sessionrestore_no_auto_restore', 15:19:57 INFO - 'tabpaint']}, 15:19:57 INFO - 'other-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 15:19:57 INFO - 'tests': ['a11yr', 15:19:57 INFO - 'ts_paint', 15:19:57 INFO - 'tpaint', 15:19:57 INFO - 'sessionrestore', 15:19:57 INFO - 'sessionrestore_many_windows', 15:19:57 INFO - 'sessionrestore_no_auto_restore', 15:19:57 INFO - 'tabpaint']}, 15:19:57 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 15:19:57 INFO - 'perf-reftest-singletons-e10s': {'tests': ['perf_reftest_singletons']}, 15:19:57 INFO - 'perf-reftest-singletons-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 15:19:57 INFO - 'tests': ['perf_reftest_singletons']}, 15:19:57 INFO - 'perf-reftest-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 15:19:57 INFO - 'tests': ['bloom_basic']}, 15:19:57 INFO - 'svgr-e10s': {'tests': ['tsvgx', 15:19:57 INFO - 'tsvgr_opacity', 15:19:57 INFO - 'tart', 15:19:57 INFO - 'tscrollx', 15:19:57 INFO - 'tsvg_static']}, 15:19:57 INFO - 'svgr-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 15:19:57 INFO - 'tests': ['tsvgx', 15:19:57 INFO - 'tsvgr_opacity', 15:19:57 INFO - 'tart', 15:19:57 INFO - 'tscrollx', 15:19:57 INFO - 'tsvg_static']}, 15:19:57 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 15:19:57 INFO - 'tp5o-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 15:19:57 INFO - 'talos_options': ['--disable-stylo'], 15:19:57 INFO - 'tests': ['tp5o']}, 15:19:57 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 15:19:57 INFO - 'talos_options': ['--mitmproxy', 15:19:57 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 15:19:57 INFO - '--firstNonBlankPaint'], 15:19:57 INFO - 'tests': ['tp6_google', 15:19:57 INFO - 'tp6_youtube', 15:19:57 INFO - 'tp6_amazon', 15:19:57 INFO - 'tp6_facebook']}, 15:19:57 INFO - 'tp6-stylo-disabled-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 15:19:57 INFO - 'talos_options': ['--disable-stylo', 15:19:57 INFO - '--mitmproxy', 15:19:57 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 15:19:57 INFO - '--firstNonBlankPaint'], 15:19:57 INFO - 'tests': ['tp6_google', 15:19:57 INFO - 'tp6_youtube', 15:19:57 INFO - 'tp6_amazon', 15:19:57 INFO - 'tp6_facebook']}, 15:19:57 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 15:19:57 INFO - 'talos_options': ['--stylo-threads=1', 15:19:57 INFO - '--mitmproxy', 15:19:57 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 15:19:57 INFO - '--firstNonBlankPaint'], 15:19:57 INFO - 'tests': ['tp6_google', 15:19:57 INFO - 'tp6_youtube', 15:19:57 INFO - 'tp6_amazon', 15:19:57 INFO - 'tp6_facebook']}, 15:19:57 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 15:19:57 INFO - 'talos_options': ['--xperf_path', 15:19:57 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:19:57 INFO - 'tests': ['tp5n']}, 15:19:57 INFO - 'xperf-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 15:19:57 INFO - 'talos_options': ['--disable-stylo', 15:19:57 INFO - '--xperf_path', 15:19:57 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:19:57 INFO - 'tests': ['tp5n']}}} 15:19:57 INFO - Running post-action listener: _resource_record_post_action 15:19:57 INFO - [mozharness: 2017-09-17 22:19:57.188598Z] Finished populate-webroot step (success) 15:19:57 INFO - [mozharness: 2017-09-17 22:19:57.188699Z] Running create-virtualenv step. 15:19:57 INFO - Running pre-action listener: _resource_record_pre_action 15:19:57 INFO - Running main action method: create_virtualenv 15:19:57 INFO - Creating virtualenv /builds/slave/test/build/venv 15:19:57 INFO - Running command: ['virtualenv', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 15:19:57 INFO - Copy/paste: virtualenv --no-site-packages --distribute /builds/slave/test/build/venv 15:19:57 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 15:19:57 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 15:19:57 INFO - New python executable in /builds/slave/test/build/venv/bin/python 15:19:58 INFO - Installing distribute.............................................................................................................................................................................................done. 15:20:00 INFO - Installing pip...............done. 15:20:00 INFO - Return code: 0 15:20:00 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 15:20:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 15:20:00 INFO - Reading from file tmpfile_stdout 15:20:00 INFO - Output received: 15:20:00 INFO - pip 1.1 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.1-py2.7.egg (python 2.7) 15:20:00 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 15:20:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:20:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:20:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:20:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:20:00 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 0x13f21f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15bba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x175ea60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1762090>, '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 0x1762d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x175cf90>, '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': '05b19d94dfa9f3ce7b6e62cc000001f7-1505686321.954831-1980373633', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:20:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 15:20:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 15:20:00 INFO - Using env: {'DISPLAY': ':0', 15:20:00 INFO - 'HOME': '/home/cltbld', 15:20:00 INFO - 'LANG': 'en_US.UTF-8', 15:20:00 INFO - 'LANGUAGE': 'en_US:en', 15:20:00 INFO - 'LOGNAME': 'cltbld', 15:20:00 INFO - 'MAIL': '/var/mail/cltbld', 15:20:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:20:00 INFO - 'MOZ_NO_REMOTE': '1', 15:20:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:20:00 INFO - 'NO_EM_RESTART': '1', 15:20:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:20:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:20:00 INFO - 'PWD': '/builds/slave/test', 15:20:00 INFO - 'SHELL': '/bin/bash', 15:20:00 INFO - 'SHLVL': '1', 15:20:00 INFO - 'TERM': 'linux', 15:20:00 INFO - 'TMOUT': '86400', 15:20:00 INFO - 'USER': 'cltbld', 15:20:00 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1505686321.954831-1980373633', 15:20:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:20:00 INFO - '_': '/tools/buildbot/bin/python'} 15:20:02 INFO - Ignoring indexes: http://pypi.python.org/simple/ 15:20:02 INFO - Downloading/unpacking pip>=1.5 15:20:02 INFO - Running setup.py egg_info for package pip 15:20:02 INFO - warning: no files found matching 'pip/cacert.pem' 15:20:02 INFO - warning: no files found matching '*.html' under directory 'docs' 15:20:02 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 15:20:02 INFO - no previously-included directories found matching 'docs/_build/_sources' 15:20:02 INFO - Installing collected packages: pip 15:20:02 INFO - Found existing installation: pip 1.1 15:20:02 INFO - Uninstalling pip: 15:20:02 INFO - Successfully uninstalled pip 15:20:02 INFO - Running setup.py install for pip 15:20:02 INFO - warning: no files found matching 'pip/cacert.pem' 15:20:02 INFO - warning: no files found matching '*.html' under directory 'docs' 15:20:02 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 15:20:02 INFO - no previously-included directories found matching 'docs/_build/_sources' 15:20:02 INFO - Installing pip script to /builds/slave/test/build/venv/bin 15:20:02 INFO - Installing pip2.7 script to /builds/slave/test/build/venv/bin 15:20:02 INFO - Installing pip2 script to /builds/slave/test/build/venv/bin 15:20:02 INFO - Successfully installed pip 15:20:02 INFO - Cleaning up... 15:20:02 INFO - Return code: 0 15:20:02 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 15:20:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:20:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:20:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:20:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:20:02 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x13f21f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15bba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x175ea60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1762090>, '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 0x1762d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x175cf90>, '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': '05b19d94dfa9f3ce7b6e62cc000001f7-1505686321.954831-1980373633', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:20:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 15:20:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 15:20:02 INFO - Using env: {'DISPLAY': ':0', 15:20:02 INFO - 'HOME': '/home/cltbld', 15:20:02 INFO - 'LANG': 'en_US.UTF-8', 15:20:02 INFO - 'LANGUAGE': 'en_US:en', 15:20:02 INFO - 'LOGNAME': 'cltbld', 15:20:02 INFO - 'MAIL': '/var/mail/cltbld', 15:20:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:20:02 INFO - 'MOZ_NO_REMOTE': '1', 15:20:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:20:02 INFO - 'NO_EM_RESTART': '1', 15:20:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:20:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:20:02 INFO - 'PWD': '/builds/slave/test', 15:20:02 INFO - 'SHELL': '/bin/bash', 15:20:02 INFO - 'SHLVL': '1', 15:20:02 INFO - 'TERM': 'linux', 15:20:02 INFO - 'TMOUT': '86400', 15:20:02 INFO - 'USER': 'cltbld', 15:20:02 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1505686321.954831-1980373633', 15:20:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:20:02 INFO - '_': '/tools/buildbot/bin/python'} 15:20:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:20:02 INFO - Downloading/unpacking psutil>=3.1.1 15:20:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:20:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:20:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:20:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:20:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 15:20:03 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:20:03 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:20:03 INFO - Installing collected packages: psutil 15:20:03 INFO - Running setup.py install for psutil 15:20:03 INFO - building 'psutil._psutil_linux' extension 15:20:03 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 15:20:03 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 15:20:04 INFO - building 'psutil._psutil_posix' extension 15:20:04 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 15:20:04 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 15:20:04 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:20:04 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:20:04 INFO - Successfully installed psutil 15:20:04 INFO - Cleaning up... 15:20:06 INFO - Return code: 0 15:20:06 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 15:20: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')]} 15:20:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:20: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')]} 15:20:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:20: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', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13f21f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15bba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x175ea60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1762090>, '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 0x1762d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x175cf90>, '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': '05b19d94dfa9f3ce7b6e62cc000001f7-1505686321.954831-1980373633', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:20: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', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 15:20: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 mozsystemmonitor==0.3 15:20:06 INFO - Using env: {'DISPLAY': ':0', 15:20:06 INFO - 'HOME': '/home/cltbld', 15:20:06 INFO - 'LANG': 'en_US.UTF-8', 15:20:06 INFO - 'LANGUAGE': 'en_US:en', 15:20:06 INFO - 'LOGNAME': 'cltbld', 15:20:06 INFO - 'MAIL': '/var/mail/cltbld', 15:20:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:20:06 INFO - 'MOZ_NO_REMOTE': '1', 15:20:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:20:06 INFO - 'NO_EM_RESTART': '1', 15:20:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:20:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:20:06 INFO - 'PWD': '/builds/slave/test', 15:20:06 INFO - 'SHELL': '/bin/bash', 15:20:06 INFO - 'SHLVL': '1', 15:20:06 INFO - 'TERM': 'linux', 15:20:06 INFO - 'TMOUT': '86400', 15:20:06 INFO - 'USER': 'cltbld', 15:20:06 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1505686321.954831-1980373633', 15:20:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:20:06 INFO - '_': '/tools/buildbot/bin/python'} 15:20:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:20:06 INFO - Downloading/unpacking mozsystemmonitor==0.3 15:20: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 15:20: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 15:20: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 15:20: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 15:20:07 INFO - Downloading mozsystemmonitor-0.3.tar.gz 15:20:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 15:20:07 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 15:20:07 INFO - Installing collected packages: mozsystemmonitor 15:20:07 INFO - Running setup.py install for mozsystemmonitor 15:20:07 INFO - Successfully installed mozsystemmonitor 15:20:07 INFO - Cleaning up... 15:20:07 INFO - Return code: 0 15:20:07 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 15:20:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:20:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:20:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:20:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:20:07 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 0x13f21f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15bba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x175ea60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1762090>, '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 0x1762d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x175cf90>, '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': '05b19d94dfa9f3ce7b6e62cc000001f7-1505686321.954831-1980373633', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:20:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 15:20:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 15:20:07 INFO - Using env: {'DISPLAY': ':0', 15:20:07 INFO - 'HOME': '/home/cltbld', 15:20:07 INFO - 'LANG': 'en_US.UTF-8', 15:20:07 INFO - 'LANGUAGE': 'en_US:en', 15:20:07 INFO - 'LOGNAME': 'cltbld', 15:20:07 INFO - 'MAIL': '/var/mail/cltbld', 15:20:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:20:07 INFO - 'MOZ_NO_REMOTE': '1', 15:20:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:20:07 INFO - 'NO_EM_RESTART': '1', 15:20:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:20:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:20:07 INFO - 'PWD': '/builds/slave/test', 15:20:07 INFO - 'SHELL': '/bin/bash', 15:20:07 INFO - 'SHLVL': '1', 15:20:07 INFO - 'TERM': 'linux', 15:20:07 INFO - 'TMOUT': '86400', 15:20:07 INFO - 'USER': 'cltbld', 15:20:07 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1505686321.954831-1980373633', 15:20:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:20:07 INFO - '_': '/tools/buildbot/bin/python'} 15:20:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:20:07 INFO - Downloading/unpacking jsonschema==2.5.1 15:20:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:20:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:20:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:20:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:20:08 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 15:20:08 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 15:20:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:20:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:20:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:20:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:20:08 INFO - Downloading functools32-3.2.3-2.tar.gz 15:20:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 15:20:09 INFO - warning: no files found matching '*.txt' 15:20:09 INFO - no previously-included directories found matching 'build' 15:20:09 INFO - no previously-included directories found matching 'dist' 15:20:09 INFO - no previously-included directories found matching '.git*' 15:20:09 INFO - Installing collected packages: jsonschema, functools32 15:20:09 INFO - Running setup.py install for functools32 15:20:09 INFO - warning: no files found matching '*.txt' 15:20:09 INFO - no previously-included directories found matching 'build' 15:20:09 INFO - no previously-included directories found matching 'dist' 15:20:09 INFO - no previously-included directories found matching '.git*' 15:20:09 INFO - Successfully installed jsonschema functools32 15:20:09 INFO - Cleaning up... 15:20:09 INFO - Return code: 0 15:20:09 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 15:20:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:20:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:20:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:20:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:20:09 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 0x13f21f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15bba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x175ea60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1762090>, '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 0x1762d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x175cf90>, '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': '05b19d94dfa9f3ce7b6e62cc000001f7-1505686321.954831-1980373633', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:20:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 15:20:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 15:20:09 INFO - Using env: {'DISPLAY': ':0', 15:20:09 INFO - 'HOME': '/home/cltbld', 15:20:09 INFO - 'LANG': 'en_US.UTF-8', 15:20:09 INFO - 'LANGUAGE': 'en_US:en', 15:20:09 INFO - 'LOGNAME': 'cltbld', 15:20:09 INFO - 'MAIL': '/var/mail/cltbld', 15:20:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:20:09 INFO - 'MOZ_NO_REMOTE': '1', 15:20:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:20:09 INFO - 'NO_EM_RESTART': '1', 15:20:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:20:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:20:09 INFO - 'PWD': '/builds/slave/test', 15:20:09 INFO - 'SHELL': '/bin/bash', 15:20:09 INFO - 'SHLVL': '1', 15:20:09 INFO - 'TERM': 'linux', 15:20:09 INFO - 'TMOUT': '86400', 15:20:09 INFO - 'USER': 'cltbld', 15:20:09 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1505686321.954831-1980373633', 15:20:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:20:09 INFO - '_': '/tools/buildbot/bin/python'} 15:20:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:20:09 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 15:20:09 INFO - Cleaning up... 15:20:09 INFO - Return code: 0 15:20:09 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 15:20:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:20:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:20:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:20:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:20:09 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 0x13f21f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15bba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x175ea60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1762090>, '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 0x1762d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x175cf90>, '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': '05b19d94dfa9f3ce7b6e62cc000001f7-1505686321.954831-1980373633', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:20:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 15:20:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 15:20:09 INFO - Using env: {'DISPLAY': ':0', 15:20:09 INFO - 'HOME': '/home/cltbld', 15:20:09 INFO - 'LANG': 'en_US.UTF-8', 15:20:09 INFO - 'LANGUAGE': 'en_US:en', 15:20:09 INFO - 'LOGNAME': 'cltbld', 15:20:09 INFO - 'MAIL': '/var/mail/cltbld', 15:20:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:20:09 INFO - 'MOZ_NO_REMOTE': '1', 15:20:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:20:09 INFO - 'NO_EM_RESTART': '1', 15:20:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:20:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:20:09 INFO - 'PWD': '/builds/slave/test', 15:20:09 INFO - 'SHELL': '/bin/bash', 15:20:09 INFO - 'SHLVL': '1', 15:20:09 INFO - 'TERM': 'linux', 15:20:09 INFO - 'TMOUT': '86400', 15:20:09 INFO - 'USER': 'cltbld', 15:20:09 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1505686321.954831-1980373633', 15:20:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:20:09 INFO - '_': '/tools/buildbot/bin/python'} 15:20:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:20:09 INFO - Downloading/unpacking blobuploader==1.2.4 15:20: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 15:20: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 15:20: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 15:20: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 15:20:10 INFO - Downloading blobuploader-1.2.4.tar.gz 15:20:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 15:20:10 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 15:20: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 15:20: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 15:20: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 15:20: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 15:20:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 15:20:11 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 15:20: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 15:20: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 15:20: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 15:20: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 15:20:11 INFO - Downloading docopt-0.6.1.tar.gz 15:20:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 15:20:11 INFO - Installing collected packages: blobuploader, requests, docopt 15:20:11 INFO - Running setup.py install for blobuploader 15:20:11 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 15:20:11 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 15:20:11 INFO - Running setup.py install for requests 15:20:11 INFO - Running setup.py install for docopt 15:20:11 INFO - Successfully installed blobuploader requests docopt 15:20:11 INFO - Cleaning up... 15:20:11 INFO - Return code: 0 15:20:11 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:20:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:20:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:20:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:20:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:20:11 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 0x13f21f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15bba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x175ea60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1762090>, '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 0x1762d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x175cf90>, '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': '05b19d94dfa9f3ce7b6e62cc000001f7-1505686321.954831-1980373633', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:20:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 15:20:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 15:20:11 INFO - Using env: {'DISPLAY': ':0', 15:20:11 INFO - 'HOME': '/home/cltbld', 15:20:11 INFO - 'LANG': 'en_US.UTF-8', 15:20:11 INFO - 'LANGUAGE': 'en_US:en', 15:20:11 INFO - 'LOGNAME': 'cltbld', 15:20:11 INFO - 'MAIL': '/var/mail/cltbld', 15:20:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:20:11 INFO - 'MOZ_NO_REMOTE': '1', 15:20:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:20:11 INFO - 'NO_EM_RESTART': '1', 15:20:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:20:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:20:11 INFO - 'PWD': '/builds/slave/test', 15:20:11 INFO - 'SHELL': '/bin/bash', 15:20:11 INFO - 'SHLVL': '1', 15:20:11 INFO - 'TERM': 'linux', 15:20:11 INFO - 'TMOUT': '86400', 15:20:11 INFO - 'USER': 'cltbld', 15:20:11 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1505686321.954831-1980373633', 15:20:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:20:11 INFO - '_': '/tools/buildbot/bin/python'} 15:20:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:20:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:20:12 INFO - Running setup.py (path:/tmp/pip-59nm3y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:20:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:20:12 INFO - Running setup.py (path:/tmp/pip-LPtzOG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:20:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:20:12 INFO - Running setup.py (path:/tmp/pip-ps6nZe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:20:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:20:12 INFO - Running setup.py (path:/tmp/pip-9kf2W_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:20:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:20:12 INFO - Running setup.py (path:/tmp/pip-l5MQwn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:20:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:20:12 INFO - Running setup.py (path:/tmp/pip-7RfNgn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:20:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:20:12 INFO - Running setup.py (path:/tmp/pip-DfZFst-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:20:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:20:12 INFO - Running setup.py (path:/tmp/pip-sCpCZf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:20:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:20:12 INFO - Running setup.py (path:/tmp/pip-uvPc2J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:20:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:20:12 INFO - Running setup.py (path:/tmp/pip-37Y5H4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:20:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:20:12 INFO - Running setup.py (path:/tmp/pip-a77wid-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:20:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:20:12 INFO - Running setup.py (path:/tmp/pip-6cBLKg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:20:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:20:12 INFO - Running setup.py (path:/tmp/pip-nMdyWC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:20:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:20:13 INFO - Running setup.py (path:/tmp/pip-kUxkC5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:20:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:20:13 INFO - Running setup.py (path:/tmp/pip-IcWc0q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:20:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:20:13 INFO - Running setup.py (path:/tmp/pip-Q56Tb_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:20:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:20:13 INFO - Running setup.py (path:/tmp/pip-IbFxCq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:20:13 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 15:20:13 INFO - Running setup.py install for manifestparser 15:20:13 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 15:20:13 INFO - Running setup.py install for mozcrash 15:20:13 INFO - Running setup.py install for mozdebug 15:20:13 INFO - Running setup.py install for mozdevice 15:20:13 INFO - Installing dm script to /builds/slave/test/build/venv/bin 15:20:13 INFO - Running setup.py install for mozfile 15:20:13 INFO - Running setup.py install for mozhttpd 15:20:13 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 15:20:13 INFO - Running setup.py install for mozinfo 15:20:13 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 15:20:13 INFO - Running setup.py install for mozInstall 15:20:14 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 15:20:14 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 15:20:14 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 15:20:14 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 15:20:14 INFO - Running setup.py install for mozleak 15:20:14 INFO - Running setup.py install for mozlog 15:20:14 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 15:20:14 INFO - Running setup.py install for moznetwork 15:20:14 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 15:20:14 INFO - Running setup.py install for mozprocess 15:20:14 INFO - Running setup.py install for mozprofile 15:20:14 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 15:20:14 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 15:20:14 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 15:20:14 INFO - Running setup.py install for mozrunner 15:20:14 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 15:20:14 INFO - Running setup.py install for mozscreenshot 15:20:14 INFO - Running setup.py install for moztest 15:20:14 INFO - Running setup.py install for mozversion 15:20:14 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 15:20:15 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 15:20:15 INFO - Cleaning up... 15:20:15 INFO - Return code: 0 15:20:15 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:20: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')]} 15:20:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:20: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')]} 15:20:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:20:15 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 0x13f21f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15bba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x175ea60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1762090>, '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 0x1762d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x175cf90>, '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': '05b19d94dfa9f3ce7b6e62cc000001f7-1505686321.954831-1980373633', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:20:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 15:20:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 15:20:15 INFO - Using env: {'DISPLAY': ':0', 15:20:15 INFO - 'HOME': '/home/cltbld', 15:20:15 INFO - 'LANG': 'en_US.UTF-8', 15:20:15 INFO - 'LANGUAGE': 'en_US:en', 15:20:15 INFO - 'LOGNAME': 'cltbld', 15:20:15 INFO - 'MAIL': '/var/mail/cltbld', 15:20:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:20:15 INFO - 'MOZ_NO_REMOTE': '1', 15:20:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:20:15 INFO - 'NO_EM_RESTART': '1', 15:20:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:20:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:20:15 INFO - 'PWD': '/builds/slave/test', 15:20:15 INFO - 'SHELL': '/bin/bash', 15:20:15 INFO - 'SHLVL': '1', 15:20:15 INFO - 'TERM': 'linux', 15:20:15 INFO - 'TMOUT': '86400', 15:20:15 INFO - 'USER': 'cltbld', 15:20:15 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1505686321.954831-1980373633', 15:20:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:20:15 INFO - '_': '/tools/buildbot/bin/python'} 15:20:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:20:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:20:15 INFO - Running setup.py (path:/tmp/pip-TIPamv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:20:15 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 15:20:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:20:15 INFO - Running setup.py (path:/tmp/pip-t7BXNT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:20:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 15:20:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:20:15 INFO - Running setup.py (path:/tmp/pip-uG_7LY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:20:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 15:20:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:20:15 INFO - Running setup.py (path:/tmp/pip-TgdEGE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:20:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.51 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 15:20:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:20:15 INFO - Running setup.py (path:/tmp/pip-s6yTgo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:20:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 15:20:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:20:15 INFO - Running setup.py (path:/tmp/pip-hik_ZU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:20:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 15:20:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:20:15 INFO - Running setup.py (path:/tmp/pip-ZLoXPa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:20:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.10 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 15:20:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:20:15 INFO - Running setup.py (path:/tmp/pip-by0cb8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:20:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.13 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 15:20:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:20:15 INFO - Running setup.py (path:/tmp/pip-GkiI81-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:20:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 15:20:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:20:15 INFO - Running setup.py (path:/tmp/pip-SNroZO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:20:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.5 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 15:20:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:20:15 INFO - Running setup.py (path:/tmp/pip-YMa329-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:20:16 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 15:20:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:20:16 INFO - Running setup.py (path:/tmp/pip-rijwGJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:20:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 15:20:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:20:16 INFO - Running setup.py (path:/tmp/pip-BWoupY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:20:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 15:20:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:20:16 INFO - Running setup.py (path:/tmp/pip-EqmXjL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:20:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 15:20:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:20:16 INFO - Running setup.py (path:/tmp/pip-D3acb7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:20:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 15:20:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:20:16 INFO - Running setup.py (path:/tmp/pip-_ZkjzD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:20:16 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 15:20:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:20:16 INFO - Running setup.py (path:/tmp/pip-7NMlsn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:20:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 15:20:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 15:20:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 15:20:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 15:20:16 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.51->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 15:20:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.51->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 15:20:16 INFO - Requirement already satisfied (use --upgrade to upgrade): requests in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozInstall==1.13->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 15:20:16 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 15:20:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:20:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:20:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:20:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:20:17 INFO - Downloading blessings-1.6.tar.gz 15:20:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 15:20:17 INFO - Installing collected packages: blessings 15:20:17 INFO - Running setup.py install for blessings 15:20:17 INFO - Successfully installed blessings 15:20:17 INFO - Cleaning up... 15:20:17 INFO - Return code: 0 15:20:17 INFO - Done creating virtualenv /builds/slave/test/build/venv. 15:20:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:20:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:20:18 INFO - Reading from file tmpfile_stdout 15:20:18 INFO - Current package versions: 15:20:18 INFO - argparse == 1.2.1 15:20:18 INFO - blessings == 1.6 15:20:18 INFO - blobuploader == 1.2.4 15:20:18 INFO - docopt == 0.6.1 15:20:18 INFO - functools32 == 3.2.3-2 15:20:18 INFO - jsonschema == 2.5.1 15:20:18 INFO - manifestparser == 1.1 15:20:18 INFO - mozInstall == 1.13 15:20:18 INFO - mozcrash == 1.0 15:20:18 INFO - mozdebug == 0.1 15:20:18 INFO - mozdevice == 0.51 15:20:18 INFO - mozfile == 1.2 15:20:18 INFO - mozhttpd == 0.7 15:20:18 INFO - mozinfo == 0.10 15:20:18 INFO - mozleak == 0.1 15:20:18 INFO - mozlog == 3.5 15:20:18 INFO - moznetwork == 0.27 15:20:18 INFO - mozprocess == 0.25 15:20:18 INFO - mozprofile == 0.28 15:20:18 INFO - mozrunner == 6.13 15:20:18 INFO - mozscreenshot == 0.1 15:20:18 INFO - mozsystemmonitor == 0.3 15:20:18 INFO - moztest == 0.8 15:20:18 INFO - mozversion == 1.4 15:20:18 INFO - psutil == 3.1.1 15:20:18 INFO - requests == 1.2.3 15:20:18 INFO - wsgiref == 0.1.2 15:20:18 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:20: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')]} 15:20:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:20: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')]} 15:20:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:20:18 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 0x13f21f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15bba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x175ea60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1762090>, '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 0x1762d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x175cf90>, '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': '05b19d94dfa9f3ce7b6e62cc000001f7-1505686321.954831-1980373633', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:20:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 15:20:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 15:20:18 INFO - Using env: {'DISPLAY': ':0', 15:20:18 INFO - 'HOME': '/home/cltbld', 15:20:18 INFO - 'LANG': 'en_US.UTF-8', 15:20:18 INFO - 'LANGUAGE': 'en_US:en', 15:20:18 INFO - 'LOGNAME': 'cltbld', 15:20:18 INFO - 'MAIL': '/var/mail/cltbld', 15:20:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:20:18 INFO - 'MOZ_NO_REMOTE': '1', 15:20:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:20:18 INFO - 'NO_EM_RESTART': '1', 15:20:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:20:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:20:18 INFO - 'PWD': '/builds/slave/test', 15:20:18 INFO - 'SHELL': '/bin/bash', 15:20:18 INFO - 'SHLVL': '1', 15:20:18 INFO - 'TERM': 'linux', 15:20:18 INFO - 'TMOUT': '86400', 15:20:18 INFO - 'USER': 'cltbld', 15:20:18 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1505686321.954831-1980373633', 15:20:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:20:18 INFO - '_': '/tools/buildbot/bin/python'} 15:20:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:20:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 15:20:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 15:20:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 15:20:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 15:20:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 15:20:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 15:20:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 15:20:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 15:20:18 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 15:20:18 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 15:20:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:20:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:20:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:20:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:20:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 15:20:19 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 15:20:19 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 15:20:19 INFO - Installing collected packages: simplejson 15:20:19 INFO - Running setup.py install for simplejson 15:20:19 INFO - building 'simplejson._speedups' extension 15:20:19 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c simplejson/_speedups.c -o build/temp.linux-x86_64-2.7/simplejson/_speedups.o 15:20:20 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/simplejson/_speedups.o -o build/lib.linux-x86_64-2.7/simplejson/_speedups.so 15:20:20 INFO - Successfully installed simplejson 15:20:20 INFO - Cleaning up... 15:20:20 INFO - Return code: 0 15:20:20 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 15:20:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:20:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:20:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:20:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:20:20 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 0x13f21f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15bba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x175ea60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1762090>, '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 0x1762d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x175cf90>, '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': '05b19d94dfa9f3ce7b6e62cc000001f7-1505686321.954831-1980373633', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:20:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 15:20:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 15:20:20 INFO - Using env: {'DISPLAY': ':0', 15:20:20 INFO - 'HOME': '/home/cltbld', 15:20:20 INFO - 'LANG': 'en_US.UTF-8', 15:20:20 INFO - 'LANGUAGE': 'en_US:en', 15:20:20 INFO - 'LOGNAME': 'cltbld', 15:20:20 INFO - 'MAIL': '/var/mail/cltbld', 15:20:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:20:20 INFO - 'MOZ_NO_REMOTE': '1', 15:20:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:20:20 INFO - 'NO_EM_RESTART': '1', 15:20:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:20:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:20:20 INFO - 'PWD': '/builds/slave/test', 15:20:20 INFO - 'SHELL': '/bin/bash', 15:20:20 INFO - 'SHLVL': '1', 15:20:20 INFO - 'TERM': 'linux', 15:20:20 INFO - 'TMOUT': '86400', 15:20:20 INFO - 'USER': 'cltbld', 15:20:20 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1505686321.954831-1980373633', 15:20:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:20:20 INFO - '_': '/tools/buildbot/bin/python'} 15:20:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:20:20 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 15:20:20 INFO - Cleaning up... 15:20:20 INFO - Return code: 0 15:20:20 INFO - Running post-action listener: _resource_record_post_action 15:20:20 INFO - Running post-action listener: _start_resource_monitoring 15:20:20 INFO - Starting resource monitoring. 15:20:20 INFO - [mozharness: 2017-09-17 22:20:20.729713Z] Finished create-virtualenv step (success) 15:20:20 INFO - [mozharness: 2017-09-17 22:20:20.730293Z] Running install step. 15:20:20 INFO - Running pre-action listener: _resource_record_pre_action 15:20:20 INFO - Running main action method: install 15:20:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:20:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:20:20 INFO - Reading from file tmpfile_stdout 15:20:20 INFO - Detecting whether we're running mozinstall >=1.0... 15:20:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 15:20:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 15:20:21 INFO - Reading from file tmpfile_stdout 15:20:21 INFO - Output received: 15:20:21 INFO - Usage: mozinstall [options] installer 15:20:21 INFO - Options: 15:20:21 INFO - -h, --help show this help message and exit 15:20:21 INFO - -d DEST, --destination=DEST 15:20:21 INFO - Directory to install application into. [default: 15:20:21 INFO - "/builds/slave/test"] 15:20:21 INFO - --app=APP Application being installed. [default: firefox] 15:20:21 INFO - mkdir: /builds/slave/test/build/application 15:20:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/target.tar.bz2', '--destination', '/builds/slave/test/build/application'] 15:20:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 15:20:38 INFO - Reading from file tmpfile_stdout 15:20:38 INFO - Output received: 15:20:38 INFO - /builds/slave/test/build/application/firefox/firefox 15:20:38 INFO - Running post-action listener: _resource_record_post_action 15:20:38 INFO - [mozharness: 2017-09-17 22:20:38.856935Z] Finished install step (success) 15:20:38 INFO - [mozharness: 2017-09-17 22:20:38.857081Z] Running setup-mitmproxy step. 15:20:38 INFO - Running pre-action listener: _resource_record_pre_action 15:20:38 INFO - Running main action method: setup_mitmproxy 15:20:38 INFO - Skipping: mitmproxy is not required 15:20:38 INFO - Running post-action listener: _resource_record_post_action 15:20:38 INFO - [mozharness: 2017-09-17 22:20:38.857610Z] Finished setup-mitmproxy step (success) 15:20:38 INFO - [mozharness: 2017-09-17 22:20:38.857713Z] Running run-tests step. 15:20:38 INFO - Running pre-action listener: _resource_record_pre_action 15:20:38 INFO - Running pre-action listener: _set_gcov_prefix 15:20:38 INFO - Running main action method: run_tests 15:20:38 WARNING - Try message not found. 15:20:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 15:20:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 15:20:38 INFO - Python 2.7.3 15:20:38 INFO - Return code: 0 15:20:38 INFO - grabbing minidump binary from tooltool 15:20:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:20:38 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 0x1762090>, '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 0x1762d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x175cf90>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 15:20:38 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://tooltool.mozilla-releng.net/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 15:20:38 INFO - Copy/paste: /tools/tooltool.py --url https://tooltool.mozilla-releng.net/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 15:20:38 INFO - Calling ['/tools/tooltool.py', '--url', 'https://tooltool.mozilla-releng.net/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 15:20:38 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 15:20:38 INFO - Return code: 0 15:20:38 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 15:20:38 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 15:20:38 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 15:20:38 INFO - ENV: RUST_BACKTRACE is now full 15:20:38 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 15:20:38 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 15:20:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Mt_FquQNTb2zZxQoyb7pNg/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-069', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 15:20:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Mt_FquQNTb2zZxQoyb7pNg/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-069 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 15:20:38 INFO - Using env: {'DISPLAY': ':0', 15:20:38 INFO - 'HOME': '/home/cltbld', 15:20:38 INFO - 'LANG': 'en_US.UTF-8', 15:20:38 INFO - 'LANGUAGE': 'en_US:en', 15:20:38 INFO - 'LOGNAME': 'cltbld', 15:20:38 INFO - 'MAIL': '/var/mail/cltbld', 15:20:38 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 15:20:38 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 15:20:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:20:38 INFO - 'MOZ_NO_REMOTE': '1', 15:20:38 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 15:20:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:20:38 INFO - 'NO_EM_RESTART': '1', 15:20:38 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:20:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:20:38 INFO - 'PWD': '/builds/slave/test', 15:20:38 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 15:20:38 INFO - 'RUST_BACKTRACE': 'full', 15:20:38 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 15:20:38 INFO - 'SHELL': '/bin/bash', 15:20:38 INFO - 'SHLVL': '1', 15:20:38 INFO - 'TERM': 'linux', 15:20:38 INFO - 'TMOUT': '86400', 15:20:38 INFO - 'USER': 'cltbld', 15:20:38 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1505686321.954831-1980373633', 15:20:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:20:38 INFO - '_': '/tools/buildbot/bin/python'} 15:20:38 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Mt_FquQNTb2zZxQoyb7pNg/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-069', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 15:20:39 INFO - mozversion application_buildid: 20170917213019 15:20:39 INFO - mozversion application_changeset: dd87b8587fc1d63e57ebdadcbabba89c6d172969 15:20:39 INFO - mozversion application_display_name: Nightly 15:20:39 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 15:20:39 INFO - mozversion application_name: Firefox 15:20:39 INFO - mozversion application_remotingname: firefox 15:20:39 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 15:20:39 INFO - mozversion application_vendor: Mozilla 15:20:39 INFO - mozversion application_version: 57.0a1 15:20:39 INFO - mozversion platform_buildid: 20170917213019 15:20:39 INFO - mozversion platform_changeset: dd87b8587fc1d63e57ebdadcbabba89c6d172969 15:20:39 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 15:20:39 INFO - mozversion platform_version: 57.0a1 15:20:39 INFO - using testdate: 1505686839 15:20:39 INFO - actual date: 1505686839 15:20:39 INFO - starting webserver on 'localhost:45905' 15:20:39 INFO - SUITE-START | Running 2 tests 15:20:39 INFO - TEST-START | dromaeo_css 15:20:39 INFO - Initialising browser for dromaeo_css test... 15:20:39 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:45905/getInfo.html -profile /tmp/tmpnKTgvK/profile 15:20:39 INFO - TEST-INFO | started process 5668 (/builds/slave/test/build/application/firefox/firefox http://localhost:45905/getInfo.html) 15:20:45 INFO - TEST-INFO | 5668: exit 0 15:20:45 INFO - Browser initialized. 15:20:45 INFO - Running cycle 1/1 for dromaeo_css test... 15:20:45 INFO - Using env: {'DISPLAY': ':0', 15:20:45 INFO - 'HOME': '/home/cltbld', 15:20:45 INFO - 'JSGC_DISABLE_POISONING': '1', 15:20:45 INFO - 'LANG': 'en_US.UTF-8', 15:20:45 INFO - 'LANGUAGE': 'en_US:en', 15:20:45 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 15:20:45 INFO - 'LOGNAME': 'cltbld', 15:20:45 INFO - 'MAIL': '/var/mail/cltbld', 15:20:45 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 15:20:45 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 15:20:45 INFO - 'MOZ_CRASHREPORTER': '1', 15:20:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:20:45 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 15:20:45 INFO - 'MOZ_NO_REMOTE': '1', 15:20:45 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 15:20:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:20:45 INFO - 'NO_EM_RESTART': '1', 15:20:45 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:20:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:20:45 INFO - 'PWD': '/builds/slave/test', 15:20:45 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 15:20:45 INFO - 'RUST_BACKTRACE': 'full', 15:20:45 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 15:20:45 INFO - 'SHELL': '/bin/bash', 15:20:45 INFO - 'SHLVL': '1', 15:20:45 INFO - 'TERM': 'linux', 15:20:45 INFO - 'TMOUT': '86400', 15:20:45 INFO - 'USER': 'cltbld', 15:20:45 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1505686321.954831-1980373633', 15:20:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:20:45 INFO - '_': '/tools/buildbot/bin/python'} 15:20:45 INFO - TEST-INFO | started process 5908 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpnKTgvK/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 15:20:45 INFO - PID 5908 | 15:20:45 INFO - PID 5908 | (/builds/slave/test/build/application/firefox/firefox:5957): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 15:20:45 INFO - PID 5908 | 15:20:56 INFO - PID 5908 | RSS: Main: 154677248 15:20:56 INFO - PID 5908 | 15:23:52 INFO - PID 5908 | Cycle 1(1): loaded http://localhost:45905/tests/dromaeo/cssquery-dojo.html (next: http://localhost:45905/tests/dromaeo/cssquery-ext.html) 15:23:53 INFO - PID 5908 | RSS: Main: 155586560 15:23:53 INFO - PID 5908 | 15:26:55 INFO - PID 5908 | Cycle 1(1): loaded http://localhost:45905/tests/dromaeo/cssquery-ext.html (next: http://localhost:45905/tests/dromaeo/cssquery-jquery.html) 15:26:56 INFO - PID 5908 | RSS: Main: 154980352 15:26:56 INFO - PID 5908 | 15:29:58 INFO - PID 5908 | Cycle 1(1): loaded http://localhost:45905/tests/dromaeo/cssquery-jquery.html (next: http://localhost:45905/tests/dromaeo/cssquery-mootools.html) 15:29:58 INFO - PID 5908 | RSS: Main: 157065216 15:29:58 INFO - PID 5908 | 15:33:00 INFO - PID 5908 | Cycle 1(1): loaded http://localhost:45905/tests/dromaeo/cssquery-mootools.html (next: http://localhost:45905/tests/dromaeo/cssquery-prototype.html) 15:33:01 INFO - PID 5908 | RSS: Main: 156475392 15:33:01 INFO - PID 5908 | 15:36:04 INFO - PID 5908 | Cycle 1(1): loaded http://localhost:45905/tests/dromaeo/cssquery-prototype.html (next: http://localhost:45905/tests/dromaeo/cssquery-yui.html) 15:36:04 INFO - PID 5908 | RSS: Main: 157200384 15:36:04 INFO - PID 5908 | 15:39:06 INFO - PID 5908 | Cycle 1(1): loaded http://localhost:45905/tests/dromaeo/cssquery-yui.html (next: http://localhost:45905/tests/dromaeo/cssquery-dojo.html) 15:39:06 INFO - PID 5908 | RSS: Main: 159035392 15:39:06 INFO - PID 5908 | 15:39:06 INFO - PID 5908 | __start_tp_report 15:39:06 INFO - PID 5908 | _x_x_mozilla_page_load 15:39:06 INFO - PID 5908 | _x_x_mozilla_page_load_details 15:39:06 INFO - PID 5908 | |i|pagename|runs| 15:39:06 INFO - PID 5908 | |0;dojo.html;3107.984460077699;3110.782245242834;3124.0940127363074;3124.7031532004466;3142.8585713642883;6073.423024812647;6195;6197.59715618485;6228;6328.430441260286;6164.568480206376;6220.4712599428985;6220.720067596958;6223.502119830414;6228;5718.428157184269;5798.971005144968;5800.738966746486;5802.622829516089;5830.854228644275;5767.163761254616;5818.214541036969;5842.912356314659;5866.413358664142;5906.26171728534;71.45859029449974;5352.277442545265;5682.715864206773;5815.389384114649;5873.471387575118;5694.629849059839;5726.828195154152;5812.215350927613;5827.621204621729;5852.209951656514;5730.914036289459;5770.365259821417;5808.012637851575;5832.4459176378605;5849.912251316191;6259.967105427599;6261.812145635638;6278.497720182374;6318.968405157945;6352.555321127523;6516.641584712839;6697.062411262427;6729.287661491036;6828.624425656587;6835.008923706085;6657;6673;6675.966620166917;6678.232003319583;6679.298673639247;6213.906791398133;6224.439800417984;6299.527535434815;6303;6303.338149494283;6874.518783685094;6933;6958.965205173941;6960.895586566206;6967;6539.50953678476;6560.573562718503;6634.535582509275;6640.966795165993;6650.102236198148;6667.933320666828;6698.497612679069;6705;6781.186257649114;6801.523893327519;6395.20059992501;6550.312217217219;6621.172353455818;6669.599824010575;6680.3987641112535;6750.35871592198;6778.76274330406;6780.932190678129;6787.389134977777;6787.830304242433;5294.232336311214;5361.08861493547;5368.141097424394;5378.058839703036;5379.946200537945;4622.098690755271;4642.326862604971;4648.930266046012;4651.906961860812;4681.7190968542;5634.408387119293;5748.655080695172;5758;5812.3025236971835;5812.796552120655;6775.186977562724;6795.898061529081;6809.863802723918;6827.658617069127;6828.419584335387;5743.282089738783;5765.711714414347;5773.04744717117;5828.242328497268;5833.38749431312;5744.052231381859;5784.652920824764;5810.970945145332;5834.504067154339;5843.649381037151;6300.936990630126;6365.522585806083;6394.904076438857;6398.200224971879;6528.608283503005;6605.438537724347;6619.4373478252965;6625.204975402982;6647.900281495685;6670.466362690876;6348.174737284124;6425.775097871552;6490.350964903472;6572.934270657232;6577.210734711865;6619.834504137435;6679.098321726699;6707.698153583003;6715.227748808754;6716.1604799400075;6742.595444273359;6752.3922846944015;6754.932450675627;6844.349786770249;6862.519623626298;6348.619082854859;6462.030695395728;6499.447546958561;6514.804555863332;6598.60408375499;6558.639274839738;6573.408393244631;6579.243387010555;6591.176102987127;6610.140681711347;6450.48396128318;6520.543561950618;6524.119243902012;6530.575512591667;6543.149390579194;6520.739170433129;6558.540902136995;6621.635810030494;6637.303083176197;6647;6322.589031713108;6336.482583342917;6373.521985850987;6380.808575742735;6391.872162556816 15:39:06 INFO - PID 5908 | |1;ext.html;851.6593362654937;880.784207869072;881.9073997230295;884.310238014349;887.050855584524;41527.169456610885;42333.94165145869;42503;42558.36162457566;42578.787106064425;37826;37854.81072594633;37953.430698539545;37960;37962;6915.619640919747;6998.265182155877;7075.646217689121;7131.0729605151255;7151.070360853082;7046.612436316001;7125.714971401164;7131.215566287704;7131.89302160468;7151.177614574312;7096.112985876765;7100.6449677516175;7117.679704413288;7121.679524421387;7134.17956934954;7076.6815493302665;7100.28997100291;7101.579684063182;7101.786946391565;7119.75080872167;6469.708863101125;6522.445592124628;6529.151210342625;6538.476921846241;6542.214934207926;34096.147596310046;34292.14269643279;34328;34361.312773744634;34371.14072148217;3420.350133474632;3421.726261899042;3422.0076177908377;3423.7945723256685;3427.211741299515;27723.306917327027;27736.861315693495;27752.167434976982;27798.16605501838;27942.161735147976;4450.2434586120435;4689.88275293117;4691.272852707802;4702.388689470347;4723.385959825235;178269;180175;180954;181168;181866;22635.20776772838;42490;43121.568784311756;49720.50279497231;50428;51554;51641.225381619304;51907;51920.480795191565;52109;15699.215039247993;16007.679846403007;16020.19899005045;16387.918060409622;16408.26162822676;13245.403956821967;13265.933670331586;13339.333033348294;13432.664183395493;13441.059125861097;13594.320283985959;13804.17174969505;13901.652458688412;14025.719485610434;14173.433062677377;5564.360098588714;5614.2701448811395;5626.2685850839125;5653.971730141405;5668.943310566841;1019.1897441533998;1028.5217373921162;1033.8604288420968;1043.7077618266896;1049.1239814754765;23341.066357345517;23422.882885585805;23719.525609487715;23913.52172956566;24062.796860156923;1135.647949135754;1139.7036770439745;1141.3836528274805;1158.195054437158;1161.4599211366756;12309;12564;12758;12785.808212876815;12850.293233872228;225251;225873;226252;226261;226428;53992.73003635035;54167;54225.45774542204;54323.72838135784;54530.45469545333;1454.4691187716196;1455.548779878241;1476.1659662290986;1477.1727832413667;1499.5426394949645;22929.65605515952;23109.306720798402;23151.073957041528;23180.652290215996;23205.41986450352;38053;38150.23699526049;38222;41194;43431.34852977271;194143;197602;199077;199432;199483;33869;34240.48639270363;34336.313273734886;34430.13924651904;34441.311173776885;43319;43457.565424345354;43498.565014350716;43795.343069854614;43909.56090439182;31744.682553174174;31789;32018.51972220372;32264.032079037668;32572.51141232931;25748.742512575383;25837.483250335263;26017.6097358536;26024.52766987133;26168.476630466903;35187;35358.11604709903;35802.28395432025;35900.82049589735;36250.63749362472;30457.847710761303;30504.389912202074;30750.84624576863;30872.84563577168;31020.22449438692;21619;22884.542309154058;22997.88501057484;23006.539869202858;23056.884715576314 15:39:06 INFO - PID 5908 | |2;jquery.html;547.3267880506976;559.5020431815682;573.0802062689386;576.9711514424278;596.439347013807;22036.88981555092;23040.539189216226;23134.88432557839;23137.537249255005;23149.30552083436;23655.40861478464;24086.5182696346;24387.51224975504;25641.23076307714;25670.74329256707;6350.983842585176;6542.803715888531;6543.443807276387;6544.214694236698;6548.1814773153355;6386.1697979262635;6474;6481.902771458432;6486.61080335179;6492.09110724499;6399.424051835334;6676.699548520304;6676.899846502306;6681.866362672744;6682.799516014503;6541.705623246941;6577.704003319838;6580.473562115019;6583.637899915503;6589.04458853466;5898.41015898411;6052.697365131726;6084.117802918597;6110.511159107261;6135.447809697149;29121.56317655237;29669.554956675667;29685;29730.108096757132;29749.851250743824;1936.893470859102;1955.7946415626297;1963.3128405058258;1963.4502339344863;1968.7046942958527;19062.714059289123;19419.902900485547;19673.803261967485;19786;19826;2428.247243354566;2466.605343145106;2506.6240063990367;2512.5979843224995;2538.6192071189284;116990;122304.99999999911;136714.3164284182;141212;144722;14400.67979606135;14527.339319352723;14798.186099764616;14916.942026884462;14925.70148597022;22786.202482913017;22884.65673014906;22937.655935160987;23016.194433195094;23041.193558225383;9762.267829912786;9783.510824458748;9859.950700246452;10035.548400322003;10094.747631309276;8951.820963580692;9167.26661867049;9169.908300916906;9258.259339252843;9348.672796452227;8871.423357481743;9289.303302252358;9298.209652179641;9320.627174913063;9377.671781487616;2680.654427376046;2685.501087368573;2696.2046196372116;2705.8241214321006;2764.5853122031453;918.8713580098791;929.1405449958761;939.8261321655516;953.6376177052675;964.628617982082;19199.904000480186;19394.612107757766;19441.56465568796;19534.511637209183;19863.106160222535;1014.4826138669184;1014.7564584499667;1015.8476228565775;1027.773889744255;1031.6750223679517;10793.78412431747;10828.187885908588;10859.78280434387;10948.288361256493;10952.890471095187;481618;483269;489619;491188;495803;107976;109450;110731;110994;111150;1028.5114570578914;1074.7152004718755;1145.3471521232984;1155.7110722319587;1187.0859438232512;21000.789992099883;21310.680339794606;21565.568688626452;21566.137354505645;21566.460838479165;55915.161272581754;56326.43673563376;56498.717506412206;56643.433565663814;58130.12804808016;71468.64265678638;71526.64236678783;75997;76351.2364876344;76713;20118.29585964484;20279.898600506902;20401.59196816085;20969.475763105434;21008.894955525124;22932;23161.884190578938;23211.419714507272;23231.186908458123;23572.6464103042;18315.816841831413;18483.445496635122;18909.71635425497;19086.61826763429;19124;16638.50084497467;17187.828121718623;17231.310747570456;17292.654146917244;17493.82506174973;18189.909050454662;18950.24199032023;19159;19171.233150674376;19592.902035489733;20260.290889818785;20360.69458958087;20526.794732053088;20627.278045268344;20670.17319307271;18308.359207427675;18405.723914141032;18455;18667.253309867454;18671.906640467256 15:39:06 INFO - PID 5908 | |3;mootools.html;1287.2919894058266;1378.5450801235593;1383.0940733819352;1386.757317469443;1387.840398354189;14962.925185374072;15426.151561664117;15552;15612.141332226738;15726.29231684574;15245.54263372098;15246.771298430533;15252.237388130605;15357.308921098549;15386.923065384657;2610.9738902611016;2747.6565429321336;2752.160591019748;2759.503289407906;2761.4753196892525;2492.4516606346574;2641.960370594443;2694.8517831519357;2702.3244188952763;2705.5671092625184;2779.3190668286297;2801.90193343233;2803.663560372758;2808.0873716042265;2813.563897595876;2639.802014848894;2669.532831754445;2674.0507119972517;2679.598060290962;2682.6110214018954;2578.181186915645;2611.720257074039;2613.46423983083;2619.869006549665;2624.8556329401877;14774.409023639042;15095;15109.093454392772;15160.696786064216;15192.240387980557;7949.88075178867;8265;8268.297194738454;8272.462289951134;8273;5250.9474905250845;5524.364698059734;5588.245586845765;5610.859728506779;5622.690752008638;1821.9726704099448;1839.8252166044203;1850.9074546272632;1879.4079864842531;1912.5601111744377;25684.357891052874;25864.74135258642;25882.87058564714;25991.350216244555;26024.609630855364;6486.351364863476;6714.127163468718;6761.526693131434;6880.69036893341;6999.335063168991;16998.150092495325;17010.149492525325;17031.65936681284;17047.48857534276;17188.140592970303;7853.096893857165;8139.4709343892455;8153.103158652543;8153.22544358285;8155.388345874083;7203.423726101899;7278.235785242579;7360.521566098187;7388.224236455202;7393.03890494243;5088.338515992971;5211.973940130275;5217.50433708797;5236.319278493771;5300.655457395257;1370.8903287736957;1397.4130865036507;1522.8020357353694;1525.42034027069;1553.603831023082;859.9054104048549;890.1321211818555;901.5717534171347;901.8692289617969;918.4076270805426;8593.183647553473;8654.394192406597;8674.306055515544;8689.478631282016;8753.606087726068;715.989260161098;728.9854202915913;735.6615956659889;739.789160089372;804.1435870797582;5115.258287548285;5257.658252213594;5405.675659460445;5512.39363669996;5645.576581756384;21314;22249.443763905707;22474.775252247597;22539.43651408728;22602.547949040927;21490.14039438405;22156.1137554496;22368.217112400987;22387.664185037236;22455.438614034454;11564.710882228012;11640.825387619192;11683.883161168449;11712.414379281003;11765.588204412805;8058.717944871902;8256.504609723435;8320.583970801557;8610.354223433142;8686.956565217133;18428.815711843246;18800.15399307007;18956.336528221447;18998.145083471554;19178.13698383604;19407.417777466697;19521.023948802787;19523.12145953464;19660;19723.211071556976;10966.232363734782;10989.395583242998;11132.721681958015;11193.720156995814;11194.496247668712;13420.127691700009;13864.098833576189;14194.006419550533;14197.361118749888;14220.21788801626;11535.307881527135;11538.423078845855;11541.480633371351;11564.595239166589;11820.527178912747;11278;11352.772944540899;11444.313341199555;11593.072554195813;11672.241304315192;10174.389536627827;10234.181265498892;10262.076413122855;10266.691999240034;10268.537915793957;7330.286523097668;7459.962700186465;7492.625368731433;7501.5874126923545;7533.427654783466;6817.284185160685;6825.522213445011;6834.248232694499;6842.828929276808;6881.793546193622 15:39:06 INFO - PID 5908 | |4;prototype.html;502.1789374372899;518.7043385270398;521.7599904044141;527.3961314295132;529.5419462165228;6207.627542347463;6234.127222188891;6243.875122497553;6286.905696414546;6308.842278943029;6122.785702500413;6147.661878596676;6204;6204.844878878019;6217.222847144107;5104.93250233656;5131.230315452674;5141.717205553693;5182.922256166151;5183.024296675197;4838.685485443435;5128.102582048145;5131.794728210867;5151.76817043232;5154.819581314655;4851.708897466146;4878.853634390974;4925.211966085427;4927.6550641455115;4933.629977751665;4884.413870335547;4887.169181239198;4929.1374009548545;4950.232713929347;4957.925631115536;4397.142557201347;4429.933550996738;4431.800568974404;4435.556444355571;4438.778061096932;5974.715436181242;6006.789762358297;6061.636301821904;6081.597768881267;6086.756529738849;5588.385277619499;5636;5644.181593668936;5649.322081350264;5683.374828768832;6428.8071357859335;6450.4839612830865;6455.8063258101865;6467.126937863422;6492.123563318939;4566.13243483737;4801.15979703554;4817.445993710698;4836.806527738886;4859.392575928009;6623.205215374186;6625;6690.531662783607;6726.394624483771;6817.625030623314;4894.828680996148;4910.8772280693265;4913.975430122827;4923.630727695438;4936.284238785356;4981.277714731416;4999.725015124203;5002.59979201663;5004.674696144739;5005.77474013663;5565.777368905198;5567.860803479945;5574.777008919597;5576.6096373254295;5607.383187849415;6401.9039714404325;6464.967675161594;6484.124643173205;6484.513661475408;6488.805335839932;1714.8799584028998;1720.3892618120638;1721.7761690980092;1728.6197036651915;1734.0722713348298;1131.5417256011328;1186.7745128425572;1187.9049676025897;1193.4748710567324;1221.8961388282096;5534.169874518774;5580.135079062752;5617.32592088952;5660.5471562274915;5673.489385955201;6491.902621460682;6521.967390163114;6556.311587283362;6556.901646475307;6677.629441548181;5549.750261238254;5559.082751345983;5561.888762224733;5662.150677398341;5669.319681638147;3428.211511352403;3481.8781342652887;3510.6824051271306;3556.8399422026073;3556.964430355715;6314.273858506239;6314.968425157845;6389.424951754364;6424.389682980202;6467.641795222962;6698.8611935971;6712.12742343502;6791.830204244835;6812.352826481477;6832.180138383326;6347.587406818542;6352.428281454691;6379.864209311456;6403.391677790602;6414.679266036679;6055.775314497282;6395.776147834804;6419.550631455753;6476.902846457213;6550.181227346582;6466.805995820133;6477.4494167996245;6526.869462610816;6539.869202615826;6542.54202205841;6207.099676016746;6223.222097237845;6274.247090349188;6280.410434713201;6352.9047064295;4682.274247491644;4824.903501930012;4864.124457597666;4909.5090490950615;4911.287863259736;6377.426031657174;6526.692383027179;6613.14029176204;6625.768098116543;6631.834204144935;6325.698525003042;6447.548671592944;6486.632379181659;6501.187351581052;6502.837429064311;6433.710483028181;6458.773942911976;6463.3213512580505;6514.869702606016;6516.152900122954;6424.421802037839;6436.356364363526;6446.774362897276;6455.289918109098;6509.8698026040165;6385.13800636908;6396.520260980352;6541.443977261795;6551.901721474277;6582.473402127914;6248.718807653576;6292.433680968735;6333.524985626189;6351.2060992375955;6373.521985850987 15:39:06 INFO - PID 5908 | |5;yui.html;901.2474583722591;921.9769505762355;948.2082461144944;953.0612346838363;953.7615596100975;18630.25478980839;19267.229310827584;19377.806221937793;19421.223151073977;19437.31969381072;16830;17260.74108888368;17300.999999999967;18050.27798888043;18145.546361340974;936.962521499141;954.9045095490465;955.3360414511917;957.5930229652405;958.3914214473824;947.8483442649177;949.4777872170313;949.5584553182769;949.8337790886602;950.1021534649759;994.9850752238722;1040.1159014837403;1042.9426381549013;1043.191526566909;1043.3635482355794;1031.2781053262745;1032.4837581209358;1033.560736686905;1035.0942924940678;1036.533559898049;719.3957076056138;725.0284618611033;743.8103283662631;747.2452822649163;747.6112421540822;18962.52593685155;18963.905180474147;18964.62070758577;19228.519287017796;19461.513462163417;19850.60298794016;20355.69466458004;20367.592648147103;20635.380938571867;20862.791372086387;16698.56148538255;16983.3206671733;16998.235079421454;17052.14739263032;17206.827931720647;3605.927881442383;3628.89113326598;3647.1429214134923;3656.8537258509896;3656.945145822815;135752;139478;140145;141058;143183.99999999895;15471.690566188614;15621.375144994074;15683.294251758698;15899.682006359808;15943.920280398524;27951.720482795317;28198.577021344696;29118.7088129116;29131.41737165287;29154.271143221165;8362.958185209034;8444.324454043784;8468.364872634576;8473.237408633253;8476.364272679573;3988.940165897514;4113.670906327547;4123.340265557556;4139.4204811326435;4146.315857883415;5104.948950510522;5112.309838171799;5157.638965272395;5168.224766285088;5214.035403450373;987.782687808681;1007;1007.8387458006683;1015.898410158993;1020.6580795433613;654.8461111638761;658.1772784019975;686.9313068693191;688.4526801193064;694.0838093716246;10397.776689226364;10768.892311076946;10806.567737290421;10952.726181845517;11670.766584668429;658.980230593083;675.1729131813587;676.5433332500543;677;694.3369082526175;5298.682079075268;5331.973340133352;5334.439883812144;5395.487428694268;5411.756470958816;115514;117795.41102294605;118532;118924.40537797428;122872;109582;109621.45189274002;114151;114802.42598786953;115434.38262469575;94651.52674236585;96859;97688.51155744176;98157;98818.50590747144;9864;10126.038026387481;10139.898601013896;10185.236107291834;10258.743531411475;43423.78288108539;44855.10289794121;45023.774881125384;45577;46201;56774.43225567857;57126.428735712114;57452.71273643605;57779.4222057774;59705.40294596998;14711.33798979027;14862.851371486147;14991.550253492413;15020.173890435693;15115.470958516398;16448.34206631769;16539.007659540464;16776;16843.24205410784;17007.744883827;14361.353739081558;14559.85440145585;14618.195999220145;14620.122792632475;14649.340779664728;13233.602991910258;13239.80140297877;13247.072704910564;13293.601191964257;13468.93265533666;13375.331233438485;13410.463581456632;13475.326233688473;13478.52825151115;13517.053806233469;10713.517891694737;10880.727981800519;10896.782064358827;10990.505427255952;11195.664130076111;10462;10594.523246453773;10791.946040269748;10998.725031874266;11051.281666691639 15:39:06 INFO - PID 5908 | __end_tp_report 15:39:06 INFO - PID 5908 | __start_cc_report 15:39:06 INFO - PID 5908 | _x_x_mozilla_cycle_collect,295 15:39:06 INFO - PID 5908 | __end_cc_report 15:39:06 INFO - PID 5908 | __startTimestamp1505687946617__endTimestamp 15:39:06 INFO - PID 5908 | 15:39:06 INFO - PID 5908 | ------- Summary: start ------- 15:39:06 INFO - PID 5908 | Number of tests: 6 15:39:06 INFO - PID 5908 | 15:39:06 INFO - PID 5908 | [#0] dojo.html Cycles:165 Average:6139.15 Median:6391.87 stddev:877.00 (13.7%) stddev-sans-first:846.84 15:39:06 INFO - PID 5908 | Values: 3108.0 3110.8 3124.1 3124.7 3142.9 6073.4 6195.0 6197.6 6228.0 6328.4 6164.6 6220.5 6220.7 6223.5 6228.0 5718.4 5799.0 5800.7 5802.6 5830.9 5767.2 5818.2 5842.9 5866.4 5906.3 71.5 5352.3 5682.7 5815.4 5873.5 5694.6 5726.8 5812.2 5827.6 5852.2 5730.9 5770.4 5808.0 5832.4 5849.9 6260.0 6261.8 6278.5 6319.0 6352.6 6516.6 6697.1 6729.3 6828.6 6835.0 6657.0 6673.0 6676.0 6678.2 6679.3 6213.9 6224.4 6299.5 6303.0 6303.3 6874.5 6933.0 6959.0 6960.9 6967.0 6539.5 6560.6 6634.5 6641.0 6650.1 6667.9 6698.5 6705.0 6781.2 6801.5 6395.2 6550.3 6621.2 6669.6 6680.4 6750.4 6778.8 6780.9 6787.4 6787.8 5294.2 5361.1 5368.1 5378.1 5379.9 4622.1 4642.3 4648.9 4651.9 4681.7 5634.4 5748.7 5758.0 5812.3 5812.8 6775.2 6795.9 6809.9 6827.7 6828.4 5743.3 5765.7 5773.0 5828.2 5833.4 5744.1 5784.7 5811.0 5834.5 5843.6 6300.9 6365.5 6394.9 6398.2 6528.6 6605.4 6619.4 6625.2 6647.9 6670.5 6348.2 6425.8 6490.4 6572.9 6577.2 6619.8 6679.1 6707.7 6715.2 6716.2 6742.6 6752.4 6754.9 6844.3 6862.5 6348.6 6462.0 6499.4 6514.8 6598.6 6558.6 6573.4 6579.2 6591.2 6610.1 6450.5 6520.5 6524.1 6530.6 6543.1 6520.7 6558.5 6621.6 6637.3 6647.0 6322.6 6336.5 6373.5 6380.8 6391.9 15:39:06 INFO - PID 5908 | 15:39:06 INFO - PID 5908 | [#1] ext.html Cycles:180 Average:36535.57 Median:3422.90 stddev:52516.72 (1534.3%) stddev-sans-first:52595.69 15:39:06 INFO - PID 5908 | Values: 851.7 880.8 881.9 884.3 887.1 41527.2 42333.9 42503.0 42558.4 42578.8 37826.0 37854.8 37953.4 37960.0 37962.0 6915.6 6998.3 7075.6 7131.1 7151.1 7046.6 7125.7 7131.2 7131.9 7151.2 7096.1 7100.6 7117.7 7121.7 7134.2 7076.7 7100.3 7101.6 7101.8 7119.8 6469.7 6522.4 6529.2 6538.5 6542.2 34096.1 34292.1 34328.0 34361.3 34371.1 3420.4 3421.7 3422.0 3423.8 3427.2 27723.3 27736.9 27752.2 27798.2 27942.2 4450.2 4689.9 4691.3 4702.4 4723.4 178269.0 180175.0 180954.0 181168.0 181866.0 22635.2 42490.0 43121.6 49720.5 50428.0 51554.0 51641.2 51907.0 51920.5 52109.0 15699.2 16007.7 16020.2 16387.9 16408.3 13245.4 13265.9 13339.3 13432.7 13441.1 13594.3 13804.2 13901.7 14025.7 14173.4 5564.4 5614.3 5626.3 5654.0 5668.9 1019.2 1028.5 1033.9 1043.7 1049.1 23341.1 23422.9 23719.5 23913.5 24062.8 1135.6 1139.7 1141.4 1158.2 1161.5 12309.0 12564.0 12758.0 12785.8 12850.3 225251.0 225873.0 226252.0 226261.0 226428.0 53992.7 54167.0 54225.5 54323.7 54530.5 1454.5 1455.5 1476.2 1477.2 1499.5 22929.7 23109.3 23151.1 23180.7 23205.4 38053.0 38150.2 38222.0 41194.0 43431.3 194143.0 197602.0 199077.0 199432.0 199483.0 33869.0 34240.5 34336.3 34430.1 34441.3 43319.0 43457.6 43498.6 43795.3 43909.6 31744.7 31789.0 32018.5 32264.0 32572.5 25748.7 25837.5 26017.6 26024.5 26168.5 35187.0 35358.1 35802.3 35900.8 36250.6 30457.8 30504.4 30750.8 30872.8 31020.2 21619.0 22884.5 22997.9 23006.5 23056.9 15:39:06 INFO - PID 5908 | 15:39:06 INFO - PID 5908 | [#2] jquery.html Cycles:180 Average:34919.14 Median:23136.21 stddev:81946.67 (354.2%) stddev-sans-first:82135.92 15:39:06 INFO - PID 5908 | Values: 547.3 559.5 573.1 577.0 596.4 22036.9 23040.5 23134.9 23137.5 23149.3 23655.4 24086.5 24387.5 25641.2 25670.7 6351.0 6542.8 6543.4 6544.2 6548.2 6386.2 6474.0 6481.9 6486.6 6492.1 6399.4 6676.7 6676.9 6681.9 6682.8 6541.7 6577.7 6580.5 6583.6 6589.0 5898.4 6052.7 6084.1 6110.5 6135.4 29121.6 29669.6 29685.0 29730.1 29749.9 1936.9 1955.8 1963.3 1963.5 1968.7 19062.7 19419.9 19673.8 19786.0 19826.0 2428.2 2466.6 2506.6 2512.6 2538.6 116990.0 122305.0 136714.3 141212.0 144722.0 14400.7 14527.3 14798.2 14916.9 14925.7 22786.2 22884.7 22937.7 23016.2 23041.2 9762.3 9783.5 9860.0 10035.5 10094.7 8951.8 9167.3 9169.9 9258.3 9348.7 8871.4 9289.3 9298.2 9320.6 9377.7 2680.7 2685.5 2696.2 2705.8 2764.6 918.9 929.1 939.8 953.6 964.6 19199.9 19394.6 19441.6 19534.5 19863.1 1014.5 1014.8 1015.8 1027.8 1031.7 10793.8 10828.2 10859.8 10948.3 10952.9 481618.0 483269.0 489619.0 491188.0 495803.0 107976.0 109450.0 110731.0 110994.0 111150.0 1028.5 1074.7 1145.3 1155.7 1187.1 21000.8 21310.7 21565.6 21566.1 21566.5 55915.2 56326.4 56498.7 56643.4 58130.1 71468.6 71526.6 75997.0 76351.2 76713.0 20118.3 20279.9 20401.6 20969.5 21008.9 22932.0 23161.9 23211.4 23231.2 23572.6 18315.8 18483.4 18909.7 19086.6 19124.0 16638.5 17187.8 17231.3 17292.7 17493.8 18189.9 18950.2 19159.0 19171.2 19592.9 20260.3 20360.7 20526.8 20627.3 20670.2 18308.4 18405.7 18455.0 18667.3 18671.9 15:39:06 INFO - PID 5908 | 15:39:06 INFO - PID 5908 | [#3] mootools.html Cycles:180 Average:9425.90 Median:26007.98 stddev:6739.89 (25.9%) stddev-sans-first:6731.06 15:39:06 INFO - PID 5908 | Values: 1287.3 1378.5 1383.1 1386.8 1387.8 14962.9 15426.2 15552.0 15612.1 15726.3 15245.5 15246.8 15252.2 15357.3 15386.9 2611.0 2747.7 2752.2 2759.5 2761.5 2492.5 2642.0 2694.9 2702.3 2705.6 2779.3 2801.9 2803.7 2808.1 2813.6 2639.8 2669.5 2674.1 2679.6 2682.6 2578.2 2611.7 2613.5 2619.9 2624.9 14774.4 15095.0 15109.1 15160.7 15192.2 7949.9 8265.0 8268.3 8272.5 8273.0 5250.9 5524.4 5588.2 5610.9 5622.7 1822.0 1839.8 1850.9 1879.4 1912.6 25684.4 25864.7 25882.9 25991.4 26024.6 6486.4 6714.1 6761.5 6880.7 6999.3 16998.2 17010.1 17031.7 17047.5 17188.1 7853.1 8139.5 8153.1 8153.2 8155.4 7203.4 7278.2 7360.5 7388.2 7393.0 5088.3 5212.0 5217.5 5236.3 5300.7 1370.9 1397.4 1522.8 1525.4 1553.6 859.9 890.1 901.6 901.9 918.4 8593.2 8654.4 8674.3 8689.5 8753.6 716.0 729.0 735.7 739.8 804.1 5115.3 5257.7 5405.7 5512.4 5645.6 21314.0 22249.4 22474.8 22539.4 22602.5 21490.1 22156.1 22368.2 22387.7 22455.4 11564.7 11640.8 11683.9 11712.4 11765.6 8058.7 8256.5 8320.6 8610.4 8687.0 18428.8 18800.2 18956.3 18998.1 19178.1 19407.4 19521.0 19523.1 19660.0 19723.2 10966.2 10989.4 11132.7 11193.7 11194.5 13420.1 13864.1 14194.0 14197.4 14220.2 11535.3 11538.4 11541.5 11564.6 11820.5 11278.0 11352.8 11444.3 11593.1 11672.2 10174.4 10234.2 10262.1 10266.7 10268.5 7330.3 7460.0 7492.6 7501.6 7533.4 6817.3 6825.5 6834.2 6842.8 6881.8 15:39:06 INFO - PID 5908 | 15:39:06 INFO - PID 5908 | [#4] prototype.html Cycles:180 Average:5429.93 Median:6104.77 stddev:1515.07 (24.8%) stddev-sans-first:1473.48 15:39:06 INFO - PID 5908 | Values: 502.2 518.7 521.8 527.4 529.5 6207.6 6234.1 6243.9 6286.9 6308.8 6122.8 6147.7 6204.0 6204.8 6217.2 5104.9 5131.2 5141.7 5182.9 5183.0 4838.7 5128.1 5131.8 5151.8 5154.8 4851.7 4878.9 4925.2 4927.7 4933.6 4884.4 4887.2 4929.1 4950.2 4957.9 4397.1 4429.9 4431.8 4435.6 4438.8 5974.7 6006.8 6061.6 6081.6 6086.8 5588.4 5636.0 5644.2 5649.3 5683.4 6428.8 6450.5 6455.8 6467.1 6492.1 4566.1 4801.2 4817.4 4836.8 4859.4 6623.2 6625.0 6690.5 6726.4 6817.6 4894.8 4910.9 4914.0 4923.6 4936.3 4981.3 4999.7 5002.6 5004.7 5005.8 5565.8 5567.9 5574.8 5576.6 5607.4 6401.9 6465.0 6484.1 6484.5 6488.8 1714.9 1720.4 1721.8 1728.6 1734.1 1131.5 1186.8 1187.9 1193.5 1221.9 5534.2 5580.1 5617.3 5660.5 5673.5 6491.9 6522.0 6556.3 6556.9 6677.6 5549.8 5559.1 5561.9 5662.2 5669.3 3428.2 3481.9 3510.7 3556.8 3557.0 6314.3 6315.0 6389.4 6424.4 6467.6 6698.9 6712.1 6791.8 6812.4 6832.2 6347.6 6352.4 6379.9 6403.4 6414.7 6055.8 6395.8 6419.6 6476.9 6550.2 6466.8 6477.4 6526.9 6539.9 6542.5 6207.1 6223.2 6274.2 6280.4 6352.9 4682.3 4824.9 4864.1 4909.5 4911.3 6377.4 6526.7 6613.1 6625.8 6631.8 6325.7 6447.5 6486.6 6501.2 6502.8 6433.7 6458.8 6463.3 6514.9 6516.2 6424.4 6436.4 6446.8 6455.3 6509.9 6385.1 6396.5 6541.4 6551.9 6582.5 6248.7 6292.4 6333.5 6351.2 6373.5 15:39:06 INFO - PID 5908 | 15:39:06 INFO - PID 5908 | [#5] yui.html Cycles:180 Average:23875.05 Median:19096.57 stddev:35538.11 (186.1%) stddev-sans-first:35595.94 15:39:06 INFO - PID 5908 | Values: 901.2 922.0 948.2 953.1 953.8 18630.3 19267.2 19377.8 19421.2 19437.3 16830.0 17260.7 17301.0 18050.3 18145.5 937.0 954.9 955.3 957.6 958.4 947.8 949.5 949.6 949.8 950.1 995.0 1040.1 1042.9 1043.2 1043.4 1031.3 1032.5 1033.6 1035.1 1036.5 719.4 725.0 743.8 747.2 747.6 18962.5 18963.9 18964.6 19228.5 19461.5 19850.6 20355.7 20367.6 20635.4 20862.8 16698.6 16983.3 16998.2 17052.1 17206.8 3605.9 3628.9 3647.1 3656.9 3656.9 135752.0 139478.0 140145.0 141058.0 143184.0 15471.7 15621.4 15683.3 15899.7 15943.9 27951.7 28198.6 29118.7 29131.4 29154.3 8363.0 8444.3 8468.4 8473.2 8476.4 3988.9 4113.7 4123.3 4139.4 4146.3 5104.9 5112.3 5157.6 5168.2 5214.0 987.8 1007.0 1007.8 1015.9 1020.7 654.8 658.2 686.9 688.5 694.1 10397.8 10768.9 10806.6 10952.7 11670.8 659.0 675.2 676.5 677.0 694.3 5298.7 5332.0 5334.4 5395.5 5411.8 115514.0 117795.4 118532.0 118924.4 122872.0 109582.0 109621.5 114151.0 114802.4 115434.4 94651.5 96859.0 97688.5 98157.0 98818.5 9864.0 10126.0 10139.9 10185.2 10258.7 43423.8 44855.1 45023.8 45577.0 46201.0 56774.4 57126.4 57452.7 57779.4 59705.4 14711.3 14862.9 14991.6 15020.2 15115.5 16448.3 16539.0 16776.0 16843.2 17007.7 14361.4 14559.9 14618.2 14620.1 14649.3 13233.6 13239.8 13247.1 13293.6 13468.9 13375.3 13410.5 13475.3 13478.5 13517.1 10713.5 10880.7 10896.8 10990.5 11195.7 10462.0 10594.5 10791.9 10998.7 11051.3 15:39:06 INFO - PID 5908 | -------- Summary: end -------- 15:39:06 INFO - PID 5908 | 15:39:07 INFO - TEST-INFO | 5908: exit 0 15:39:07 INFO - TEST-OK | dromaeo_css | took 1108058ms 15:39:07 INFO - TEST-START | kraken 15:39:07 INFO - Initialising browser for kraken test... 15:39:07 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:45905/getInfo.html -profile /tmp/tmp82SzFm/profile 15:39:07 INFO - TEST-INFO | started process 6278 (/builds/slave/test/build/application/firefox/firefox http://localhost:45905/getInfo.html) 15:39:12 INFO - TEST-INFO | 6278: exit 0 15:39:12 INFO - Browser initialized. 15:39:12 INFO - Running cycle 1/1 for kraken test... 15:39:12 INFO - Using env: {'DISPLAY': ':0', 15:39:12 INFO - 'HOME': '/home/cltbld', 15:39:12 INFO - 'JSGC_DISABLE_POISONING': '1', 15:39:12 INFO - 'LANG': 'en_US.UTF-8', 15:39:12 INFO - 'LANGUAGE': 'en_US:en', 15:39:12 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 15:39:12 INFO - 'LOGNAME': 'cltbld', 15:39:12 INFO - 'MAIL': '/var/mail/cltbld', 15:39:12 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 15:39:12 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 15:39:12 INFO - 'MOZ_CRASHREPORTER': '1', 15:39:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:39:12 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 15:39:12 INFO - 'MOZ_NO_REMOTE': '1', 15:39:12 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 15:39:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:39:12 INFO - 'NO_EM_RESTART': '1', 15:39:12 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:39:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:39:12 INFO - 'PWD': '/builds/slave/test', 15:39:12 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 15:39:12 INFO - 'RUST_BACKTRACE': 'full', 15:39:12 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 15:39:12 INFO - 'SHELL': '/bin/bash', 15:39:12 INFO - 'SHLVL': '1', 15:39:12 INFO - 'TERM': 'linux', 15:39:12 INFO - 'TMOUT': '86400', 15:39:12 INFO - 'USER': 'cltbld', 15:39:12 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1505686321.954831-1980373633', 15:39:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:39:12 INFO - '_': '/tools/buildbot/bin/python'} 15:39:12 INFO - TEST-INFO | started process 6513 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp82SzFm/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 15:39:13 INFO - PID 6513 | 15:39:13 INFO - PID 6513 | (/builds/slave/test/build/application/firefox/firefox:6563): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 15:39:13 INFO - PID 6513 | 15:39:23 INFO - PID 6513 | RSS: Main: 154218496 15:39:23 INFO - PID 6513 | 15:39:26 INFO - PID 6513 | Cycle 1(1): loaded http://localhost:45905/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:45905/tests/kraken/driver.html?testName=audio-beat-detection) 15:39:27 INFO - PID 6513 | RSS: Main: 159715328 15:39:27 INFO - PID 6513 | 15:39:30 INFO - PID 6513 | Cycle 1(1): loaded http://localhost:45905/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:45905/tests/kraken/driver.html?testName=audio-dft) 15:39:30 INFO - PID 6513 | RSS: Main: 160153600 15:39:30 INFO - PID 6513 | 15:39:33 INFO - PID 6513 | Cycle 1(1): loaded http://localhost:45905/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:45905/tests/kraken/driver.html?testName=audio-fft) 15:39:34 INFO - PID 6513 | RSS: Main: 157085696 15:39:34 INFO - PID 6513 | 15:39:36 INFO - PID 6513 | Cycle 1(1): loaded http://localhost:45905/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:45905/tests/kraken/driver.html?testName=audio-oscillator) 15:39:37 INFO - PID 6513 | RSS: Main: 157388800 15:39:37 INFO - PID 6513 | 15:39:39 INFO - PID 6513 | Cycle 1(1): loaded http://localhost:45905/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:45905/tests/kraken/driver.html?testName=imaging-gaussian-blur) 15:39:39 INFO - PID 6513 | RSS: Main: 157728768 15:39:39 INFO - PID 6513 | 15:39:42 INFO - PID 6513 | Cycle 1(1): loaded http://localhost:45905/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:45905/tests/kraken/driver.html?testName=imaging-darkroom) 15:39:43 INFO - PID 6513 | RSS: Main: 160055296 15:39:43 INFO - PID 6513 | 15:39:47 INFO - PID 6513 | Cycle 1(1): loaded http://localhost:45905/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:45905/tests/kraken/driver.html?testName=imaging-desaturate) 15:39:47 INFO - PID 6513 | RSS: Main: 160460800 15:39:47 INFO - PID 6513 | 15:39:50 INFO - PID 6513 | Cycle 1(1): loaded http://localhost:45905/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:45905/tests/kraken/driver.html?testName=json-parse-financial) 15:39:51 INFO - PID 6513 | RSS: Main: 160452608 15:39:51 INFO - PID 6513 | 15:39:53 INFO - PID 6513 | Cycle 1(1): loaded http://localhost:45905/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:45905/tests/kraken/driver.html?testName=json-stringify-tinderbox) 15:39:53 INFO - PID 6513 | RSS: Main: 160415744 15:39:53 INFO - PID 6513 | 15:39:55 INFO - PID 6513 | Cycle 1(1): loaded http://localhost:45905/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:45905/tests/kraken/driver.html?testName=stanford-crypto-aes) 15:39:55 INFO - PID 6513 | RSS: Main: 160321536 15:39:55 INFO - PID 6513 | 15:39:57 INFO - PID 6513 | Cycle 1(1): loaded http://localhost:45905/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:45905/tests/kraken/driver.html?testName=stanford-crypto-ccm) 15:39:58 INFO - PID 6513 | RSS: Main: 157720576 15:39:58 INFO - PID 6513 | 15:40:01 INFO - PID 6513 | Cycle 1(1): loaded http://localhost:45905/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:45905/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 15:40:01 INFO - PID 6513 | RSS: Main: 157929472 15:40:01 INFO - PID 6513 | 15:40:04 INFO - PID 6513 | Cycle 1(1): loaded http://localhost:45905/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:45905/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 15:40:05 INFO - PID 6513 | RSS: Main: 158326784 15:40:05 INFO - PID 6513 | 15:40:07 INFO - PID 6513 | Cycle 1(1): loaded http://localhost:45905/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:45905/tests/kraken/driver.html?testName=ai-astar) 15:40:07 INFO - PID 6513 | RSS: Main: 159444992 15:40:07 INFO - PID 6513 | 15:40:07 INFO - PID 6513 | __start_tp_report 15:40:07 INFO - PID 6513 | _x_x_mozilla_page_load 15:40:07 INFO - PID 6513 | _x_x_mozilla_page_load_details 15:40:07 INFO - PID 6513 | |i|pagename|runs| 15:40:07 INFO - PID 6513 | |0;ai-astar;108;107;108;107;108;110;107;108;107;107 15:40:07 INFO - PID 6513 | |1;audio-beat-detection;118;119;115;122;117;120;117;159;122;115 15:40:07 INFO - PID 6513 | |2;audio-dft;164;162;164;162;162;162;163;163;168;164 15:40:07 INFO - PID 6513 | |3;audio-fft;74;75;74;73;74;75;73;73;74;74 15:40:07 INFO - PID 6513 | |4;audio-oscillator;80;79;78;81;81;83;82;79;80;79 15:40:07 INFO - PID 6513 | |5;imaging-gaussian-blur;113;114;114;114;113;113;115;114;114;113 15:40:07 INFO - PID 6513 | |6;imaging-darkroom;155;149;150;148;148;147;148;148;149;148 15:40:07 INFO - PID 6513 | |7;imaging-desaturate;96;94;94;94;94;94;94;95;94;95 15:40:07 INFO - PID 6513 | |8;json-parse-financial;55;56;54;55;55;51;54;54;53;53 15:40:07 INFO - PID 6513 | |9;json-stringify-tinderbox;38;38;38;38;38;38;38;38;38;39 15:40:07 INFO - PID 6513 | |10;stanford-crypto-aes;73;73;74;73;76;74;81;75;77;74 15:40:07 INFO - PID 6513 | |11;stanford-crypto-ccm;115;117;110;112;112;118;114;111;119;116 15:40:07 INFO - PID 6513 | |12;stanford-crypto-pbkdf2;171;164;165;169;180;167;172;170;165;174 15:40:07 INFO - PID 6513 | |13;stanford-crypto-sha256-iterative;66;64;68;66;65;64;66;64;67;65 15:40:07 INFO - PID 6513 | __end_tp_report 15:40:07 INFO - PID 6513 | __start_cc_report 15:40:07 INFO - PID 6513 | _x_x_mozilla_cycle_collect,740 15:40:07 INFO - PID 6513 | __end_cc_report 15:40:07 INFO - PID 6513 | __startTimestamp1505688007343__endTimestamp 15:40:07 INFO - PID 6513 | 15:40:07 INFO - PID 6513 | ------- Summary: start ------- 15:40:07 INFO - PID 6513 | Number of tests: 14 15:40:07 INFO - PID 6513 | 15:40:07 INFO - PID 6513 | [#0] ai-astar Cycles:10 Average:107.70 Median:108.00 stddev:0.95 (0.9%) stddev-sans-first:1.00 15:40:07 INFO - PID 6513 | Values: 108.0 107.0 108.0 107.0 108.0 110.0 107.0 108.0 107.0 107.0 15:40:07 INFO - PID 6513 | 15:40:07 INFO - PID 6513 | [#1] audio-beat-detection Cycles:10 Average:122.40 Median:119.50 stddev:13.10 (11.0%) stddev-sans-first:13.80 15:40:07 INFO - PID 6513 | Values: 118.0 119.0 115.0 122.0 117.0 120.0 117.0 159.0 122.0 115.0 15:40:07 INFO - PID 6513 | 15:40:07 INFO - PID 6513 | [#2] audio-dft Cycles:10 Average:163.40 Median:163.50 stddev:1.84 (1.1%) stddev-sans-first:1.94 15:40:07 INFO - PID 6513 | Values: 164.0 162.0 164.0 162.0 162.0 162.0 163.0 163.0 168.0 164.0 15:40:07 INFO - PID 6513 | 15:40:07 INFO - PID 6513 | [#3] audio-fft Cycles:10 Average:73.90 Median:74.00 stddev:0.74 (1.0%) stddev-sans-first:0.78 15:40:07 INFO - PID 6513 | Values: 74.0 75.0 74.0 73.0 74.0 75.0 73.0 73.0 74.0 74.0 15:40:07 INFO - PID 6513 | 15:40:07 INFO - PID 6513 | [#4] audio-oscillator Cycles:10 Average:80.20 Median:80.50 stddev:1.55 (1.9%) stddev-sans-first:1.64 15:40:07 INFO - PID 6513 | Values: 80.0 79.0 78.0 81.0 81.0 83.0 82.0 79.0 80.0 79.0 15:40:07 INFO - PID 6513 | 15:40:07 INFO - PID 6513 | [#5] imaging-gaussian-blur Cycles:10 Average:113.70 Median:114.00 stddev:0.67 (0.6%) stddev-sans-first:0.67 15:40:07 INFO - PID 6513 | Values: 113.0 114.0 114.0 114.0 113.0 113.0 115.0 114.0 114.0 113.0 15:40:07 INFO - PID 6513 | 15:40:07 INFO - PID 6513 | [#6] imaging-darkroom Cycles:10 Average:149.00 Median:148.50 stddev:2.26 (1.5%) stddev-sans-first:0.87 15:40:07 INFO - PID 6513 | Values: 155.0 149.0 150.0 148.0 148.0 147.0 148.0 148.0 149.0 148.0 15:40:07 INFO - PID 6513 | 15:40:07 INFO - PID 6513 | [#7] imaging-desaturate Cycles:10 Average:94.40 Median:94.00 stddev:0.70 (0.7%) stddev-sans-first:0.44 15:40:07 INFO - PID 6513 | Values: 96.0 94.0 94.0 94.0 94.0 94.0 94.0 95.0 94.0 95.0 15:40:07 INFO - PID 6513 | 15:40:07 INFO - PID 6513 | [#8] json-parse-financial Cycles:10 Average:54.00 Median:54.50 stddev:1.41 (2.6%) stddev-sans-first:1.45 15:40:07 INFO - PID 6513 | Values: 55.0 56.0 54.0 55.0 55.0 51.0 54.0 54.0 53.0 53.0 15:40:07 INFO - PID 6513 | 15:40:07 INFO - PID 6513 | [#9] json-stringify-tinderbox Cycles:10 Average:38.10 Median:38.00 stddev:0.32 (0.8%) stddev-sans-first:0.33 15:40:07 INFO - PID 6513 | Values: 38.0 38.0 38.0 38.0 38.0 38.0 38.0 38.0 38.0 39.0 15:40:07 INFO - PID 6513 | 15:40:07 INFO - PID 6513 | [#10] stanford-crypto-aes Cycles:10 Average:75.00 Median:74.50 stddev:2.49 (3.3%) stddev-sans-first:2.54 15:40:07 INFO - PID 6513 | Values: 73.0 73.0 74.0 73.0 76.0 74.0 81.0 75.0 77.0 74.0 15:40:07 INFO - PID 6513 | 15:40:07 INFO - PID 6513 | [#11] stanford-crypto-ccm Cycles:10 Average:114.40 Median:115.50 stddev:3.10 (2.7%) stddev-sans-first:3.28 15:40:07 INFO - PID 6513 | Values: 115.0 117.0 110.0 112.0 112.0 118.0 114.0 111.0 119.0 116.0 15:40:07 INFO - PID 6513 | 15:40:07 INFO - PID 6513 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:169.70 Median:170.50 stddev:4.90 (2.9%) stddev-sans-first:5.17 15:40:07 INFO - PID 6513 | Values: 171.0 164.0 165.0 169.0 180.0 167.0 172.0 170.0 165.0 174.0 15:40:07 INFO - PID 6513 | 15:40:07 INFO - PID 6513 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.50 Median:66.00 stddev:1.35 (2.1%) stddev-sans-first:1.42 15:40:07 INFO - PID 6513 | Values: 66.0 64.0 68.0 66.0 65.0 64.0 66.0 64.0 67.0 65.0 15:40:07 INFO - PID 6513 | -------- Summary: end -------- 15:40:07 INFO - PID 6513 | 15:40:07 INFO - PID 6513 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 15:40:07 INFO - TEST-INFO | 6513: exit 0 15:40:07 INFO - TEST-OK | kraken | took 60711ms 15:40:07 INFO - SUITE-END | took 1168s 15:40:08 INFO - Completed test suite (00:19:28) 15:40:08 INFO - javascript benchmark 15:40:08 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8401.962969495427, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3107.984460077699, 3110.782245242834, 3124.0940127363074, 3124.7031532004466, 3142.8585713642883, 6073.423024812647, 6195.0, 6197.59715618485, 6228.0, 6328.430441260286, 6164.568480206376, 6220.4712599428985, 6220.720067596958, 6223.502119830414, 6228.0, 5718.428157184269, 5798.971005144968, 5800.738966746486, 5802.622829516089, 5830.854228644275, 5767.163761254616, 5818.214541036969, 5842.912356314659, 5866.413358664142, 5906.26171728534, 71.45859029449974, 5352.277442545265, 5682.715864206773, 5815.389384114649, 5873.471387575118, 5694.629849059839, 5726.828195154152, 5812.215350927613, 5827.621204621729, 5852.209951656514, 5730.914036289459, 5770.365259821417, 5808.012637851575, 5832.4459176378605, 5849.912251316191, 6259.967105427599, 6261.812145635638, 6278.497720182374, 6318.968405157945, 6352.555321127523, 6516.641584712839, 6697.062411262427, 6729.287661491036, 6828.624425656587, 6835.008923706085, 6657.0, 6673.0, 6675.966620166917, 6678.232003319583, 6679.298673639247, 6213.906791398133, 6224.439800417984, 6299.527535434815, 6303.0, 6303.338149494283, 6874.518783685094, 6933.0, 6958.965205173941, 6960.895586566206, 6967.0, 6539.50953678476, 6560.573562718503, 6634.535582509275, 6640.966795165993, 6650.102236198148, 6667.933320666828, 6698.497612679069, 6705.0, 6781.186257649114, 6801.523893327519, 6395.20059992501, 6550.312217217219, 6621.172353455818, 6669.599824010575, 6680.3987641112535, 6750.35871592198, 6778.76274330406, 6780.932190678129, 6787.389134977777, 6787.830304242433, 5294.232336311214, 5361.08861493547, 5368.141097424394, 5378.058839703036, 5379.946200537945, 4622.098690755271, 4642.326862604971, 4648.930266046012, 4651.906961860812, 4681.7190968542, 5634.408387119293, 5748.655080695172, 5758.0, 5812.3025236971835, 5812.796552120655, 6775.186977562724, 6795.898061529081, 6809.863802723918, 6827.658617069127, 6828.419584335387, 5743.282089738783, 5765.711714414347, 5773.04744717117, 5828.242328497268, 5833.38749431312, 5744.052231381859, 5784.652920824764, 5810.970945145332, 5834.504067154339, 5843.649381037151, 6300.936990630126, 6365.522585806083, 6394.904076438857, 6398.200224971879, 6528.608283503005, 6605.438537724347, 6619.4373478252965, 6625.204975402982, 6647.900281495685, 6670.466362690876, 6348.174737284124, 6425.775097871552, 6490.350964903472, 6572.934270657232, 6577.210734711865, 6619.834504137435, 6679.098321726699, 6707.698153583003, 6715.227748808754, 6716.1604799400075, 6742.595444273359, 6752.3922846944015, 6754.932450675627, 6844.349786770249, 6862.519623626298, 6348.619082854859, 6462.030695395728, 6499.447546958561, 6514.804555863332, 6598.60408375499, 6558.639274839738, 6573.408393244631, 6579.243387010555, 6591.176102987127, 6610.140681711347, 6450.48396128318, 6520.543561950618, 6524.119243902012, 6530.575512591667, 6543.149390579194, 6520.739170433129, 6558.540902136995, 6621.635810030494, 6637.303083176197, 6647.0, 6322.589031713108, 6336.482583342917, 6373.521985850987, 6380.808575742735, 6391.872162556816], "value": 6076.105156417935, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [851.6593362654937, 880.784207869072, 881.9073997230295, 884.310238014349, 887.050855584524, 41527.169456610885, 42333.94165145869, 42503.0, 42558.36162457566, 42578.787106064425, 37826.0, 37854.81072594633, 37953.430698539545, 37960.0, 37962.0, 6915.619640919747, 6998.265182155877, 7075.646217689121, 7131.0729605151255, 7151.070360853082, 7046.612436316001, 7125.714971401164, 7131.215566287704, 7131.89302160468, 7151.177614574312, 7096.112985876765, 7100.6449677516175, 7117.679704413288, 7121.679524421387, 7134.17956934954, 7076.6815493302665, 7100.28997100291, 7101.579684063182, 7101.786946391565, 7119.75080872167, 6469.708863101125, 6522.445592124628, 6529.151210342625, 6538.476921846241, 6542.214934207926, 34096.147596310046, 34292.14269643279, 34328.0, 34361.312773744634, 34371.14072148217, 3420.350133474632, 3421.726261899042, 3422.0076177908377, 3423.7945723256685, 3427.211741299515, 27723.306917327027, 27736.861315693495, 27752.167434976982, 27798.16605501838, 27942.161735147976, 4450.2434586120435, 4689.88275293117, 4691.272852707802, 4702.388689470347, 4723.385959825235, 178269.0, 180175.0, 180954.0, 181168.0, 181866.0, 22635.20776772838, 42490.0, 43121.568784311756, 49720.50279497231, 50428.0, 51554.0, 51641.225381619304, 51907.0, 51920.480795191565, 52109.0, 15699.215039247993, 16007.679846403007, 16020.19899005045, 16387.918060409622, 16408.26162822676, 13245.403956821967, 13265.933670331586, 13339.333033348294, 13432.664183395493, 13441.059125861097, 13594.320283985959, 13804.17174969505, 13901.652458688412, 14025.719485610434, 14173.433062677377, 5564.360098588714, 5614.2701448811395, 5626.2685850839125, 5653.971730141405, 5668.943310566841, 1019.1897441533998, 1028.5217373921162, 1033.8604288420968, 1043.7077618266896, 1049.1239814754765, 23341.066357345517, 23422.882885585805, 23719.525609487715, 23913.52172956566, 24062.796860156923, 1135.647949135754, 1139.7036770439745, 1141.3836528274805, 1158.195054437158, 1161.4599211366756, 12309.0, 12564.0, 12758.0, 12785.808212876815, 12850.293233872228, 225251.0, 225873.0, 226252.0, 226261.0, 226428.0, 53992.73003635035, 54167.0, 54225.45774542204, 54323.72838135784, 54530.45469545333, 1454.4691187716196, 1455.548779878241, 1476.1659662290986, 1477.1727832413667, 1499.5426394949645, 22929.65605515952, 23109.306720798402, 23151.073957041528, 23180.652290215996, 23205.41986450352, 38053.0, 38150.23699526049, 38222.0, 41194.0, 43431.34852977271, 194143.0, 197602.0, 199077.0, 199432.0, 199483.0, 33869.0, 34240.48639270363, 34336.313273734886, 34430.13924651904, 34441.311173776885, 43319.0, 43457.565424345354, 43498.565014350716, 43795.343069854614, 43909.56090439182, 31744.682553174174, 31789.0, 32018.51972220372, 32264.032079037668, 32572.51141232931, 25748.742512575383, 25837.483250335263, 26017.6097358536, 26024.52766987133, 26168.476630466903, 35187.0, 35358.11604709903, 35802.28395432025, 35900.82049589735, 36250.63749362472, 30457.847710761303, 30504.389912202074, 30750.84624576863, 30872.84563577168, 31020.22449438692, 21619.0, 22884.542309154058, 22997.88501057484, 23006.539869202858, 23056.884715576314], "value": 16601.373728510203, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [547.3267880506976, 559.5020431815682, 573.0802062689386, 576.9711514424278, 596.439347013807, 22036.88981555092, 23040.539189216226, 23134.88432557839, 23137.537249255005, 23149.30552083436, 23655.40861478464, 24086.5182696346, 24387.51224975504, 25641.23076307714, 25670.74329256707, 6350.983842585176, 6542.803715888531, 6543.443807276387, 6544.214694236698, 6548.1814773153355, 6386.1697979262635, 6474.0, 6481.902771458432, 6486.61080335179, 6492.09110724499, 6399.424051835334, 6676.699548520304, 6676.899846502306, 6681.866362672744, 6682.799516014503, 6541.705623246941, 6577.704003319838, 6580.473562115019, 6583.637899915503, 6589.04458853466, 5898.41015898411, 6052.697365131726, 6084.117802918597, 6110.511159107261, 6135.447809697149, 29121.56317655237, 29669.554956675667, 29685.0, 29730.108096757132, 29749.851250743824, 1936.893470859102, 1955.7946415626297, 1963.3128405058258, 1963.4502339344863, 1968.7046942958527, 19062.714059289123, 19419.902900485547, 19673.803261967485, 19786.0, 19826.0, 2428.247243354566, 2466.605343145106, 2506.6240063990367, 2512.5979843224995, 2538.6192071189284, 116990.0, 122304.99999999911, 136714.3164284182, 141212.0, 144722.0, 14400.67979606135, 14527.339319352723, 14798.186099764616, 14916.942026884462, 14925.70148597022, 22786.202482913017, 22884.65673014906, 22937.655935160987, 23016.194433195094, 23041.193558225383, 9762.267829912786, 9783.510824458748, 9859.950700246452, 10035.548400322003, 10094.747631309276, 8951.820963580692, 9167.26661867049, 9169.908300916906, 9258.259339252843, 9348.672796452227, 8871.423357481743, 9289.303302252358, 9298.209652179641, 9320.627174913063, 9377.671781487616, 2680.654427376046, 2685.501087368573, 2696.2046196372116, 2705.8241214321006, 2764.5853122031453, 918.8713580098791, 929.1405449958761, 939.8261321655516, 953.6376177052675, 964.628617982082, 19199.904000480186, 19394.612107757766, 19441.56465568796, 19534.511637209183, 19863.106160222535, 1014.4826138669184, 1014.7564584499667, 1015.8476228565775, 1027.773889744255, 1031.6750223679517, 10793.78412431747, 10828.187885908588, 10859.78280434387, 10948.288361256493, 10952.890471095187, 481618.0, 483269.0, 489619.0, 491188.0, 495803.0, 107976.0, 109450.0, 110731.0, 110994.0, 111150.0, 1028.5114570578914, 1074.7152004718755, 1145.3471521232984, 1155.7110722319587, 1187.0859438232512, 21000.789992099883, 21310.680339794606, 21565.568688626452, 21566.137354505645, 21566.460838479165, 55915.161272581754, 56326.43673563376, 56498.717506412206, 56643.433565663814, 58130.12804808016, 71468.64265678638, 71526.64236678783, 75997.0, 76351.2364876344, 76713.0, 20118.29585964484, 20279.898600506902, 20401.59196816085, 20969.475763105434, 21008.894955525124, 22932.0, 23161.884190578938, 23211.419714507272, 23231.186908458123, 23572.6464103042, 18315.816841831413, 18483.445496635122, 18909.71635425497, 19086.61826763429, 19124.0, 16638.50084497467, 17187.828121718623, 17231.310747570456, 17292.654146917244, 17493.82506174973, 18189.909050454662, 18950.24199032023, 19159.0, 19171.233150674376, 19592.902035489733, 20260.290889818785, 20360.69458958087, 20526.794732053088, 20627.278045268344, 20670.17319307271, 18308.359207427675, 18405.723914141032, 18455.0, 18667.253309867454, 18671.906640467256], "value": 12194.062742524397, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1287.2919894058266, 1378.5450801235593, 1383.0940733819352, 1386.757317469443, 1387.840398354189, 14962.925185374072, 15426.151561664117, 15552.0, 15612.141332226738, 15726.29231684574, 15245.54263372098, 15246.771298430533, 15252.237388130605, 15357.308921098549, 15386.923065384657, 2610.9738902611016, 2747.6565429321336, 2752.160591019748, 2759.503289407906, 2761.4753196892525, 2492.4516606346574, 2641.960370594443, 2694.8517831519357, 2702.3244188952763, 2705.5671092625184, 2779.3190668286297, 2801.90193343233, 2803.663560372758, 2808.0873716042265, 2813.563897595876, 2639.802014848894, 2669.532831754445, 2674.0507119972517, 2679.598060290962, 2682.6110214018954, 2578.181186915645, 2611.720257074039, 2613.46423983083, 2619.869006549665, 2624.8556329401877, 14774.409023639042, 15095.0, 15109.093454392772, 15160.696786064216, 15192.240387980557, 7949.88075178867, 8265.0, 8268.297194738454, 8272.462289951134, 8273.0, 5250.9474905250845, 5524.364698059734, 5588.245586845765, 5610.859728506779, 5622.690752008638, 1821.9726704099448, 1839.8252166044203, 1850.9074546272632, 1879.4079864842531, 1912.5601111744377, 25684.357891052874, 25864.74135258642, 25882.87058564714, 25991.350216244555, 26024.609630855364, 6486.351364863476, 6714.127163468718, 6761.526693131434, 6880.69036893341, 6999.335063168991, 16998.150092495325, 17010.149492525325, 17031.65936681284, 17047.48857534276, 17188.140592970303, 7853.096893857165, 8139.4709343892455, 8153.103158652543, 8153.22544358285, 8155.388345874083, 7203.423726101899, 7278.235785242579, 7360.521566098187, 7388.224236455202, 7393.03890494243, 5088.338515992971, 5211.973940130275, 5217.50433708797, 5236.319278493771, 5300.655457395257, 1370.8903287736957, 1397.4130865036507, 1522.8020357353694, 1525.42034027069, 1553.603831023082, 859.9054104048549, 890.1321211818555, 901.5717534171347, 901.8692289617969, 918.4076270805426, 8593.183647553473, 8654.394192406597, 8674.306055515544, 8689.478631282016, 8753.606087726068, 715.989260161098, 728.9854202915913, 735.6615956659889, 739.789160089372, 804.1435870797582, 5115.258287548285, 5257.658252213594, 5405.675659460445, 5512.39363669996, 5645.576581756384, 21314.0, 22249.443763905707, 22474.775252247597, 22539.43651408728, 22602.547949040927, 21490.14039438405, 22156.1137554496, 22368.217112400987, 22387.664185037236, 22455.438614034454, 11564.710882228012, 11640.825387619192, 11683.883161168449, 11712.414379281003, 11765.588204412805, 8058.717944871902, 8256.504609723435, 8320.583970801557, 8610.354223433142, 8686.956565217133, 18428.815711843246, 18800.15399307007, 18956.336528221447, 18998.145083471554, 19178.13698383604, 19407.417777466697, 19521.023948802787, 19523.12145953464, 19660.0, 19723.211071556976, 10966.232363734782, 10989.395583242998, 11132.721681958015, 11193.720156995814, 11194.496247668712, 13420.127691700009, 13864.098833576189, 14194.006419550533, 14197.361118749888, 14220.21788801626, 11535.307881527135, 11538.423078845855, 11541.480633371351, 11564.595239166589, 11820.527178912747, 11278.0, 11352.772944540899, 11444.313341199555, 11593.072554195813, 11672.241304315192, 10174.389536627827, 10234.181265498892, 10262.076413122855, 10266.691999240034, 10268.537915793957, 7330.286523097668, 7459.962700186465, 7492.625368731433, 7501.5874126923545, 7533.427654783466, 6817.284185160685, 6825.522213445011, 6834.248232694499, 6842.828929276808, 6881.793546193622], "value": 6672.124383023129, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [502.1789374372899, 518.7043385270398, 521.7599904044141, 527.3961314295132, 529.5419462165228, 6207.627542347463, 6234.127222188891, 6243.875122497553, 6286.905696414546, 6308.842278943029, 6122.785702500413, 6147.661878596676, 6204.0, 6204.844878878019, 6217.222847144107, 5104.93250233656, 5131.230315452674, 5141.717205553693, 5182.922256166151, 5183.024296675197, 4838.685485443435, 5128.102582048145, 5131.794728210867, 5151.76817043232, 5154.819581314655, 4851.708897466146, 4878.853634390974, 4925.211966085427, 4927.6550641455115, 4933.629977751665, 4884.413870335547, 4887.169181239198, 4929.1374009548545, 4950.232713929347, 4957.925631115536, 4397.142557201347, 4429.933550996738, 4431.800568974404, 4435.556444355571, 4438.778061096932, 5974.715436181242, 6006.789762358297, 6061.636301821904, 6081.597768881267, 6086.756529738849, 5588.385277619499, 5636.0, 5644.181593668936, 5649.322081350264, 5683.374828768832, 6428.8071357859335, 6450.4839612830865, 6455.8063258101865, 6467.126937863422, 6492.123563318939, 4566.13243483737, 4801.15979703554, 4817.445993710698, 4836.806527738886, 4859.392575928009, 6623.205215374186, 6625.0, 6690.531662783607, 6726.394624483771, 6817.625030623314, 4894.828680996148, 4910.8772280693265, 4913.975430122827, 4923.630727695438, 4936.284238785356, 4981.277714731416, 4999.725015124203, 5002.59979201663, 5004.674696144739, 5005.77474013663, 5565.777368905198, 5567.860803479945, 5574.777008919597, 5576.6096373254295, 5607.383187849415, 6401.9039714404325, 6464.967675161594, 6484.124643173205, 6484.513661475408, 6488.805335839932, 1714.8799584028998, 1720.3892618120638, 1721.7761690980092, 1728.6197036651915, 1734.0722713348298, 1131.5417256011328, 1186.7745128425572, 1187.9049676025897, 1193.4748710567324, 1221.8961388282096, 5534.169874518774, 5580.135079062752, 5617.32592088952, 5660.5471562274915, 5673.489385955201, 6491.902621460682, 6521.967390163114, 6556.311587283362, 6556.901646475307, 6677.629441548181, 5549.750261238254, 5559.082751345983, 5561.888762224733, 5662.150677398341, 5669.319681638147, 3428.211511352403, 3481.8781342652887, 3510.6824051271306, 3556.8399422026073, 3556.964430355715, 6314.273858506239, 6314.968425157845, 6389.424951754364, 6424.389682980202, 6467.641795222962, 6698.8611935971, 6712.12742343502, 6791.830204244835, 6812.352826481477, 6832.180138383326, 6347.587406818542, 6352.428281454691, 6379.864209311456, 6403.391677790602, 6414.679266036679, 6055.775314497282, 6395.776147834804, 6419.550631455753, 6476.902846457213, 6550.181227346582, 6466.805995820133, 6477.4494167996245, 6526.869462610816, 6539.869202615826, 6542.54202205841, 6207.099676016746, 6223.222097237845, 6274.247090349188, 6280.410434713201, 6352.9047064295, 4682.274247491644, 4824.903501930012, 4864.124457597666, 4909.5090490950615, 4911.287863259736, 6377.426031657174, 6526.692383027179, 6613.14029176204, 6625.768098116543, 6631.834204144935, 6325.698525003042, 6447.548671592944, 6486.632379181659, 6501.187351581052, 6502.837429064311, 6433.710483028181, 6458.773942911976, 6463.3213512580505, 6514.869702606016, 6516.152900122954, 6424.421802037839, 6436.356364363526, 6446.774362897276, 6455.289918109098, 6509.8698026040165, 6385.13800636908, 6396.520260980352, 6541.443977261795, 6551.901721474277, 6582.473402127914, 6248.718807653576, 6292.433680968735, 6333.524985626189, 6351.2060992375955, 6373.521985850987], "value": 4985.016927000027, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [901.2474583722591, 921.9769505762355, 948.2082461144944, 953.0612346838363, 953.7615596100975, 18630.25478980839, 19267.229310827584, 19377.806221937793, 19421.223151073977, 19437.31969381072, 16830.0, 17260.74108888368, 17300.999999999967, 18050.27798888043, 18145.546361340974, 936.962521499141, 954.9045095490465, 955.3360414511917, 957.5930229652405, 958.3914214473824, 947.8483442649177, 949.4777872170313, 949.5584553182769, 949.8337790886602, 950.1021534649759, 994.9850752238722, 1040.1159014837403, 1042.9426381549013, 1043.191526566909, 1043.3635482355794, 1031.2781053262745, 1032.4837581209358, 1033.560736686905, 1035.0942924940678, 1036.533559898049, 719.3957076056138, 725.0284618611033, 743.8103283662631, 747.2452822649163, 747.6112421540822, 18962.52593685155, 18963.905180474147, 18964.62070758577, 19228.519287017796, 19461.513462163417, 19850.60298794016, 20355.69466458004, 20367.592648147103, 20635.380938571867, 20862.791372086387, 16698.56148538255, 16983.3206671733, 16998.235079421454, 17052.14739263032, 17206.827931720647, 3605.927881442383, 3628.89113326598, 3647.1429214134923, 3656.8537258509896, 3656.945145822815, 135752.0, 139478.0, 140145.0, 141058.0, 143183.99999999895, 15471.690566188614, 15621.375144994074, 15683.294251758698, 15899.682006359808, 15943.920280398524, 27951.720482795317, 28198.577021344696, 29118.7088129116, 29131.41737165287, 29154.271143221165, 8362.958185209034, 8444.324454043784, 8468.364872634576, 8473.237408633253, 8476.364272679573, 3988.940165897514, 4113.670906327547, 4123.340265557556, 4139.4204811326435, 4146.315857883415, 5104.948950510522, 5112.309838171799, 5157.638965272395, 5168.224766285088, 5214.035403450373, 987.782687808681, 1007.0, 1007.8387458006683, 1015.898410158993, 1020.6580795433613, 654.8461111638761, 658.1772784019975, 686.9313068693191, 688.4526801193064, 694.0838093716246, 10397.776689226364, 10768.892311076946, 10806.567737290421, 10952.726181845517, 11670.766584668429, 658.980230593083, 675.1729131813587, 676.5433332500543, 677.0, 694.3369082526175, 5298.682079075268, 5331.973340133352, 5334.439883812144, 5395.487428694268, 5411.756470958816, 115514.0, 117795.41102294605, 118532.0, 118924.40537797428, 122872.0, 109582.0, 109621.45189274002, 114151.0, 114802.42598786953, 115434.38262469575, 94651.52674236585, 96859.0, 97688.51155744176, 98157.0, 98818.50590747144, 9864.0, 10126.038026387481, 10139.898601013896, 10185.236107291834, 10258.743531411475, 43423.78288108539, 44855.10289794121, 45023.774881125384, 45577.0, 46201.0, 56774.43225567857, 57126.428735712114, 57452.71273643605, 57779.4222057774, 59705.40294596998, 14711.33798979027, 14862.851371486147, 14991.550253492413, 15020.173890435693, 15115.470958516398, 16448.34206631769, 16539.007659540464, 16776.0, 16843.24205410784, 17007.744883827, 14361.353739081558, 14559.85440145585, 14618.195999220145, 14620.122792632475, 14649.340779664728, 13233.602991910258, 13239.80140297877, 13247.072704910564, 13293.601191964257, 13468.93265533666, 13375.331233438485, 13410.463581456632, 13475.326233688473, 13478.52825151115, 13517.053806233469, 10713.517891694737, 10880.727981800519, 10896.782064358827, 10990.505427255952, 11195.664130076111, 10462.0, 10594.523246453773, 10791.946040269748, 10998.725031874266, 11051.281666691639], "value": 8598.253531031543, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1421.4000000000003, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [108.0, 107.0, 108.0, 107.0, 108.0, 110.0, 107.0, 108.0, 107.0, 107.0], "value": 107.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 119.0, 115.0, 122.0, 117.0, 120.0, 117.0, 159.0, 122.0, 115.0], "value": 122.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 162.0, 164.0, 162.0, 162.0, 162.0, 163.0, 163.0, 168.0, 164.0], "value": 163.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 75.0, 74.0, 73.0, 74.0, 75.0, 73.0, 73.0, 74.0, 74.0], "value": 73.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 79.0, 78.0, 81.0, 81.0, 83.0, 82.0, 79.0, 80.0, 79.0], "value": 80.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 114.0, 114.0, 114.0, 113.0, 113.0, 115.0, 114.0, 114.0, 113.0], "value": 113.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [155.0, 149.0, 150.0, 148.0, 148.0, 147.0, 148.0, 148.0, 149.0, 148.0], "value": 149.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 94.0, 94.0, 94.0, 94.0, 94.0, 94.0, 95.0, 94.0, 95.0], "value": 94.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 56.0, 54.0, 55.0, 55.0, 51.0, 54.0, 54.0, 53.0, 53.0], "value": 54.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [38.0, 38.0, 38.0, 38.0, 38.0, 38.0, 38.0, 38.0, 38.0, 39.0], "value": 38.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 73.0, 74.0, 73.0, 76.0, 74.0, 81.0, 75.0, 77.0, 74.0], "value": 75.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 117.0, 110.0, 112.0, 112.0, 118.0, 114.0, 111.0, 119.0, 116.0], "value": 114.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [171.0, 164.0, 165.0, 169.0, 180.0, 167.0, 172.0, 170.0, 165.0, 174.0], "value": 169.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 64.0, 68.0, 66.0, 65.0, 64.0, 66.0, 64.0, 67.0, 65.0], "value": 65.5, "unit": "score"}]}]} 15:40:08 INFO - Return code: 0 15:40:08 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 15:40:08 INFO - # TBPL SUCCESS # 15:40:08 INFO - Running post-action listener: _package_coverage_data 15:40:08 INFO - Running post-action listener: _resource_record_post_action 15:40:08 INFO - [mozharness: 2017-09-17 22:40:08.144525Z] Finished run-tests step (success) 15:40:08 INFO - Running post-run listener: _resource_record_post_run 15:40:08 INFO - Total resource usage - Wall time: 1187s; CPU: 13.0%; Read bytes: 425984; Write bytes: 340246528; Read time: 52; Write time: 277644 15:40:08 INFO - TinderboxPrint: CPU usage
13.1% 15:40:08 INFO - TinderboxPrint: I/O read bytes / time
425,984 / 52 15:40:08 INFO - TinderboxPrint: I/O write bytes / time
340,246,528 / 277,644 15:40:08 INFO - TinderboxPrint: CPU idle
8,221.7 (86.9%) 15:40:08 INFO - TinderboxPrint: CPU user
1,190.7 (12.6%) 15:40:08 INFO - TinderboxPrint: Swap in / out
0 / 0 15:40:08 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 13021184; Read time: 0; Write time: 1392 15:40:08 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 15:40:08 INFO - run-tests - Wall time: 1169s; CPU: 13.0%; Read bytes: 421888; Write bytes: 327225344; Read time: 48; Write time: 276252 15:40:08 INFO - Running post-run listener: _upload_blobber_files 15:40:08 INFO - Blob upload gear active. 15:40:08 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 15:40: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 15:40: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-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 15:40: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-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 15:40:09 INFO - (blobuploader) - INFO - Open directory for files ... 15:40:09 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 15:40:09 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:40:09 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:40:10 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 15:40:10 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:40:10 INFO - (blobuploader) - INFO - Done attempting. 15:40:10 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 15:40:10 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:40:10 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:40:17 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 15:40:17 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:40:17 INFO - (blobuploader) - INFO - Done attempting. 15:40:17 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 15:40:17 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:40:17 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:40:18 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 15:40:18 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:40:18 INFO - (blobuploader) - INFO - Done attempting. 15:40:18 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 15:40:18 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:40:18 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:40:19 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 15:40:19 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:40:19 INFO - (blobuploader) - INFO - Done attempting. 15:40:19 INFO - (blobuploader) - INFO - Iteration through files over. 15:40:19 INFO - Return code: 0 15:40:19 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 15:40:19 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 15:40:19 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/47c2567a6634a74b77a4dc8b34c1f49df936cc867f91f7d7f0886e90cbfdeb4bef6a540691730f22791bb49e84edd8a1466f1e72a859255a3299fa7abbae94a1", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/f04120f1a20faf97d62104b69a9c8ff2477e7c1f24d1c558d3fc89981c4ca8a16509b79defce1948f45f82e5cd67ecea45ba1df1bb18b6e9aa3ca4a1c48720a2", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/da33e30b75f594f3cef983e3bf4fcfd427ce2e9d22bacfb7c964938b4d39b600f4452af9db9b956dc85f814e061c44428b94a28f197a694376a314c9dd1dd836", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/81abd868fc7d433140cd935f2eea0981257896c94834825a073d52f2aa4b69c61ae4a5233d1f63a1704368642e4e67df6484acff9ab606a651f7332e26c6b4b3"} 15:40:19 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 15:40:19 INFO - Writing to file /builds/slave/test/properties/blobber_files 15:40:19 INFO - Contents: 15:40:19 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/47c2567a6634a74b77a4dc8b34c1f49df936cc867f91f7d7f0886e90cbfdeb4bef6a540691730f22791bb49e84edd8a1466f1e72a859255a3299fa7abbae94a1", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/f04120f1a20faf97d62104b69a9c8ff2477e7c1f24d1c558d3fc89981c4ca8a16509b79defce1948f45f82e5cd67ecea45ba1df1bb18b6e9aa3ca4a1c48720a2", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/da33e30b75f594f3cef983e3bf4fcfd427ce2e9d22bacfb7c964938b4d39b600f4452af9db9b956dc85f814e061c44428b94a28f197a694376a314c9dd1dd836", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/81abd868fc7d433140cd935f2eea0981257896c94834825a073d52f2aa4b69c61ae4a5233d1f63a1704368642e4e67df6484acff9ab606a651f7332e26c6b4b3"} 15:40:19 INFO - Running post-run listener: copy_logs_to_upload_dir 15:40:19 INFO - Copying logs to upload dir... 15:40:19 INFO - mkdir: /builds/slave/test/build/upload/logs 15:40:19 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1240.575413 ========= master_lag: 0.23 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 40 secs) (at 2017-09-17 15:40:19.976930) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-17 15:40:19.981692) ========= 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=05b19d94dfa9f3ce7b6e62cc000001f7-1505686321.954831-1980373633 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/47c2567a6634a74b77a4dc8b34c1f49df936cc867f91f7d7f0886e90cbfdeb4bef6a540691730f22791bb49e84edd8a1466f1e72a859255a3299fa7abbae94a1", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/f04120f1a20faf97d62104b69a9c8ff2477e7c1f24d1c558d3fc89981c4ca8a16509b79defce1948f45f82e5cd67ecea45ba1df1bb18b6e9aa3ca4a1c48720a2", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/da33e30b75f594f3cef983e3bf4fcfd427ce2e9d22bacfb7c964938b4d39b600f4452af9db9b956dc85f814e061c44428b94a28f197a694376a314c9dd1dd836", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/81abd868fc7d433140cd935f2eea0981257896c94834825a073d52f2aa4b69c61ae4a5233d1f63a1704368642e4e67df6484acff9ab606a651f7332e26c6b4b3"} build_url:https://queue.taskcluster.net/v1/task/Mt_FquQNTb2zZxQoyb7pNg/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011368 build_url: 'https://queue.taskcluster.net/v1/task/Mt_FquQNTb2zZxQoyb7pNg/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/47c2567a6634a74b77a4dc8b34c1f49df936cc867f91f7d7f0886e90cbfdeb4bef6a540691730f22791bb49e84edd8a1466f1e72a859255a3299fa7abbae94a1", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/f04120f1a20faf97d62104b69a9c8ff2477e7c1f24d1c558d3fc89981c4ca8a16509b79defce1948f45f82e5cd67ecea45ba1df1bb18b6e9aa3ca4a1c48720a2", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/da33e30b75f594f3cef983e3bf4fcfd427ce2e9d22bacfb7c964938b4d39b600f4452af9db9b956dc85f814e061c44428b94a28f197a694376a314c9dd1dd836", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/81abd868fc7d433140cd935f2eea0981257896c94834825a073d52f2aa4b69c61ae4a5233d1f63a1704368642e4e67df6484acff9ab606a651f7332e26c6b4b3"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-17 15:40:20.009452) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-17 15:40:20.009766) ========= 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=05b19d94dfa9f3ce7b6e62cc000001f7-1505686321.954831-1980373633 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004560 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-17 15:40:20.092743) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-17 15:40:20.093050) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-17 15:40:20.093372) ========= ========= Total master_lag: 0.54 =========