builder: mozilla-beta_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-011 starttime: 1506454395.41 results: success (0) revision: 520e300d1266d19aea623eb723587acc03751d50 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-09-26 12:33:15.414599) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-09-26 12:33:15.415312) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-26 12:33:15.415589) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-26 12:33:15.463013) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-26 12:33:15.463268) ========= 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=5cf47e208febbcd81da23b2e0000026f-1506453608.174477-904915991 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-09-26 12:33:15-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 46.6M=0s 2017-09-26 12:33:15 (46.6 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.146237 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-26 12:33:15.626002) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-26 12:33:15.626330) ========= 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=5cf47e208febbcd81da23b2e0000026f-1506453608.174477-904915991 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018800 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-26 12:33:15.679255) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-26 12:33:15.679588) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 520e300d1266d19aea623eb723587acc03751d50 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 520e300d1266d19aea623eb723587acc03751d50 --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=5cf47e208febbcd81da23b2e0000026f-1506453608.174477-904915991 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-09-26 12:33:15,722 truncating revision to first 12 chars 2017-09-26 12:33:15,722 Setting DEBUG logging. 2017-09-26 12:33:15,722 attempt 1/10 2017-09-26 12:33:15,722 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/520e300d1266?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-09-26 12:33:16,003 unpacking tar archive at: mozilla-beta-520e300d1266/testing/mozharness/ program finished with exit code 0 elapsedTime=0.580670 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-26 12:33:16.276192) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-26 12:33:16.276487) ========= script_repo_revision: 520e300d1266d19aea623eb723587acc03751d50 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-26 12:33:16.279882) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-26 12:33:16.280162) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-26 12:33:16.297214) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 35 secs) (at 2017-09-26 12:33:16.297762) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Beta-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta-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', 'Mozilla-Beta-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Beta-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=5cf47e208febbcd81da23b2e0000026f-1506453608.174477-904915991 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 12:33:16 INFO - MultiFileLogger online at 20170926 12:33:16 in /builds/slave/test 12:33:16 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Beta-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta-Non-PGO 12:33:16 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 12:33:16 INFO - {'append_to_log': False, 12:33:16 INFO - 'base_work_dir': '/builds/slave/test', 12:33:16 INFO - 'blob_upload_branch': 'Mozilla-Beta-Non-PGO', 12:33:16 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 12:33:16 INFO - 'branch': 'Mozilla-Beta-Non-PGO', 12:33:16 INFO - 'buildbot_json_path': 'buildprops.json', 12:33:16 INFO - 'code_coverage': False, 12:33:16 INFO - 'config_files': ('talos/linux_config.py',), 12:33:16 INFO - 'default_actions': ('clobber', 12:33:16 INFO - 'read-buildbot-config', 12:33:16 INFO - 'download-and-extract', 12:33:16 INFO - 'populate-webroot', 12:33:16 INFO - 'create-virtualenv', 12:33:16 INFO - 'install', 12:33:16 INFO - 'setup-mitmproxy', 12:33:16 INFO - 'run-tests'), 12:33:16 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 12:33:16 INFO - 'disable_ccov_upload': False, 12:33:16 INFO - 'disable_stylo': False, 12:33:16 INFO - 'download_minidump_stackwalk': True, 12:33:16 INFO - 'download_symbols': 'ondemand', 12:33:16 INFO - 'enable_stylo': False, 12:33:16 INFO - 'enable_webrender': False, 12:33:16 INFO - 'exes': {'tooltool.py': '/tools/tooltool.py'}, 12:33:16 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 12:33:16 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 12:33:16 INFO - 'gecko_profile': False, 12:33:16 INFO - 'gecko_profile_interval': 0, 12:33:16 INFO - 'installer_path': 'installer.exe', 12:33:16 INFO - 'log_level': 'info', 12:33:16 INFO - 'log_name': 'talos', 12:33:16 INFO - 'log_to_console': True, 12:33:16 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 12:33:16 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 12:33:16 INFO - 'opt_config_files': (), 12:33:16 INFO - 'pip_index': False, 12:33:16 INFO - 'suite': 'dromaeojs-e10s', 12:33:16 INFO - 'system_bits': '32', 12:33:16 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 12:33:16 INFO - 'title': 'talos-linux64-ix-011', 12:33:16 INFO - 'tooltool_cache': '/builds/tooltool_cache', 12:33:16 INFO - 'use_talos_json': True, 12:33:16 INFO - 'verify': 'False', 12:33:16 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 12:33:16 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 12:33:16 INFO - 'work_dir': 'build'} 12:33:16 INFO - [mozharness: 2017-09-26 19:33:16.494083Z] Running clobber step. 12:33:16 INFO - Running pre-action listener: _resource_record_pre_action 12:33:16 INFO - Running main action method: clobber 12:33:16 INFO - rmtree: /builds/slave/test/build 12:33:16 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 12:33:17 INFO - Running post-action listener: _resource_record_post_action 12:33:17 INFO - [mozharness: 2017-09-26 19:33:17.492248Z] Finished clobber step (success) 12:33:17 INFO - [mozharness: 2017-09-26 19:33:17.492346Z] Running read-buildbot-config step. 12:33:17 INFO - Running pre-action listener: _resource_record_pre_action 12:33:17 INFO - Running main action method: read_buildbot_config 12:33:17 INFO - Using buildbot properties: 12:33:17 INFO - { 12:33:17 INFO - "project": "", 12:33:17 INFO - "product": "firefox", 12:33:17 INFO - "who": "ryanvm@gmail.com", 12:33:17 INFO - "installer_path": "public/build/target.tar.bz2", 12:33:17 INFO - "builddir": "mozilla-beta_ubuntu64_hw_test-dromaeojs-e10s", 12:33:17 INFO - "repository": "https://hg.mozilla.org/releases/mozilla-beta", 12:33:17 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-beta talos dromaeojs-e10s", 12:33:17 INFO - "stage_platform": "linux64", 12:33:17 INFO - "basedir": "/builds/slave/test", 12:33:17 INFO - "buildnumber": 129, 12:33:17 INFO - "platform": "ubuntu64_hw", 12:33:17 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 12:33:17 INFO - "slavebuilddir": "test", 12:33:17 INFO - "taskId": "AO40xLIkSGOP6e9sL3SWBA", 12:33:17 INFO - "branch": "mozilla-beta", 12:33:17 INFO - "script_repo_revision": "production", 12:33:17 INFO - "revision": "520e300d1266d19aea623eb723587acc03751d50", 12:33:17 INFO - "slavename": "talos-linux64-ix-011", 12:33:17 INFO - "repo_path": "releases/mozilla-beta" 12:33:17 INFO - } 12:33:17 INFO - Finding installer, test and symbols from parent task. 12:33:17 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/AO40xLIkSGOP6e9sL3SWBA'}, attempt #1 12:33:17 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/AO40xLIkSGOP6e9sL3SWBA'}, attempt #1 12:33:18 INFO - Task dependencies: I1eCh6_kSp-ZjFnEQUHzVw 12:33:18 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/I1eCh6_kSp-ZjFnEQUHzVw'}, attempt #1 12:33:18 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/I1eCh6_kSp-ZjFnEQUHzVw/artifacts/public/build/target.tar.bz2 12:33:18 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/I1eCh6_kSp-ZjFnEQUHzVw/artifacts/public/build/target.test_packages.json 12:33:18 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/I1eCh6_kSp-ZjFnEQUHzVw/artifacts/public/build/target.crashreporter-symbols.zip 12:33:18 INFO - Running post-action listener: _resource_record_post_action 12:33:18 INFO - [mozharness: 2017-09-26 19:33:18.884668Z] Finished read-buildbot-config step (success) 12:33:18 INFO - [mozharness: 2017-09-26 19:33:18.884884Z] Running download-and-extract step. 12:33:18 INFO - Running pre-action listener: _resource_record_pre_action 12:33:18 INFO - Running main action method: download_and_extract 12:33:18 INFO - mkdir: /builds/slave/test/build/tests 12:33: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')]} 12:33:18 INFO - trying https://queue.taskcluster.net/v1/task/I1eCh6_kSp-ZjFnEQUHzVw/artifacts/public/build/target.test_packages.json 12:33:18 INFO - Downloading https://queue.taskcluster.net/v1/task/I1eCh6_kSp-ZjFnEQUHzVw/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 12:33:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/I1eCh6_kSp-ZjFnEQUHzVw/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 12:33:19 INFO - Downloaded 989 bytes. 12:33:19 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 12:33:19 INFO - Using the following test package requirements: 12:33:19 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 12:33:19 INFO - u'common': [u'target.common.tests.zip'], 12:33:19 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 12:33:19 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 12:33:19 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 12:33:19 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 12:33:19 INFO - u'mozbase': [u'target.common.tests.zip'], 12:33:19 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 12:33:19 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 12:33:19 INFO - u'web-platform': [u'target.common.tests.zip', 12:33:19 INFO - u'target.web-platform.tests.tar.gz'], 12:33:19 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 12:33:19 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite categories: ['common', 'talos'] 12:33:19 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/I1eCh6_kSp-ZjFnEQUHzVw/artifacts/public/build/target.common.tests.zip 12:33:19 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/I1eCh6_kSp-ZjFnEQUHzVw/artifacts/public/build/target.common.tests.zip'}, attempt #1 12:33:19 INFO - Fetch https://queue.taskcluster.net/v1/task/I1eCh6_kSp-ZjFnEQUHzVw/artifacts/public/build/target.common.tests.zip into memory 12:33:21 INFO - Content-Length response header: 55184549 12:33:21 INFO - Bytes received: 55184549 12:33:32 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/I1eCh6_kSp-ZjFnEQUHzVw/artifacts/public/build/target.talos.tests.zip 12:33:32 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/I1eCh6_kSp-ZjFnEQUHzVw/artifacts/public/build/target.talos.tests.zip'}, attempt #1 12:33:32 INFO - Fetch https://queue.taskcluster.net/v1/task/I1eCh6_kSp-ZjFnEQUHzVw/artifacts/public/build/target.talos.tests.zip into memory 12:33:33 INFO - Content-Length response header: 14509184 12:33:33 INFO - Bytes received: 14509184 12:33:34 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')]} 12:33:34 INFO - trying https://queue.taskcluster.net/v1/task/I1eCh6_kSp-ZjFnEQUHzVw/artifacts/public/build/target.tar.bz2 12:33:34 INFO - Downloading https://queue.taskcluster.net/v1/task/I1eCh6_kSp-ZjFnEQUHzVw/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 12:33:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/I1eCh6_kSp-ZjFnEQUHzVw/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 12:33:36 INFO - Downloaded 53488252 bytes. 12:33:36 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/I1eCh6_kSp-ZjFnEQUHzVw/artifacts/public/build/target.tar.bz2 12:33:36 INFO - mkdir: /builds/slave/test/properties 12:33:36 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 12:33:36 INFO - Writing to file /builds/slave/test/properties/build_url 12:33:36 INFO - Contents: 12:33:36 INFO - build_url:https://queue.taskcluster.net/v1/task/I1eCh6_kSp-ZjFnEQUHzVw/artifacts/public/build/target.tar.bz2 12:33:36 INFO - Running post-action listener: _resource_record_post_action 12:33:36 INFO - Running post-action listener: find_tests_for_verification 12:33:36 INFO - Running post-action listener: set_extra_try_arguments 12:33:36 INFO - [mozharness: 2017-09-26 19:33:36.418195Z] Finished download-and-extract step (success) 12:33:36 INFO - [mozharness: 2017-09-26 19:33:36.418403Z] Running populate-webroot step. 12:33:36 INFO - Running pre-action listener: _resource_record_pre_action 12:33:36 INFO - Running main action method: populate_webroot 12:33:36 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 12:33:36 INFO - 'chromez-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 12:33:36 INFO - 'tests': ['tresize', 12:33:36 INFO - 'tcanvasmark']}, 12:33:36 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 12:33:36 INFO - 'dromaeojs-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 12:33:36 INFO - 'tests': ['dromaeo_css', 12:33:36 INFO - 'kraken']}, 12:33:36 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 12:33:36 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:33:36 INFO - 'g1-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 12:33:36 INFO - 'talos_options': ['--disable-stylo'], 12:33:36 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:33:36 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 12:33:36 INFO - 'tests': ['damp', 'tps']}, 12:33:36 INFO - 'g2-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 12:33:36 INFO - 'talos_options': ['--disable-stylo'], 12:33:36 INFO - 'tests': ['damp', 'tps']}, 12:33:36 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 12:33:36 INFO - 'g3-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 12:33:36 INFO - 'tests': ['dromaeo_dom']}, 12:33:36 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 12:33:36 INFO - 'g4-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 12:33:36 INFO - 'tests': ['basic_compositor_video', 12:33:36 INFO - 'glvideo']}, 12:33:36 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 12:33:36 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 12:33:36 INFO - 'g5-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 12:33:36 INFO - 'talos_options': ['--disable-stylo'], 12:33:36 INFO - 'tests': ['ts_paint_webext', 12:33:36 INFO - 'tp5o_webext']}, 12:33:36 INFO - 'other-e10s': {'tests': ['a11yr', 12:33:36 INFO - 'ts_paint', 12:33:36 INFO - 'tpaint', 12:33:36 INFO - 'sessionrestore', 12:33:36 INFO - 'sessionrestore_many_windows', 12:33:36 INFO - 'sessionrestore_no_auto_restore', 12:33:36 INFO - 'tabpaint']}, 12:33:36 INFO - 'other-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 12:33:36 INFO - 'tests': ['a11yr', 12:33:36 INFO - 'ts_paint', 12:33:36 INFO - 'tpaint', 12:33:36 INFO - 'sessionrestore', 12:33:36 INFO - 'sessionrestore_many_windows', 12:33:36 INFO - 'sessionrestore_no_auto_restore', 12:33:36 INFO - 'tabpaint']}, 12:33:36 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 12:33:36 INFO - 'perf-reftest-singletons-e10s': {'tests': ['perf_reftest_singletons']}, 12:33:36 INFO - 'perf-reftest-singletons-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 12:33:36 INFO - 'tests': ['perf_reftest_singletons']}, 12:33:36 INFO - 'perf-reftest-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 12:33:36 INFO - 'tests': ['bloom_basic']}, 12:33:36 INFO - 'svgr-e10s': {'tests': ['tsvgx', 12:33:36 INFO - 'tsvgr_opacity', 12:33:36 INFO - 'tart', 12:33:36 INFO - 'tscrollx', 12:33:36 INFO - 'tsvg_static']}, 12:33:36 INFO - 'svgr-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 12:33:36 INFO - 'tests': ['tsvgx', 12:33:36 INFO - 'tsvgr_opacity', 12:33:36 INFO - 'tart', 12:33:36 INFO - 'tscrollx', 12:33:36 INFO - 'tsvg_static']}, 12:33:36 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 12:33:36 INFO - 'tp5o-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 12:33:36 INFO - 'talos_options': ['--disable-stylo'], 12:33:36 INFO - 'tests': ['tp5o']}, 12:33:36 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 12:33:36 INFO - 'talos_options': ['--mitmproxy', 12:33:36 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 12:33:36 INFO - '--firstNonBlankPaint'], 12:33:36 INFO - 'tests': ['tp6_google', 12:33:36 INFO - 'tp6_youtube', 12:33:36 INFO - 'tp6_amazon', 12:33:36 INFO - 'tp6_facebook']}, 12:33:36 INFO - 'tp6-stylo-disabled-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 12:33:36 INFO - 'talos_options': ['--disable-stylo', 12:33:36 INFO - '--mitmproxy', 12:33:36 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 12:33:36 INFO - '--firstNonBlankPaint'], 12:33:36 INFO - 'tests': ['tp6_google', 12:33:36 INFO - 'tp6_youtube', 12:33:36 INFO - 'tp6_amazon', 12:33:36 INFO - 'tp6_facebook']}, 12:33:36 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 12:33:36 INFO - 'talos_options': ['--stylo-threads=1', 12:33:36 INFO - '--mitmproxy', 12:33:36 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 12:33:36 INFO - '--firstNonBlankPaint'], 12:33:36 INFO - 'tests': ['tp6_google', 12:33:36 INFO - 'tp6_youtube', 12:33:36 INFO - 'tp6_amazon', 12:33:36 INFO - 'tp6_facebook']}, 12:33:36 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 12:33:36 INFO - 'talos_options': ['--xperf_path', 12:33:36 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:33:36 INFO - 'tests': ['tp5n']}, 12:33:36 INFO - 'xperf-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 12:33:36 INFO - 'talos_options': ['--disable-stylo', 12:33:36 INFO - '--xperf_path', 12:33:36 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:33:36 INFO - 'tests': ['tp5n']}}} 12:33:36 INFO - Running post-action listener: _resource_record_post_action 12:33:36 INFO - [mozharness: 2017-09-26 19:33:36.435198Z] Finished populate-webroot step (success) 12:33:36 INFO - [mozharness: 2017-09-26 19:33:36.435287Z] Running create-virtualenv step. 12:33:36 INFO - Running pre-action listener: _resource_record_pre_action 12:33:36 INFO - Running main action method: create_virtualenv 12:33:36 INFO - Creating virtualenv /builds/slave/test/build/venv 12:33:36 INFO - Running command: ['virtualenv', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 12:33:36 INFO - Copy/paste: virtualenv --no-site-packages --distribute /builds/slave/test/build/venv 12:33:36 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 12:33:36 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 12:33:36 INFO - New python executable in /builds/slave/test/build/venv/bin/python 12:33:37 INFO - Installing distribute.............................................................................................................................................................................................done. 12:33:37 INFO - Installing pip...............done. 12:33:37 INFO - Return code: 0 12:33:37 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 12:33:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 12:33:37 INFO - Reading from file tmpfile_stdout 12:33:37 INFO - Output received: 12:33:37 INFO - pip 1.1 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.1-py2.7.egg (python 2.7) 12:33:37 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 12:33:37 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')]} 12:33:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:33:37 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')]} 12:33:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:33:37 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/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 0xa961f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc5ea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe01a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe05090>, '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 0xe05d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdfff90>, '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': '5cf47e208febbcd81da23b2e0000026f-1506453608.174477-904915991', '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 12:33:37 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 12:33:37 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 12:33:37 INFO - Using env: {'DISPLAY': ':0', 12:33:37 INFO - 'HOME': '/home/cltbld', 12:33:37 INFO - 'LANG': 'en_US.UTF-8', 12:33:37 INFO - 'LANGUAGE': 'en_US:en', 12:33:37 INFO - 'LOGNAME': 'cltbld', 12:33:37 INFO - 'MAIL': '/var/mail/cltbld', 12:33:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:33:37 INFO - 'MOZ_NO_REMOTE': '1', 12:33:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:33:37 INFO - 'NO_EM_RESTART': '1', 12:33:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:33:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:33:37 INFO - 'PWD': '/builds/slave/test', 12:33:37 INFO - 'SHELL': '/bin/bash', 12:33:37 INFO - 'SHLVL': '1', 12:33:37 INFO - 'TERM': 'linux', 12:33:37 INFO - 'TMOUT': '86400', 12:33:37 INFO - 'USER': 'cltbld', 12:33:37 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1506453608.174477-904915991', 12:33:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:33:37 INFO - '_': '/tools/buildbot/bin/python'} 12:33:38 INFO - Ignoring indexes: http://pypi.python.org/simple/ 12:33:38 INFO - Downloading/unpacking pip>=1.5 12:33:38 INFO - Running setup.py egg_info for package pip 12:33:38 INFO - warning: no files found matching 'pip/cacert.pem' 12:33:38 INFO - warning: no files found matching '*.html' under directory 'docs' 12:33:38 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 12:33:38 INFO - no previously-included directories found matching 'docs/_build/_sources' 12:33:38 INFO - Installing collected packages: pip 12:33:38 INFO - Found existing installation: pip 1.1 12:33:38 INFO - Uninstalling pip: 12:33:38 INFO - Successfully uninstalled pip 12:33:38 INFO - Running setup.py install for pip 12:33:38 INFO - warning: no files found matching 'pip/cacert.pem' 12:33:38 INFO - warning: no files found matching '*.html' under directory 'docs' 12:33:38 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 12:33:38 INFO - no previously-included directories found matching 'docs/_build/_sources' 12:33:38 INFO - Installing pip script to /builds/slave/test/build/venv/bin 12:33:38 INFO - Installing pip2.7 script to /builds/slave/test/build/venv/bin 12:33:38 INFO - Installing pip2 script to /builds/slave/test/build/venv/bin 12:33:38 INFO - Successfully installed pip 12:33:38 INFO - Cleaning up... 12:33:38 INFO - Return code: 0 12:33:38 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 12:33: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')]} 12:33:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:33: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')]} 12:33:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:33:38 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/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 0xa961f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc5ea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe01a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe05090>, '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 0xe05d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdfff90>, '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': '5cf47e208febbcd81da23b2e0000026f-1506453608.174477-904915991', '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 12:33:38 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 12:33:38 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 12:33:38 INFO - Using env: {'DISPLAY': ':0', 12:33:38 INFO - 'HOME': '/home/cltbld', 12:33:38 INFO - 'LANG': 'en_US.UTF-8', 12:33:38 INFO - 'LANGUAGE': 'en_US:en', 12:33:38 INFO - 'LOGNAME': 'cltbld', 12:33:38 INFO - 'MAIL': '/var/mail/cltbld', 12:33:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:33:38 INFO - 'MOZ_NO_REMOTE': '1', 12:33:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:33:38 INFO - 'NO_EM_RESTART': '1', 12:33:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:33:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:33:38 INFO - 'PWD': '/builds/slave/test', 12:33:38 INFO - 'SHELL': '/bin/bash', 12:33:38 INFO - 'SHLVL': '1', 12:33:38 INFO - 'TERM': 'linux', 12:33:38 INFO - 'TMOUT': '86400', 12:33:38 INFO - 'USER': 'cltbld', 12:33:38 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1506453608.174477-904915991', 12:33:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:33:38 INFO - '_': '/tools/buildbot/bin/python'} 12:33:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:33:38 INFO - Downloading/unpacking psutil>=3.1.1 12:33:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:33:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:33:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:33:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:33:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 12:33:40 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:33:40 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:33:40 INFO - Installing collected packages: psutil 12:33:40 INFO - Running setup.py install for psutil 12:33:40 INFO - building 'psutil._psutil_linux' extension 12:33:40 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 12:33:40 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 12:33:40 INFO - building 'psutil._psutil_posix' extension 12:33:40 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 12:33:40 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 12:33:40 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:33:40 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:33:40 INFO - Successfully installed psutil 12:33:40 INFO - Cleaning up... 12:33:40 INFO - Return code: 0 12:33:40 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 12:33:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:33:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:33:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:33:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:33:40 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 0xa961f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc5ea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe01a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe05090>, '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 0xe05d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdfff90>, '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': '5cf47e208febbcd81da23b2e0000026f-1506453608.174477-904915991', '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 12:33:40 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 12:33:40 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 12:33:40 INFO - Using env: {'DISPLAY': ':0', 12:33:40 INFO - 'HOME': '/home/cltbld', 12:33:40 INFO - 'LANG': 'en_US.UTF-8', 12:33:40 INFO - 'LANGUAGE': 'en_US:en', 12:33:40 INFO - 'LOGNAME': 'cltbld', 12:33:40 INFO - 'MAIL': '/var/mail/cltbld', 12:33:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:33:40 INFO - 'MOZ_NO_REMOTE': '1', 12:33:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:33:40 INFO - 'NO_EM_RESTART': '1', 12:33:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:33:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:33:40 INFO - 'PWD': '/builds/slave/test', 12:33:40 INFO - 'SHELL': '/bin/bash', 12:33:40 INFO - 'SHLVL': '1', 12:33:40 INFO - 'TERM': 'linux', 12:33:40 INFO - 'TMOUT': '86400', 12:33:40 INFO - 'USER': 'cltbld', 12:33:40 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1506453608.174477-904915991', 12:33:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:33:40 INFO - '_': '/tools/buildbot/bin/python'} 12:33:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:33:40 INFO - Downloading/unpacking mozsystemmonitor==0.3 12:33:40 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 12:33:40 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 12:33:40 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 12:33:40 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 12:33:43 INFO - Downloading mozsystemmonitor-0.3.tar.gz 12:33:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 12:33:43 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 12:33:43 INFO - Installing collected packages: mozsystemmonitor 12:33:43 INFO - Running setup.py install for mozsystemmonitor 12:33:43 INFO - Successfully installed mozsystemmonitor 12:33:43 INFO - Cleaning up... 12:33:43 INFO - Return code: 0 12:33:43 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 12:33:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:33:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:33:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:33:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:33:43 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0xa961f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc5ea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe01a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe05090>, '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 0xe05d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdfff90>, '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': '5cf47e208febbcd81da23b2e0000026f-1506453608.174477-904915991', '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 12:33:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 12:33:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 12:33:43 INFO - Using env: {'DISPLAY': ':0', 12:33:43 INFO - 'HOME': '/home/cltbld', 12:33:43 INFO - 'LANG': 'en_US.UTF-8', 12:33:43 INFO - 'LANGUAGE': 'en_US:en', 12:33:43 INFO - 'LOGNAME': 'cltbld', 12:33:43 INFO - 'MAIL': '/var/mail/cltbld', 12:33:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:33:43 INFO - 'MOZ_NO_REMOTE': '1', 12:33:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:33:43 INFO - 'NO_EM_RESTART': '1', 12:33:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:33:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:33:43 INFO - 'PWD': '/builds/slave/test', 12:33:43 INFO - 'SHELL': '/bin/bash', 12:33:43 INFO - 'SHLVL': '1', 12:33:43 INFO - 'TERM': 'linux', 12:33:43 INFO - 'TMOUT': '86400', 12:33:43 INFO - 'USER': 'cltbld', 12:33:43 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1506453608.174477-904915991', 12:33:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:33:43 INFO - '_': '/tools/buildbot/bin/python'} 12:33:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:33:44 INFO - Downloading/unpacking jsonschema==2.5.1 12:33:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:33:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:33:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:33:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:33:45 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 12:33:45 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 12:33:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:33:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:33:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:33:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:33:46 INFO - Downloading functools32-3.2.3-2.tar.gz 12:33:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 12:33:46 INFO - warning: no files found matching '*.txt' 12:33:46 INFO - no previously-included directories found matching 'build' 12:33:46 INFO - no previously-included directories found matching 'dist' 12:33:46 INFO - no previously-included directories found matching '.git*' 12:33:46 INFO - Installing collected packages: jsonschema, functools32 12:33:46 INFO - Running setup.py install for functools32 12:33:46 INFO - warning: no files found matching '*.txt' 12:33:46 INFO - no previously-included directories found matching 'build' 12:33:46 INFO - no previously-included directories found matching 'dist' 12:33:46 INFO - no previously-included directories found matching '.git*' 12:33:46 INFO - Successfully installed jsonschema functools32 12:33:46 INFO - Cleaning up... 12:33:46 INFO - Return code: 0 12:33:46 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 12:33:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:33:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:33:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:33:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:33:46 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0xa961f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc5ea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe01a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe05090>, '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 0xe05d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdfff90>, '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': '5cf47e208febbcd81da23b2e0000026f-1506453608.174477-904915991', '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 12:33:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 12:33:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 12:33:46 INFO - Using env: {'DISPLAY': ':0', 12:33:46 INFO - 'HOME': '/home/cltbld', 12:33:46 INFO - 'LANG': 'en_US.UTF-8', 12:33:46 INFO - 'LANGUAGE': 'en_US:en', 12:33:46 INFO - 'LOGNAME': 'cltbld', 12:33:46 INFO - 'MAIL': '/var/mail/cltbld', 12:33:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:33:46 INFO - 'MOZ_NO_REMOTE': '1', 12:33:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:33:46 INFO - 'NO_EM_RESTART': '1', 12:33:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:33:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:33:46 INFO - 'PWD': '/builds/slave/test', 12:33:46 INFO - 'SHELL': '/bin/bash', 12:33:46 INFO - 'SHLVL': '1', 12:33:46 INFO - 'TERM': 'linux', 12:33:46 INFO - 'TMOUT': '86400', 12:33:46 INFO - 'USER': 'cltbld', 12:33:46 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1506453608.174477-904915991', 12:33:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:33:46 INFO - '_': '/tools/buildbot/bin/python'} 12:33:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:33:46 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 12:33:46 INFO - Cleaning up... 12:33:46 INFO - Return code: 0 12:33:46 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 12:33:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:33:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:33:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:33:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:33:46 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0xa961f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc5ea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe01a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe05090>, '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 0xe05d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdfff90>, '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': '5cf47e208febbcd81da23b2e0000026f-1506453608.174477-904915991', '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 12:33:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 12:33:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 12:33:46 INFO - Using env: {'DISPLAY': ':0', 12:33:46 INFO - 'HOME': '/home/cltbld', 12:33:46 INFO - 'LANG': 'en_US.UTF-8', 12:33:46 INFO - 'LANGUAGE': 'en_US:en', 12:33:46 INFO - 'LOGNAME': 'cltbld', 12:33:46 INFO - 'MAIL': '/var/mail/cltbld', 12:33:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:33:46 INFO - 'MOZ_NO_REMOTE': '1', 12:33:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:33:46 INFO - 'NO_EM_RESTART': '1', 12:33:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:33:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:33:46 INFO - 'PWD': '/builds/slave/test', 12:33:46 INFO - 'SHELL': '/bin/bash', 12:33:46 INFO - 'SHLVL': '1', 12:33:46 INFO - 'TERM': 'linux', 12:33:46 INFO - 'TMOUT': '86400', 12:33:46 INFO - 'USER': 'cltbld', 12:33:46 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1506453608.174477-904915991', 12:33:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:33:46 INFO - '_': '/tools/buildbot/bin/python'} 12:33:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:33:46 INFO - Downloading/unpacking blobuploader==1.2.4 12:33:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:33:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:33:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:33:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:33:47 INFO - Downloading blobuploader-1.2.4.tar.gz 12:33:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 12:33:47 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 12:33:47 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 12:33:47 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 12:33:47 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 12:33:47 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 12:33:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 12:33:48 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 12:33:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:33:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:33:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:33:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:33:48 INFO - Downloading docopt-0.6.1.tar.gz 12:33:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 12:33:48 INFO - Installing collected packages: blobuploader, requests, docopt 12:33:48 INFO - Running setup.py install for blobuploader 12:33:48 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 12:33:48 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 12:33:48 INFO - Running setup.py install for requests 12:33:48 INFO - Running setup.py install for docopt 12:33:49 INFO - Successfully installed blobuploader requests docopt 12:33:49 INFO - Cleaning up... 12:33:49 INFO - Return code: 0 12:33:49 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:33:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:33:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:33:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:33:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:33:49 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 0xa961f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc5ea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe01a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe05090>, '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 0xe05d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdfff90>, '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': '5cf47e208febbcd81da23b2e0000026f-1506453608.174477-904915991', '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 12:33:49 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 12:33:49 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 12:33:49 INFO - Using env: {'DISPLAY': ':0', 12:33:49 INFO - 'HOME': '/home/cltbld', 12:33:49 INFO - 'LANG': 'en_US.UTF-8', 12:33:49 INFO - 'LANGUAGE': 'en_US:en', 12:33:49 INFO - 'LOGNAME': 'cltbld', 12:33:49 INFO - 'MAIL': '/var/mail/cltbld', 12:33:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:33:49 INFO - 'MOZ_NO_REMOTE': '1', 12:33:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:33:49 INFO - 'NO_EM_RESTART': '1', 12:33:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:33:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:33:49 INFO - 'PWD': '/builds/slave/test', 12:33:49 INFO - 'SHELL': '/bin/bash', 12:33:49 INFO - 'SHLVL': '1', 12:33:49 INFO - 'TERM': 'linux', 12:33:49 INFO - 'TMOUT': '86400', 12:33:49 INFO - 'USER': 'cltbld', 12:33:49 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1506453608.174477-904915991', 12:33:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:33:49 INFO - '_': '/tools/buildbot/bin/python'} 12:33:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:33:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:33:49 INFO - Running setup.py (path:/tmp/pip-1qyo0b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:33:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:33:49 INFO - Running setup.py (path:/tmp/pip-ecV9fG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:33:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:33:49 INFO - Running setup.py (path:/tmp/pip-RHwSp0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:33:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:33:49 INFO - Running setup.py (path:/tmp/pip-6E0mVz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:33:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:33:49 INFO - Running setup.py (path:/tmp/pip-Ub4QqB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:33:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:33:49 INFO - Running setup.py (path:/tmp/pip-QyPxSt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:33:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:33:49 INFO - Running setup.py (path:/tmp/pip-mUokBm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:33:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:33:49 INFO - Running setup.py (path:/tmp/pip-8ShxiN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:33:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:33:49 INFO - Running setup.py (path:/tmp/pip-IOrGXU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:33:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:33:49 INFO - Running setup.py (path:/tmp/pip-XflJjB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:33:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:33:49 INFO - Running setup.py (path:/tmp/pip-RBmZ3U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:33:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:33:50 INFO - Running setup.py (path:/tmp/pip-gwD7y4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:33:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:33:50 INFO - Running setup.py (path:/tmp/pip-V8nv_C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:33:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:33:50 INFO - Running setup.py (path:/tmp/pip-ExIAWT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:33:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:33:50 INFO - Running setup.py (path:/tmp/pip-kYLBOp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:33:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:33:50 INFO - Running setup.py (path:/tmp/pip-Yn_8d6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:33:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:33:50 INFO - Running setup.py (path:/tmp/pip-nWI4hf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:33:50 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 12:33:50 INFO - Running setup.py install for manifestparser 12:33:50 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 12:33:50 INFO - Running setup.py install for mozcrash 12:33:50 INFO - Running setup.py install for mozdebug 12:33:50 INFO - Running setup.py install for mozdevice 12:33:50 INFO - Installing dm script to /builds/slave/test/build/venv/bin 12:33:50 INFO - Running setup.py install for mozfile 12:33:50 INFO - Running setup.py install for mozhttpd 12:33:51 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 12:33:51 INFO - Running setup.py install for mozinfo 12:33:51 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 12:33:51 INFO - Running setup.py install for mozInstall 12:33:51 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 12:33:51 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 12:33:51 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 12:33:51 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 12:33:51 INFO - Running setup.py install for mozleak 12:33:51 INFO - Running setup.py install for mozlog 12:33:51 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 12:33:51 INFO - Running setup.py install for moznetwork 12:33:51 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 12:33:51 INFO - Running setup.py install for mozprocess 12:33:51 INFO - Running setup.py install for mozprofile 12:33:51 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 12:33:51 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 12:33:51 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 12:33:51 INFO - Running setup.py install for mozrunner 12:33:51 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 12:33:51 INFO - Running setup.py install for mozscreenshot 12:33:52 INFO - Running setup.py install for moztest 12:33:52 INFO - Running setup.py install for mozversion 12:33:52 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 12:33:52 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 12:33:52 INFO - Cleaning up... 12:33:52 INFO - Return code: 0 12:33:52 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:33:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:33:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:33:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:33:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:33:52 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 0xa961f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc5ea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe01a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe05090>, '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 0xe05d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdfff90>, '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': '5cf47e208febbcd81da23b2e0000026f-1506453608.174477-904915991', '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 12:33:52 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 12:33:52 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 12:33:52 INFO - Using env: {'DISPLAY': ':0', 12:33:52 INFO - 'HOME': '/home/cltbld', 12:33:52 INFO - 'LANG': 'en_US.UTF-8', 12:33:52 INFO - 'LANGUAGE': 'en_US:en', 12:33:52 INFO - 'LOGNAME': 'cltbld', 12:33:52 INFO - 'MAIL': '/var/mail/cltbld', 12:33:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:33:52 INFO - 'MOZ_NO_REMOTE': '1', 12:33:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:33:52 INFO - 'NO_EM_RESTART': '1', 12:33:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:33:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:33:52 INFO - 'PWD': '/builds/slave/test', 12:33:52 INFO - 'SHELL': '/bin/bash', 12:33:52 INFO - 'SHLVL': '1', 12:33:52 INFO - 'TERM': 'linux', 12:33:52 INFO - 'TMOUT': '86400', 12:33:52 INFO - 'USER': 'cltbld', 12:33:52 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1506453608.174477-904915991', 12:33:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:33:52 INFO - '_': '/tools/buildbot/bin/python'} 12:33:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:33:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:33:52 INFO - Running setup.py (path:/tmp/pip-8LDdXe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:33:52 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)) 12:33:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:33:52 INFO - Running setup.py (path:/tmp/pip-nZV22x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:33:52 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)) 12:33:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:33:52 INFO - Running setup.py (path:/tmp/pip-ffPiXQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:33:52 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)) 12:33:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:33:52 INFO - Running setup.py (path:/tmp/pip-DpjlKG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:33:52 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)) 12:33:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:33:52 INFO - Running setup.py (path:/tmp/pip-yLgk2J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:33:52 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)) 12:33:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:33:52 INFO - Running setup.py (path:/tmp/pip-g91X8C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:33:52 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)) 12:33:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:33:52 INFO - Running setup.py (path:/tmp/pip-MPsT64-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:33:52 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)) 12:33:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:33:52 INFO - Running setup.py (path:/tmp/pip-3kafPb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:33:53 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)) 12:33:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:33:53 INFO - Running setup.py (path:/tmp/pip-yIObAh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:33:53 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)) 12:33:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:33:53 INFO - Running setup.py (path:/tmp/pip-csm0oM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:33:53 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)) 12:33:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:33:53 INFO - Running setup.py (path:/tmp/pip-BNBv9l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:33:53 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)) 12:33:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:33:53 INFO - Running setup.py (path:/tmp/pip-U6ek4n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:33:53 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)) 12:33:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:33:53 INFO - Running setup.py (path:/tmp/pip-SAStc6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:33:53 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)) 12:33:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:33:53 INFO - Running setup.py (path:/tmp/pip-jj04t5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:33:53 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)) 12:33:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:33:53 INFO - Running setup.py (path:/tmp/pip-0YRn5e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:33:53 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)) 12:33:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:33:53 INFO - Running setup.py (path:/tmp/pip-3hjUXT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:33:53 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)) 12:33:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:33:53 INFO - Running setup.py (path:/tmp/pip-49sya1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:33:53 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)) 12:33:53 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)) 12:33:53 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)) 12:33:53 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)) 12:33:53 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)) 12:33:53 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)) 12:33:53 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)) 12:33:53 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 12:33:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:33:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:33:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:33:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:33:54 INFO - Downloading blessings-1.6.tar.gz 12:33:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 12:33:54 INFO - Installing collected packages: blessings 12:33:54 INFO - Running setup.py install for blessings 12:33:55 INFO - Successfully installed blessings 12:33:55 INFO - Cleaning up... 12:33:55 INFO - Return code: 0 12:33:55 INFO - Done creating virtualenv /builds/slave/test/build/venv. 12:33:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:33:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:33:55 INFO - Reading from file tmpfile_stdout 12:33:55 INFO - Current package versions: 12:33:55 INFO - argparse == 1.2.1 12:33:55 INFO - blessings == 1.6 12:33:55 INFO - blobuploader == 1.2.4 12:33:55 INFO - docopt == 0.6.1 12:33:55 INFO - functools32 == 3.2.3-2 12:33:55 INFO - jsonschema == 2.5.1 12:33:55 INFO - manifestparser == 1.1 12:33:55 INFO - mozInstall == 1.13 12:33:55 INFO - mozcrash == 1.0 12:33:55 INFO - mozdebug == 0.1 12:33:55 INFO - mozdevice == 0.51 12:33:55 INFO - mozfile == 1.2 12:33:55 INFO - mozhttpd == 0.7 12:33:55 INFO - mozinfo == 0.10 12:33:55 INFO - mozleak == 0.1 12:33:55 INFO - mozlog == 3.5 12:33:55 INFO - moznetwork == 0.27 12:33:55 INFO - mozprocess == 0.25 12:33:55 INFO - mozprofile == 0.28 12:33:55 INFO - mozrunner == 6.13 12:33:55 INFO - mozscreenshot == 0.1 12:33:55 INFO - mozsystemmonitor == 0.3 12:33:55 INFO - moztest == 0.8 12:33:55 INFO - mozversion == 1.4 12:33:55 INFO - psutil == 3.1.1 12:33:55 INFO - requests == 1.2.3 12:33:55 INFO - wsgiref == 0.1.2 12:33:55 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:33: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')]} 12:33:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:33: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')]} 12:33:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:33:55 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 0xa961f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc5ea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe01a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe05090>, '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 0xe05d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdfff90>, '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': '5cf47e208febbcd81da23b2e0000026f-1506453608.174477-904915991', '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 12:33:55 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 12:33:55 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 12:33:55 INFO - Using env: {'DISPLAY': ':0', 12:33:55 INFO - 'HOME': '/home/cltbld', 12:33:55 INFO - 'LANG': 'en_US.UTF-8', 12:33:55 INFO - 'LANGUAGE': 'en_US:en', 12:33:55 INFO - 'LOGNAME': 'cltbld', 12:33:55 INFO - 'MAIL': '/var/mail/cltbld', 12:33:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:33:55 INFO - 'MOZ_NO_REMOTE': '1', 12:33:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:33:55 INFO - 'NO_EM_RESTART': '1', 12:33:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:33:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:33:55 INFO - 'PWD': '/builds/slave/test', 12:33:55 INFO - 'SHELL': '/bin/bash', 12:33:55 INFO - 'SHLVL': '1', 12:33:55 INFO - 'TERM': 'linux', 12:33:55 INFO - 'TMOUT': '86400', 12:33:55 INFO - 'USER': 'cltbld', 12:33:55 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1506453608.174477-904915991', 12:33:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:33:55 INFO - '_': '/tools/buildbot/bin/python'} 12:33:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:33:55 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)) 12:33:55 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)) 12:33:55 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)) 12:33:55 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)) 12:33:55 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)) 12:33:55 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)) 12:33:55 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)) 12:33:55 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)) 12:33:55 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)) 12:33:55 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 12:33:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:33:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:33:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:33:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:33:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 12:33:56 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)) 12:33:56 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)) 12:33:56 INFO - Installing collected packages: simplejson 12:33:56 INFO - Running setup.py install for simplejson 12:33:56 INFO - building 'simplejson._speedups' extension 12:33:56 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 12:33:57 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 12:33:57 INFO - Successfully installed simplejson 12:33:57 INFO - Cleaning up... 12:33:57 INFO - Return code: 0 12:33:57 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 12:33:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:33:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:33:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:33:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:33:57 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xa961f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc5ea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe01a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe05090>, '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 0xe05d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdfff90>, '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': '5cf47e208febbcd81da23b2e0000026f-1506453608.174477-904915991', '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 12:33:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 12:33:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 12:33:57 INFO - Using env: {'DISPLAY': ':0', 12:33:57 INFO - 'HOME': '/home/cltbld', 12:33:57 INFO - 'LANG': 'en_US.UTF-8', 12:33:57 INFO - 'LANGUAGE': 'en_US:en', 12:33:57 INFO - 'LOGNAME': 'cltbld', 12:33:57 INFO - 'MAIL': '/var/mail/cltbld', 12:33:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:33:57 INFO - 'MOZ_NO_REMOTE': '1', 12:33:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:33:57 INFO - 'NO_EM_RESTART': '1', 12:33:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:33:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:33:57 INFO - 'PWD': '/builds/slave/test', 12:33:57 INFO - 'SHELL': '/bin/bash', 12:33:57 INFO - 'SHLVL': '1', 12:33:57 INFO - 'TERM': 'linux', 12:33:57 INFO - 'TMOUT': '86400', 12:33:57 INFO - 'USER': 'cltbld', 12:33:57 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1506453608.174477-904915991', 12:33:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:33:57 INFO - '_': '/tools/buildbot/bin/python'} 12:33:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:33:57 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 12:33:57 INFO - Cleaning up... 12:33:57 INFO - Return code: 0 12:33:57 INFO - Running post-action listener: _resource_record_post_action 12:33:57 INFO - Running post-action listener: _start_resource_monitoring 12:33:57 INFO - Starting resource monitoring. 12:33:57 INFO - [mozharness: 2017-09-26 19:33:57.975364Z] Finished create-virtualenv step (success) 12:33:57 INFO - [mozharness: 2017-09-26 19:33:57.975878Z] Running install step. 12:33:57 INFO - Running pre-action listener: _resource_record_pre_action 12:33:57 INFO - Running main action method: install 12:33:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:33:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:33:58 INFO - Reading from file tmpfile_stdout 12:33:58 INFO - Detecting whether we're running mozinstall >=1.0... 12:33:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 12:33:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 12:33:58 INFO - Reading from file tmpfile_stdout 12:33:58 INFO - Output received: 12:33:58 INFO - Usage: mozinstall [options] installer 12:33:58 INFO - Options: 12:33:58 INFO - -h, --help show this help message and exit 12:33:58 INFO - -d DEST, --destination=DEST 12:33:58 INFO - Directory to install application into. [default: 12:33:58 INFO - "/builds/slave/test"] 12:33:58 INFO - --app=APP Application being installed. [default: firefox] 12:33:58 INFO - mkdir: /builds/slave/test/build/application 12:33:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/target.tar.bz2', '--destination', '/builds/slave/test/build/application'] 12:33:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 12:34:12 INFO - Reading from file tmpfile_stdout 12:34:12 INFO - Output received: 12:34:12 INFO - /builds/slave/test/build/application/firefox/firefox 12:34:12 INFO - Running post-action listener: _resource_record_post_action 12:34:12 INFO - [mozharness: 2017-09-26 19:34:12.960448Z] Finished install step (success) 12:34:12 INFO - [mozharness: 2017-09-26 19:34:12.960700Z] Running setup-mitmproxy step. 12:34:12 INFO - Running pre-action listener: _resource_record_pre_action 12:34:12 INFO - Running main action method: setup_mitmproxy 12:34:12 INFO - Skipping: mitmproxy is not required 12:34:12 INFO - Running post-action listener: _resource_record_post_action 12:34:12 INFO - [mozharness: 2017-09-26 19:34:12.961924Z] Finished setup-mitmproxy step (success) 12:34:12 INFO - [mozharness: 2017-09-26 19:34:12.962147Z] Running run-tests step. 12:34:12 INFO - Running pre-action listener: _resource_record_pre_action 12:34:12 INFO - Running pre-action listener: _set_gcov_prefix 12:34:12 INFO - Running main action method: run_tests 12:34:12 WARNING - Try message not found. 12:34:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 12:34:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 12:34:12 INFO - Python 2.7.3 12:34:12 INFO - Return code: 0 12:34:12 INFO - grabbing minidump binary from tooltool 12:34:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:34:12 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 0xe05090>, '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 0xe05d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdfff90>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 12:34:12 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 12:34:12 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 12:34:12 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 12:34:13 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 12:34:13 INFO - Return code: 0 12:34:13 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 12:34:13 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 12:34:13 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 12:34:13 INFO - ENV: RUST_BACKTRACE is now full 12:34:13 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 12:34:13 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 12:34:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/I1eCh6_kSp-ZjFnEQUHzVw/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-011', '--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 12:34:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Beta-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/I1eCh6_kSp-ZjFnEQUHzVw/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-011 --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 12:34:13 INFO - Using env: {'DISPLAY': ':0', 12:34:13 INFO - 'HOME': '/home/cltbld', 12:34:13 INFO - 'LANG': 'en_US.UTF-8', 12:34:13 INFO - 'LANGUAGE': 'en_US:en', 12:34:13 INFO - 'LOGNAME': 'cltbld', 12:34:13 INFO - 'MAIL': '/var/mail/cltbld', 12:34:13 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 12:34:13 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 12:34:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:34:13 INFO - 'MOZ_NO_REMOTE': '1', 12:34:13 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 12:34:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:34:13 INFO - 'NO_EM_RESTART': '1', 12:34:13 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:34:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:34:13 INFO - 'PWD': '/builds/slave/test', 12:34:13 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 12:34:13 INFO - 'RUST_BACKTRACE': 'full', 12:34:13 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 12:34:13 INFO - 'SHELL': '/bin/bash', 12:34:13 INFO - 'SHLVL': '1', 12:34:13 INFO - 'TERM': 'linux', 12:34:13 INFO - 'TMOUT': '86400', 12:34:13 INFO - 'USER': 'cltbld', 12:34:13 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1506453608.174477-904915991', 12:34:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:34:13 INFO - '_': '/tools/buildbot/bin/python'} 12:34:13 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/I1eCh6_kSp-ZjFnEQUHzVw/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-011', '--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 12:34:13 INFO - mozversion application_buildid: 20170926181259 12:34:13 INFO - mozversion application_changeset: 520e300d1266d19aea623eb723587acc03751d50 12:34:13 INFO - mozversion application_display_name: Firefox 12:34:13 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 12:34:13 INFO - mozversion application_name: Firefox 12:34:13 INFO - mozversion application_remotingname: firefox 12:34:13 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 12:34:13 INFO - mozversion application_vendor: Mozilla 12:34:13 INFO - mozversion application_version: 57.0 12:34:13 INFO - mozversion platform_buildid: 20170926181259 12:34:13 INFO - mozversion platform_changeset: 520e300d1266d19aea623eb723587acc03751d50 12:34:13 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 12:34:13 INFO - mozversion platform_version: 57.0 12:34:13 INFO - using testdate: 1506454453 12:34:13 INFO - actual date: 1506454453 12:34:13 INFO - starting webserver on 'localhost:45516' 12:34:13 INFO - SUITE-START | Running 2 tests 12:34:13 INFO - TEST-START | dromaeo_css 12:34:13 INFO - Initialising browser for dromaeo_css test... 12:34:13 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:45516/getInfo.html -profile /tmp/tmpW72U0y/profile 12:34:13 INFO - TEST-INFO | started process 16595 (/builds/slave/test/build/application/firefox/firefox http://localhost:45516/getInfo.html) 12:34:18 INFO - TEST-INFO | 16595: exit 0 12:34:18 INFO - Browser initialized. 12:34:18 INFO - Running cycle 1/1 for dromaeo_css test... 12:34:18 INFO - Using env: {'DISPLAY': ':0', 12:34:18 INFO - 'HOME': '/home/cltbld', 12:34:18 INFO - 'JSGC_DISABLE_POISONING': '1', 12:34:18 INFO - 'LANG': 'en_US.UTF-8', 12:34:18 INFO - 'LANGUAGE': 'en_US:en', 12:34:18 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 12:34:18 INFO - 'LOGNAME': 'cltbld', 12:34:18 INFO - 'MAIL': '/var/mail/cltbld', 12:34:18 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 12:34:18 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 12:34:18 INFO - 'MOZ_CRASHREPORTER': '1', 12:34:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:34:18 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 12:34:18 INFO - 'MOZ_NO_REMOTE': '1', 12:34:18 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 12:34:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:34:18 INFO - 'NO_EM_RESTART': '1', 12:34:18 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:34:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:34:18 INFO - 'PWD': '/builds/slave/test', 12:34:18 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 12:34:18 INFO - 'RUST_BACKTRACE': 'full', 12:34:18 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 12:34:18 INFO - 'SHELL': '/bin/bash', 12:34:18 INFO - 'SHLVL': '1', 12:34:18 INFO - 'TERM': 'linux', 12:34:18 INFO - 'TMOUT': '86400', 12:34:18 INFO - 'USER': 'cltbld', 12:34:18 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1506453608.174477-904915991', 12:34:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:34:18 INFO - '_': '/tools/buildbot/bin/python'} 12:34:18 INFO - TEST-INFO | started process 16782 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpW72U0y/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 12:34:19 INFO - PID 16782 | 12:34:19 INFO - PID 16782 | (/builds/slave/test/build/application/firefox/firefox:16832): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 12:34:19 INFO - PID 16782 | 12:34:29 INFO - PID 16782 | RSS: Main: 143568896 12:34:29 INFO - PID 16782 | 12:37:27 INFO - PID 16782 | Cycle 1(1): loaded http://localhost:45516/tests/dromaeo/cssquery-dojo.html (next: http://localhost:45516/tests/dromaeo/cssquery-ext.html) 12:37:28 INFO - PID 16782 | RSS: Main: 146784256 12:37:28 INFO - PID 16782 | 12:40:29 INFO - PID 16782 | Cycle 1(1): loaded http://localhost:45516/tests/dromaeo/cssquery-ext.html (next: http://localhost:45516/tests/dromaeo/cssquery-jquery.html) 12:40:30 INFO - PID 16782 | RSS: Main: 144994304 12:40:30 INFO - PID 16782 | 12:43:31 INFO - PID 16782 | Cycle 1(1): loaded http://localhost:45516/tests/dromaeo/cssquery-jquery.html (next: http://localhost:45516/tests/dromaeo/cssquery-mootools.html) 12:43:32 INFO - PID 16782 | RSS: Main: 146042880 12:43:32 INFO - PID 16782 | 12:46:33 INFO - PID 16782 | Cycle 1(1): loaded http://localhost:45516/tests/dromaeo/cssquery-mootools.html (next: http://localhost:45516/tests/dromaeo/cssquery-prototype.html) 12:46:34 INFO - PID 16782 | RSS: Main: 145866752 12:46:34 INFO - PID 16782 | 12:49:37 INFO - PID 16782 | Cycle 1(1): loaded http://localhost:45516/tests/dromaeo/cssquery-prototype.html (next: http://localhost:45516/tests/dromaeo/cssquery-yui.html) 12:49:38 INFO - PID 16782 | RSS: Main: 146698240 12:49:38 INFO - PID 16782 | 12:52:39 INFO - PID 16782 | Cycle 1(1): loaded http://localhost:45516/tests/dromaeo/cssquery-yui.html (next: http://localhost:45516/tests/dromaeo/cssquery-dojo.html) 12:52:39 INFO - PID 16782 | RSS: Main: 149393408 12:52:39 INFO - PID 16782 | 12:52:39 INFO - PID 16782 | __start_tp_report 12:52:39 INFO - PID 16782 | _x_x_mozilla_page_load 12:52:39 INFO - PID 16782 | _x_x_mozilla_page_load_details 12:52:39 INFO - PID 16782 | |i|pagename|runs| 12:52:39 INFO - PID 16782 | |0;dojo.html;4034.193161367725;4048.615381538753;4050.210209009243;4078.612531809478;4084.6936479764026;6501.674916254186;6569.24453687826;6654.966725166368;6668.133142691456;6677.866442671144;6462.547621666486;6579.967100164505;6629.767958121467;6655.0682904393425;6710.8657826843555;5942.435468630473;5981.013132833077;6003.579749417553;6006.729697163616;6044;5968.1346204800275;5975.52195824333;5977.222961015062;6076.817695469143;6098.268207815068;5903.203067585864;6023.518118550527;6059.606125601844;6060.2121724175795;6068.150458935753;5890.793822216223;5921.526277897801;5932.080527518198;5980.102984552308;6011.489023433035;5740.368559458456;5763.682997435139;5814.854628634275;5850.444207800295;5885.882282354329;6487.6756162191705;6530.771423000172;6533.869322613568;6543.738250469975;6556.672166391661;7190.640467976633;7272.8545429091655;7281.235470275651;7297.854042919165;7300.7444739434395;7219.458540609423;7230.746923857692;7272.4909256352075;7303.452241081887;7336.046313979202;6554.377334153248;6595.1096601958125;6622.403983641495;6640.966795166041;6661.500387470959;7288.344049035506;7298.197198308182;7318.414526837947;7390.5196162249285;7439.995600593958;7105.076340075757;7115.89326160108;7121.181064177582;7209.423246140296;7223.061002069698;7175.8564828704175;7215.711371545184;7247.347738703436;7290.270972902774;7327.303906128909;7015.473839462061;7088.645567721594;7093.574385536885;7099.183593886666;7125.42996560274;7096.893546596805;7113.608751518716;7159.713611455588;7189.4967352285885;7190.316919892602;5306.522412982773;5362.329708786402;5376.946230537723;5378.408375078739;5383.569314454834;4815.927761083586;4866.829660961849;4872.731999739977;4885.047415753965;4896.290037944478;6590.670466476657;6661.4004739573675;6678.799636010927;6692.631905245161;6755.425788807908;7046.577205367695;7091.290870912868;7098.60957647324;7126.928730712731;7133;6626.171728533934;6630;6635.701393437307;6677.699503522354;6712.12742343502;6084;6090.23872015998;6144.969275153596;6167.938320616826;6177.351378105324;7285.7814265572115;7433.070866141732;7459.738909138154;7473.065866766654;7491;7078.787636370917;7082;7123.465740069412;7168.67740951648;7173.5337203081635;7374.078240219973;7379.963100184465;7382.744933361234;7457.2542745724995;7478.626068696434;6845.897311540431;6892.793216203522;6975.093237879043;6985.44116470671;7172.713091476283;7137.10786151731;7221.494495385273;7284.125904891235;7284.271572842674;7289.16174639902;6821.113255276782;6957.512974091967;6980.581165130108;7047.788566343018;7055.2944705529035;6839.487038472035;6866;6866.759663411756;6869.107016087876;6880.346367095118;6807.3873351398615;6813.2846051163915;6818.352256535622;6818.965905170442;6836.145481814773;6731.865362692816;6756.527043107132;6797.592144471348;6843.076184715199;6872.347127022925;6651.866962660622;6686.53194276396;6772.864542709217;6774.390304872585;6820.7271709133065 12:52:39 INFO - PID 16782 | |1;ext.html;965.613754498201;968.8498282766174;976.214147611173;1017.5065093429686;1026.938383696978;45440;46197.538024619746;46253.76873115634;46378;46453.30320045202;44003;44043.55956440435;44054.55945440553;44156.558434415725;44258.11483770323;8137.593120343989;8200.917990820075;8202.425830191889;8203.753887383358;8214.917850821475;8104.3921705872;8214.753557393287;8221.136780638037;8221.876671849897;8234.094249632535;8231.95884020579;8880.822383552326;8953.104689531026;8990.145936136056;9063.728088157366;8869.778255543599;8909.420887642282;8926.062763409846;8928.330375221853;8929.508877011762;8790.604422800989;8866.202041816268;8873.911260887438;8921.464712117293;8923.687670931486;41485.79257103695;41767.791161044;41815.1636967259;41883;41934.370984435256;3815.2560250751117;3853.499045124144;3860.884173474772;3871.612838716134;3875.65119139276;34244;34379.656203437895;34445.655543444496;34457.82771086154;34523.13692157691;5649.6327738696855;5667.149927510906;5720.3135623725;5733.713314334308;5844.064949608042;222041;223005;224379.87810061008;224738;224836;51986.22020669693;52140.47859521432;52391;54247.45752542424;55002.17496737552;57783;58133;58157;58291.70854145787;58294.41705582975;17838.643227135643;18001.459956201335;18124.45626631203;18128.728069078974;18143;14901.776473352907;14914.552563423114;14923.626909327353;14946.32741526634;15071.246437678072;15665.608359791097;15707.842921570867;15708.136052516993;15730.528084157493;15745.291461884242;5909.586328957018;5962.284525856925;5988.6706231157705;6057.757689692451;6092.8674963763215;1055.0926203465015;1064.2177999170603;1083.1118482843992;1091.6397588795678;1101.4712937789907;25668.486630267664;25748.48503029929;25815.225543233733;25894.35264118412;25915;1177.364223319415;1183.0240051956998;1195.1872726545857;1205.6744678936639;1225.197495640357;13187.142835715647;13428.731425371438;13664.521741738992;13681.794773078413;13873.236971966639;309420;310877;310890;311727;312931;52505;52617;53690.73154634202;60464.697676512216;61565.69217153885;1573.913434761099;1575.322611277139;1584.6513766971248;1589.3563106941708;1589.4039735099338;31066;31266.687333126378;31392.372152557276;32245.838770805996;32354.514682279314;42620.14759704727;42712.14575708531;42726;42737.57262427336;42746;252947;254261;254484;254565;255258;36744.81627591845;37589.624103758615;38319.23361532809;38348.6165138345;38384.23231535409;48422;48647.75676121597;48661.5133848657;49308.75345623393;49722;35440.46839297361;35875.28249434944;36102.8194859024;36121.27757444889;36176.27647447089;35310.23448827497;35422.291554169286;35499.467507987916;35602.46596301006;35928.46107308445;41304;41354.586454135075;41532.3770143442;41542;41545;34254.14364640804;34405.65594344125;34447.311053778285;34768.130796730286;35072.29855402929;26070.608940865524;26529.867350663895;26797.330066748487;26805.731942681105;27109.864450678408 12:52:39 INFO - PID 16782 | |2;jquery.html;634.3434545245672;634.4004915354989;634.9713464188011;638.3616383616383;653.1900443450122;23234.41913952152;24378.39054023648;24807.75192248077;25202.49595008099;25295.36761580964;27723.584146237772;28038.579421308696;28062.298442538948;28087;28096.578551321694;6654.866902661944;6829.078074459934;6835.07726456927;6891.448684105285;7176.964115179417;6989.54567953084;7027.051348068022;7029.5430796998035;7033.683484243222;7040.753573624924;6950.582965022089;6953.304669533057;6990.231074581792;7000.439964802829;7007.964960175192;6913.688884000232;6917.51577389583;6946.097007389032;6958.338957799001;6983.755568555076;6513.250976137758;6523.478121750249;6536.673166341711;6540;6541.34586541342;29059.564106538208;31392.686073139204;31529.684703152903;31553;31583.210419739462;2407.3500154958065;2432.0514999150346;2435;2439.0731522021697;2439.3657649011207;19882.801171988238;20192.899035504728;20705.68941465879;20710.378688639365;20789.376318710463;2532.4048848520583;2561.1676205233375;2567.858767767772;2605.726398728144;2608.960865587018;129165;135936;160216;167530;168088.99999999878;16230.269637866324;16421.83578164227;16834.831651683326;17209.397671081453;17371.913140434215;27051.323716907234;27242.727572724416;27282.5907611386;27337;27400.314992124957;10745.731356716145;10859.67420977356;10964.671059868217;10970;11024.724381890517;9944.453055081894;9992.200623950066;10019.098281154731;10109.342892712097;10147.238957078102;9828.31201815866;9920.206383489303;10119.595216191417;10172.440515771703;10304.639337623148;3015;3095.721385075354;3102.875884964576;3139.4035133324596;3193.1857376369344;1058.6982709927634;1071.8606581144556;1076.2143635146388;1078.3044936016227;1084.810158222308;21660;21696.78303216979;21898.9050547472;21916.23293184731;22144;1144.6337172104847;1148.362658724416;1151.6429906728774;1151.6660168551027;1153.4521102476256;11848.526058957545;12236.571719989757;12264.325462099492;12353.876461235452;12361.814572781415;566944;575049;582199;588855;614297;133556;134123;137233;137281;139125;1280.4238092858066;1330.068951733771;1371.2663724907327;1395.5255213227551;1400.7548678981138;23476.060957561505;23512.76487235174;23640.054397823893;23882.40293992664;23890.40273993164;67611;68459.65770171117;68671.31328686849;68919.31080689329;69160.65419672869;78432.03919902048;78797;79622.60188699019;79727;79739.60130199311;16405.42581009659;16634.584135396228;16646.916765416096;16745.91627041857;16779.664406711552;25163.622545661463;25207;25231.495370092864;25643.743562564134;25773.484530308913;19260.518487037934;19416.611667766283;19607.509812254808;19634.705479418106;19654.60690786205;18235.270589176285;18475.445736627924;18587.535311617317;18647.533811654816;18751.812481875008;20152.697709534663;21024;21139.365819025454;21288.574228515652;21296.893515532942;15522.689546209238;16302;16360.754588680942;16383.836161638708;16452.177391130634;19539.70690439616;19553.902230488755;19588.510287242934;19750.703739443634;19987.300444484372 12:52:39 INFO - PID 16782 | |3;mootools.html;1443.3432788081425;1482.1033274868705;1495.7008598280347;1502.9398824047041;1515.5756388211298;17282.395116170937;17978.910105449486;18003.729944050832;18014;18032.63934721308;17361.91319043403;17542.561435964108;17603.471895843115;17626.735598965995;17699.64600707985;2918.4163167366505;2918.6497620285595;2969.4506516294555;2983.8060526065738;2988.178250980976;2870.4833130036586;2907.665618453884;2924.7660187184974;2929.2969687275113;2933.6919623439444;2901.434220327037;3001.789874708771;3086.552449894764;3086.66046734859;3105.0529588475506;2975.4495418347674;2978.4638765022287;3021.3957208558377;3054;3068.4783586790077;2869.6556413230546;2893.146521776081;2936.060460652592;2937.911862644124;2938.853057347124;16975.91512042444;17134.05762683052;17175.914120429443;17257.137143142918;17352;8810;9016.8647470288;9067.954660226722;9068;9098.999110097884;5993.9400605993815;6024.21685180928;6205.937940620626;6215.471684906788;6241.78153764616;2134.8292136629034;2150.1506904772527;2173.6124827177596;2222.122261706633;2224.4216503709154;31515.321197698224;31764.523532147035;31777.682223177933;31812.84093579517;31834.044978650676;7264.164621068539;7389;7431.554106753612;7600.619969001527;7616.04799400075;19520.121594528282;19590.510237244183;19649.410517684493;19701.50746231327;19756.407307780788;8273.586320683942;8502.44734092282;8511.74464766058;8511.95744021276;8515.14848515156;7641.656125474367;7719.498232614862;7792.220777922275;7805.492642978188;7877;5758.654480731169;5943.70281485924;6111.54163437744;6113.57204995646;6209.627422354673;1507.8190617126015;1530.9387624495118;1596.0583255879087;1631.4779270633283;1721.5696075981004;966.8936416994125;971.4074414607084;974.8732664753537;985.074030411411;995.5520015992687;9001.729948101567;9085.13691199335;9190.49452280131;9476.431414115175;9492.098250666175;1068.1027936533194;1079.4440862955585;1088.5591335509132;1093.7593729379682;1102.2009043443438;4951.876203094951;4965.205567109245;5049.545540901263;5073.594112470993;5126.179811230185;25296;25841.353966150997;26449.47101057968;26674.066407675637;26696.866515667298;25591.23226303214;25911.352216194748;26096.739032609432;26109.608355874676;26131.869340653557;12054.457549410297;12647.367631618383;12802.295873727035;12814.35928203586;12886.484540618458;9062.954685226532;9096.408733432305;9109.271258299188;9133.041030691948;9162.037986011374;21418.678719818905;21654.783452165906;21891.562168756853;21919.671204932256;22205.444863877885;22655.773442266025;22758.65862012038;22904.427389315402;23299.417514562272;23468.76531234734;12299.754004919672;12569.371531423576;12629.2422454653;12684.429200685807;12695.238285702888;15288.235588220767;15581.610459738597;15747.291371888063;15794.76307855406;15796.36814527406;11661.883381166079;12061.939690301493;12312.322822244505;12317.137800353888;13032.283224422748;12438.253704777742;12648.810267845805;12837.101402901708;12854.293013884326;12859.29273889945;9928.205743540355;10030.348027378197;10047.598096076075;10048.89951100509;10093.848592270975;7772.378209743094;7863.449558530848;7912.881306780518;7938.24586664266;7958.761237162895;8106.229908158715;8145.67417303325;8173.34613230952;8195.057568379474;8275.62759675828 12:52:39 INFO - PID 16782 | |4;prototype.html;565.4430386069721;574.8936446757348;591.6982339007106;612.0818771842237;612.3233826621583;6383.553151279412;6423.454006409455;6488.837779055526;6532.575382600127;6587.110740050091;6406.903896441546;6442.742290308382;6465.48276137909;6476.514261430388;6489.383508566691;5316.6544174628525;5386.602961682053;5414.106672399069;5445.292112025431;5448.174861421408;5153.3815942087;5213.530782229599;5222.843314700565;5248.947510524903;5448.37343705475;5173.767180476869;5183.678162068667;5225.346831646044;5231.136862417697;5239.633225674204;5220.582353411756;5233.3981592116825;5235.1623740201385;5239.607029472805;5256.7897284108785;4709.387779588666;4715.905681886343;4743.715377077352;4748.738819364934;4783.354247176656;6421.711023003976;6447.484201263887;6451.612903225775;6474.838129046764;6491.415772580491;6124.418180272912;6157.706881554879;6163.537734669872;6190.380961903774;6194.783182588633;6928.272531384233;6992.937083560311;7000.929990700079;7011.684474198673;7016.824784316878;5141.845744627667;5350.91973620396;5356.571474282048;5361.276227709248;5387.622866399353;7113.573185608829;7125.82185445368;7168.702396897382;7247.528910620846;7304.598247096407;5485.533729633026;5490.56075513958;5498.835034948958;5505.421930697299;5507.531859791962;5573.526250268692;5580.553555715533;5586.385497595261;5645.068563687028;5650.26546548946;6224.657643829542;6233.283172435228;6241.469475094668;6243.500519958392;6267.905981410283;6927.7228910844005;6979.3020697930815;7008.404285635676;7034.6282474917925;7037.859242815115;1891.3380316889254;1915.3775023117541;1922.6539222939725;1929.9421017369502;1937.5156210947264;1341.9463221471226;1376.2018029542842;1383.1355402873205;1384.806127142201;1386.7172865099742;6427.807165785034;6479.838004049937;6487.610743355413;6575.276719560845;6585.814553380437;6989.89515157273;7022.754203602952;7031.8242043948285;7048.753293634698;7098.68055937484;6438.356164383524;6490.221173459121;6524.934750652527;6560.704768285439;6577.506686998494;3658.2683463307444;3698.278835627027;3702.148505843671;3714.60996595359;3739.8504059837846;7180.3537681608905;7223.92776072243;7270.890936635955;7313.780586582411;7327.8534429312185;7265.927340726631;7269.8546029079125;7277.345038946414;7282.162551306562;7318.780436586911;7224.8079066954415;7365.668544915385;7399.408047356199;7452.590107544029;7476.663550140257;6917.13535808024;6991.405730512964;6993.755218567326;7030.367266945999;7039.753608623673;7007.824804379931;7046.577205367695;7107.573545587281;7126.394256488256;7140.571565706075;7338.743143989935;7355.8896616551865;7362.411007119525;7377.299156580117;7429.591372474566;5437.184422336523;5485.533729632866;5502.449755024466;5510.118381059172;5523.917141242804;6840.179178498612;6846.863062738617;6955.339242771928;6969.756058537927;7052.294770522906;6828;6879.1744990599445;6894.207166175954;6922.134733158356;6955.8956615649795;6817.488688348493;6862.176538815374;6885.2770459101075;6890.793276201722;6918.962155676689;6737.494687898526;6807.353301436356;6830.590164589942;6839.418649414855;6843.281455447106;6837.2992667894905;6879.828004299732;6934.583924964519;6986.650667466504;7022;6676.494840208929;6715.5299129060495;6723.932760672331;6736.74319103106;6790.083338749403 12:52:39 INFO - PID 16782 | |5;yui.html;1018.7656838927047;1027.7071034755093;1028.1209565821218;1032.9567137191434;1056.482323661406;18313.54216144597;18532.62934741306;18839.43481695548;18900.905495472536;18960.62078758424;17003;17019.914900425512;17075.82924170758;17099.572510687238;17173.656526869454;1082.9025387715103;1099.8845121262273;1101.5043230546246;1106.634810512529;1107.1696227829127;1063.0698139128262;1093.8851420600843;1099.34039576254;1101.432762127505;1101.6474728087014;1151.5739176504662;1155.104793784815;1157.056998546182;1163.1973937982807;1164.7262893220086;1147.615548791156;1147.7073346296725;1150.6433005768156;1151.8157094864823;1155.537784886044;831.7587899509135;847.3433089355736;858.150431073233;858.9785255368603;859.2052351574769;19312.517187070294;19683.606327873506;19701.704474432896;19800.306989255307;21195;22837.20069797566;23322.533549328917;23625.527489450287;23682;23824.523509529714;17960.730589041174;18100.185491652777;18110.456686299432;18244.270229190817;18261.360852370235;4055.513338399411;4070.124923141509;4114.814833332507;4117.114820313617;4118.546959834416;162881;166496;167152;168134;168431.1578442112;15508.5347439577;15563.377464901278;15577.844221557865;15580.065196088271;15601.219939003004;35630.64369356325;36135;36212.818935905154;36221.8188909059;36308.27383452369;9094.590743416562;9148.359614827032;9155.450672959643;9235.26117910579;9240.122188392092;4792.257200133985;4863.708177509361;4878.926816097762;4880.511948805091;4893.926591101136;6386.425221730066;6396.9360306397275;6505.447037001908;6527.5430719849155;6532;1209.6492017314881;1216.1145141273546;1228.2507670321097;1228.3060071059822;1229.6802831263935;720.2797202797203;733.7211859493465;740.9407247420194;746.0711414289244;757.121738783009;12139.077174764072;12357.629271121881;12851.16467429614;13088.476460941456;13150;725.7532438970775;727.3308556128375;741.3957624535985;742.8848528478095;756.1833220122255;5811.56413268998;5866.501347385435;5962.463378295887;5971.552133589998;6043.244594425697;154914;157012;157545.21227393788;157653;165120;137522;137574;138404.30797846147;142100;146460;119920;122026.38986805009;122394.38802806108;122530;125470.99999999818;11313.943430282796;11347.751747307624;11380.772384552429;11452.942735286604;11547.826782598437;57598;58481;58601.70699146477;59302;60983;74248;74757.2524274772;75380;77498.6125069371;77677.223227767;18083.90958045254;18230.17964191588;18412.35556755507;18499.630007399508;18596;17784;17924.731129032814;17939.551511212325;17946.461606151835;17956.19197136106;18932.810671893105;19074.23703051918;19198.232070717015;19204.943728095088;19381.224751009802;18803.623927521647;18898.52753681169;18915.432537023913;18916.148773304958;18958.52603684919;15808.683826323639;15933.12367819781;15982.200889955688;16017.519474415787;16086.517404477885;12728.809067863804;12738;12802.487900483877;12947.482100715866;12996.935015324863;12351.320677362472;12527.560233451317;12549;12636.810447843474;12705.682357941125 12:52:39 INFO - PID 16782 | __end_tp_report 12:52:39 INFO - PID 16782 | __start_cc_report 12:52:39 INFO - PID 16782 | _x_x_mozilla_cycle_collect,237 12:52:39 INFO - PID 16782 | __end_cc_report 12:52:39 INFO - PID 16782 | __startTimestamp1506455559776__endTimestamp 12:52:39 INFO - PID 16782 | 12:52:39 INFO - PID 16782 | ------- Summary: start ------- 12:52:39 INFO - PID 16782 | Number of tests: 6 12:52:39 INFO - PID 16782 | 12:52:39 INFO - PID 16782 | [#0] dojo.html Cycles:165 Average:6603.88 Median:6807.39 stddev:758.46 (11.1%) stddev-sans-first:733.51 12:52:39 INFO - PID 16782 | Values: 4034.2 4048.6 4050.2 4078.6 4084.7 6501.7 6569.2 6655.0 6668.1 6677.9 6462.5 6580.0 6629.8 6655.1 6710.9 5942.4 5981.0 6003.6 6006.7 6044.0 5968.1 5975.5 5977.2 6076.8 6098.3 5903.2 6023.5 6059.6 6060.2 6068.2 5890.8 5921.5 5932.1 5980.1 6011.5 5740.4 5763.7 5814.9 5850.4 5885.9 6487.7 6530.8 6533.9 6543.7 6556.7 7190.6 7272.9 7281.2 7297.9 7300.7 7219.5 7230.7 7272.5 7303.5 7336.0 6554.4 6595.1 6622.4 6641.0 6661.5 7288.3 7298.2 7318.4 7390.5 7440.0 7105.1 7115.9 7121.2 7209.4 7223.1 7175.9 7215.7 7247.3 7290.3 7327.3 7015.5 7088.6 7093.6 7099.2 7125.4 7096.9 7113.6 7159.7 7189.5 7190.3 5306.5 5362.3 5376.9 5378.4 5383.6 4815.9 4866.8 4872.7 4885.0 4896.3 6590.7 6661.4 6678.8 6692.6 6755.4 7046.6 7091.3 7098.6 7126.9 7133.0 6626.2 6630.0 6635.7 6677.7 6712.1 6084.0 6090.2 6145.0 6167.9 6177.4 7285.8 7433.1 7459.7 7473.1 7491.0 7078.8 7082.0 7123.5 7168.7 7173.5 7374.1 7380.0 7382.7 7457.3 7478.6 6845.9 6892.8 6975.1 6985.4 7172.7 7137.1 7221.5 7284.1 7284.3 7289.2 6821.1 6957.5 6980.6 7047.8 7055.3 6839.5 6866.0 6866.8 6869.1 6880.3 6807.4 6813.3 6818.4 6819.0 6836.1 6731.9 6756.5 6797.6 6843.1 6872.3 6651.9 6686.5 6772.9 6774.4 6820.7 12:52:39 INFO - PID 16782 | 12:52:39 INFO - PID 16782 | [#1] ext.html Cycles:180 Average:44724.63 Median:38333.93 stddev:69092.98 (180.2%) stddev-sans-first:69208.68 12:52:39 INFO - PID 16782 | Values: 965.6 968.8 976.2 1017.5 1026.9 45440.0 46197.5 46253.8 46378.0 46453.3 44003.0 44043.6 44054.6 44156.6 44258.1 8137.6 8200.9 8202.4 8203.8 8214.9 8104.4 8214.8 8221.1 8221.9 8234.1 8232.0 8880.8 8953.1 8990.1 9063.7 8869.8 8909.4 8926.1 8928.3 8929.5 8790.6 8866.2 8873.9 8921.5 8923.7 41485.8 41767.8 41815.2 41883.0 41934.4 3815.3 3853.5 3860.9 3871.6 3875.7 34244.0 34379.7 34445.7 34457.8 34523.1 5649.6 5667.1 5720.3 5733.7 5844.1 222041.0 223005.0 224379.9 224738.0 224836.0 51986.2 52140.5 52391.0 54247.5 55002.2 57783.0 58133.0 58157.0 58291.7 58294.4 17838.6 18001.5 18124.5 18128.7 18143.0 14901.8 14914.6 14923.6 14946.3 15071.2 15665.6 15707.8 15708.1 15730.5 15745.3 5909.6 5962.3 5988.7 6057.8 6092.9 1055.1 1064.2 1083.1 1091.6 1101.5 25668.5 25748.5 25815.2 25894.4 25915.0 1177.4 1183.0 1195.2 1205.7 1225.2 13187.1 13428.7 13664.5 13681.8 13873.2 309420.0 310877.0 310890.0 311727.0 312931.0 52505.0 52617.0 53690.7 60464.7 61565.7 1573.9 1575.3 1584.7 1589.4 1589.4 31066.0 31266.7 31392.4 32245.8 32354.5 42620.1 42712.1 42726.0 42737.6 42746.0 252947.0 254261.0 254484.0 254565.0 255258.0 36744.8 37589.6 38319.2 38348.6 38384.2 48422.0 48647.8 48661.5 49308.8 49722.0 35440.5 35875.3 36102.8 36121.3 36176.3 35310.2 35422.3 35499.5 35602.5 35928.5 41304.0 41354.6 41532.4 41542.0 41545.0 34254.1 34405.7 34447.3 34768.1 35072.3 26070.6 26529.9 26797.3 26805.7 27109.9 12:52:39 INFO - PID 16782 | 12:52:39 INFO - PID 16782 | [#2] jquery.html Cycles:180 Average:40064.72 Median:23886.40 stddev:98386.76 (411.9%) stddev-sans-first:98618.22 12:52:39 INFO - PID 16782 | Values: 634.3 634.4 635.0 638.4 653.2 23234.4 24378.4 24807.8 25202.5 25295.4 27723.6 28038.6 28062.3 28087.0 28096.6 6654.9 6829.1 6835.1 6891.4 7177.0 6989.5 7027.1 7029.5 7033.7 7040.8 6950.6 6953.3 6990.2 7000.4 7008.0 6913.7 6917.5 6946.1 6958.3 6983.8 6513.3 6523.5 6536.7 6540.0 6541.3 29059.6 31392.7 31529.7 31553.0 31583.2 2407.4 2432.1 2435.0 2439.1 2439.4 19882.8 20192.9 20705.7 20710.4 20789.4 2532.4 2561.2 2567.9 2605.7 2609.0 129165.0 135936.0 160216.0 167530.0 168089.0 16230.3 16421.8 16834.8 17209.4 17371.9 27051.3 27242.7 27282.6 27337.0 27400.3 10745.7 10859.7 10964.7 10970.0 11024.7 9944.5 9992.2 10019.1 10109.3 10147.2 9828.3 9920.2 10119.6 10172.4 10304.6 3015.0 3095.7 3102.9 3139.4 3193.2 1058.7 1071.9 1076.2 1078.3 1084.8 21660.0 21696.8 21898.9 21916.2 22144.0 1144.6 1148.4 1151.6 1151.7 1153.5 11848.5 12236.6 12264.3 12353.9 12361.8 566944.0 575049.0 582199.0 588855.0 614297.0 133556.0 134123.0 137233.0 137281.0 139125.0 1280.4 1330.1 1371.3 1395.5 1400.8 23476.1 23512.8 23640.1 23882.4 23890.4 67611.0 68459.7 68671.3 68919.3 69160.7 78432.0 78797.0 79622.6 79727.0 79739.6 16405.4 16634.6 16646.9 16745.9 16779.7 25163.6 25207.0 25231.5 25643.7 25773.5 19260.5 19416.6 19607.5 19634.7 19654.6 18235.3 18475.4 18587.5 18647.5 18751.8 20152.7 21024.0 21139.4 21288.6 21296.9 15522.7 16302.0 16360.8 16383.8 16452.2 19539.7 19553.9 19588.5 19750.7 19987.3 12:52:39 INFO - PID 16782 | 12:52:39 INFO - PID 16782 | [#3] mootools.html Cycles:180 Average:10649.50 Median:2881.81 stddev:8012.13 (278.0%) stddev-sans-first:8004.75 12:52:39 INFO - PID 16782 | Values: 1443.3 1482.1 1495.7 1502.9 1515.6 17282.4 17978.9 18003.7 18014.0 18032.6 17361.9 17542.6 17603.5 17626.7 17699.6 2918.4 2918.6 2969.5 2983.8 2988.2 2870.5 2907.7 2924.8 2929.3 2933.7 2901.4 3001.8 3086.6 3086.7 3105.1 2975.4 2978.5 3021.4 3054.0 3068.5 2869.7 2893.1 2936.1 2937.9 2938.9 16975.9 17134.1 17175.9 17257.1 17352.0 8810.0 9016.9 9068.0 9068.0 9099.0 5993.9 6024.2 6205.9 6215.5 6241.8 2134.8 2150.2 2173.6 2222.1 2224.4 31515.3 31764.5 31777.7 31812.8 31834.0 7264.2 7389.0 7431.6 7600.6 7616.0 19520.1 19590.5 19649.4 19701.5 19756.4 8273.6 8502.4 8511.7 8512.0 8515.1 7641.7 7719.5 7792.2 7805.5 7877.0 5758.7 5943.7 6111.5 6113.6 6209.6 1507.8 1530.9 1596.1 1631.5 1721.6 966.9 971.4 974.9 985.1 995.6 9001.7 9085.1 9190.5 9476.4 9492.1 1068.1 1079.4 1088.6 1093.8 1102.2 4951.9 4965.2 5049.5 5073.6 5126.2 25296.0 25841.4 26449.5 26674.1 26696.9 25591.2 25911.4 26096.7 26109.6 26131.9 12054.5 12647.4 12802.3 12814.4 12886.5 9063.0 9096.4 9109.3 9133.0 9162.0 21418.7 21654.8 21891.6 21919.7 22205.4 22655.8 22758.7 22904.4 23299.4 23468.8 12299.8 12569.4 12629.2 12684.4 12695.2 15288.2 15581.6 15747.3 15794.8 15796.4 11661.9 12061.9 12312.3 12317.1 13032.3 12438.3 12648.8 12837.1 12854.3 12859.3 9928.2 10030.3 10047.6 10048.9 10093.8 7772.4 7863.4 7912.9 7938.2 7958.8 8106.2 8145.7 8173.3 8195.1 8275.6 12:52:39 INFO - PID 16782 | 12:52:39 INFO - PID 16782 | [#4] prototype.html Cycles:180 Average:5915.65 Median:6489.80 stddev:1643.34 (25.3%) stddev-sans-first:1598.14 12:52:39 INFO - PID 16782 | Values: 565.4 574.9 591.7 612.1 612.3 6383.6 6423.5 6488.8 6532.6 6587.1 6406.9 6442.7 6465.5 6476.5 6489.4 5316.7 5386.6 5414.1 5445.3 5448.2 5153.4 5213.5 5222.8 5248.9 5448.4 5173.8 5183.7 5225.3 5231.1 5239.6 5220.6 5233.4 5235.2 5239.6 5256.8 4709.4 4715.9 4743.7 4748.7 4783.4 6421.7 6447.5 6451.6 6474.8 6491.4 6124.4 6157.7 6163.5 6190.4 6194.8 6928.3 6992.9 7000.9 7011.7 7016.8 5141.8 5350.9 5356.6 5361.3 5387.6 7113.6 7125.8 7168.7 7247.5 7304.6 5485.5 5490.6 5498.8 5505.4 5507.5 5573.5 5580.6 5586.4 5645.1 5650.3 6224.7 6233.3 6241.5 6243.5 6267.9 6927.7 6979.3 7008.4 7034.6 7037.9 1891.3 1915.4 1922.7 1929.9 1937.5 1341.9 1376.2 1383.1 1384.8 1386.7 6427.8 6479.8 6487.6 6575.3 6585.8 6989.9 7022.8 7031.8 7048.8 7098.7 6438.4 6490.2 6524.9 6560.7 6577.5 3658.3 3698.3 3702.1 3714.6 3739.9 7180.4 7223.9 7270.9 7313.8 7327.9 7265.9 7269.9 7277.3 7282.2 7318.8 7224.8 7365.7 7399.4 7452.6 7476.7 6917.1 6991.4 6993.8 7030.4 7039.8 7007.8 7046.6 7107.6 7126.4 7140.6 7338.7 7355.9 7362.4 7377.3 7429.6 5437.2 5485.5 5502.4 5510.1 5523.9 6840.2 6846.9 6955.3 6969.8 7052.3 6828.0 6879.2 6894.2 6922.1 6955.9 6817.5 6862.2 6885.3 6890.8 6919.0 6737.5 6807.4 6830.6 6839.4 6843.3 6837.3 6879.8 6934.6 6986.7 7022.0 6676.5 6715.5 6723.9 6736.7 6790.1 12:52:39 INFO - PID 16782 | 12:52:39 INFO - PID 16782 | [#5] yui.html Cycles:180 Average:29202.08 Median:18022.32 stddev:44873.30 (249.0%) stddev-sans-first:44949.29 12:52:39 INFO - PID 16782 | Values: 1018.8 1027.7 1028.1 1033.0 1056.5 18313.5 18532.6 18839.4 18900.9 18960.6 17003.0 17019.9 17075.8 17099.6 17173.7 1082.9 1099.9 1101.5 1106.6 1107.2 1063.1 1093.9 1099.3 1101.4 1101.6 1151.6 1155.1 1157.1 1163.2 1164.7 1147.6 1147.7 1150.6 1151.8 1155.5 831.8 847.3 858.2 859.0 859.2 19312.5 19683.6 19701.7 19800.3 21195.0 22837.2 23322.5 23625.5 23682.0 23824.5 17960.7 18100.2 18110.5 18244.3 18261.4 4055.5 4070.1 4114.8 4117.1 4118.5 162881.0 166496.0 167152.0 168134.0 168431.2 15508.5 15563.4 15577.8 15580.1 15601.2 35630.6 36135.0 36212.8 36221.8 36308.3 9094.6 9148.4 9155.5 9235.3 9240.1 4792.3 4863.7 4878.9 4880.5 4893.9 6386.4 6396.9 6505.4 6527.5 6532.0 1209.6 1216.1 1228.3 1228.3 1229.7 720.3 733.7 740.9 746.1 757.1 12139.1 12357.6 12851.2 13088.5 13150.0 725.8 727.3 741.4 742.9 756.2 5811.6 5866.5 5962.5 5971.6 6043.2 154914.0 157012.0 157545.2 157653.0 165120.0 137522.0 137574.0 138404.3 142100.0 146460.0 119920.0 122026.4 122394.4 122530.0 125471.0 11313.9 11347.8 11380.8 11452.9 11547.8 57598.0 58481.0 58601.7 59302.0 60983.0 74248.0 74757.3 75380.0 77498.6 77677.2 18083.9 18230.2 18412.4 18499.6 18596.0 17784.0 17924.7 17939.6 17946.5 17956.2 18932.8 19074.2 19198.2 19204.9 19381.2 18803.6 18898.5 18915.4 18916.1 18958.5 15808.7 15933.1 15982.2 16017.5 16086.5 12728.8 12738.0 12802.5 12947.5 12996.9 12351.3 12527.6 12549.0 12636.8 12705.7 12:52:39 INFO - PID 16782 | -------- Summary: end -------- 12:52:39 INFO - PID 16782 | 12:52:40 INFO - TEST-INFO | 16782: exit 0 12:52:40 INFO - TEST-OK | dromaeo_css | took 1107143ms 12:52:40 INFO - TEST-START | kraken 12:52:40 INFO - Initialising browser for kraken test... 12:52:40 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:45516/getInfo.html -profile /tmp/tmpyMrHvb/profile 12:52:40 INFO - TEST-INFO | started process 17153 (/builds/slave/test/build/application/firefox/firefox http://localhost:45516/getInfo.html) 12:52:45 INFO - TEST-INFO | 17153: exit 0 12:52:45 INFO - Browser initialized. 12:52:45 INFO - Running cycle 1/1 for kraken test... 12:52:45 INFO - Using env: {'DISPLAY': ':0', 12:52:45 INFO - 'HOME': '/home/cltbld', 12:52:45 INFO - 'JSGC_DISABLE_POISONING': '1', 12:52:45 INFO - 'LANG': 'en_US.UTF-8', 12:52:45 INFO - 'LANGUAGE': 'en_US:en', 12:52:45 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 12:52:45 INFO - 'LOGNAME': 'cltbld', 12:52:45 INFO - 'MAIL': '/var/mail/cltbld', 12:52:45 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 12:52:45 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 12:52:45 INFO - 'MOZ_CRASHREPORTER': '1', 12:52:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:52:45 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 12:52:45 INFO - 'MOZ_NO_REMOTE': '1', 12:52:45 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 12:52:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:52:45 INFO - 'NO_EM_RESTART': '1', 12:52:45 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:52:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:52:45 INFO - 'PWD': '/builds/slave/test', 12:52:45 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 12:52:45 INFO - 'RUST_BACKTRACE': 'full', 12:52:45 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 12:52:45 INFO - 'SHELL': '/bin/bash', 12:52:45 INFO - 'SHLVL': '1', 12:52:45 INFO - 'TERM': 'linux', 12:52:45 INFO - 'TMOUT': '86400', 12:52:45 INFO - 'USER': 'cltbld', 12:52:45 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1506453608.174477-904915991', 12:52:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:52:45 INFO - '_': '/tools/buildbot/bin/python'} 12:52:45 INFO - TEST-INFO | started process 17342 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpyMrHvb/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 12:52:46 INFO - PID 17342 | 12:52:46 INFO - PID 17342 | (/builds/slave/test/build/application/firefox/firefox:17390): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 12:52:46 INFO - PID 17342 | 12:52:57 INFO - PID 17342 | RSS: Main: 140988416 12:52:57 INFO - PID 17342 | 12:52:59 INFO - PID 17342 | Cycle 1(1): loaded http://localhost:45516/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:45516/tests/kraken/driver.html?testName=audio-beat-detection) 12:53:00 INFO - PID 17342 | RSS: Main: 148295680 12:53:00 INFO - PID 17342 | 12:53:03 INFO - PID 17342 | Cycle 1(1): loaded http://localhost:45516/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:45516/tests/kraken/driver.html?testName=audio-dft) 12:53:03 INFO - PID 17342 | RSS: Main: 148930560 12:53:03 INFO - PID 17342 | 12:53:06 INFO - PID 17342 | Cycle 1(1): loaded http://localhost:45516/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:45516/tests/kraken/driver.html?testName=audio-fft) 12:53:07 INFO - PID 17342 | RSS: Main: 151269376 12:53:07 INFO - PID 17342 | 12:53:09 INFO - PID 17342 | Cycle 1(1): loaded http://localhost:45516/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:45516/tests/kraken/driver.html?testName=audio-oscillator) 12:53:09 INFO - PID 17342 | RSS: Main: 151121920 12:53:09 INFO - PID 17342 | 12:53:11 INFO - PID 17342 | Cycle 1(1): loaded http://localhost:45516/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:45516/tests/kraken/driver.html?testName=imaging-gaussian-blur) 12:53:12 INFO - PID 17342 | RSS: Main: 150269952 12:53:12 INFO - PID 17342 | 12:53:15 INFO - PID 17342 | Cycle 1(1): loaded http://localhost:45516/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:45516/tests/kraken/driver.html?testName=imaging-darkroom) 12:53:15 INFO - PID 17342 | RSS: Main: 150446080 12:53:15 INFO - PID 17342 | 12:53:19 INFO - PID 17342 | Cycle 1(1): loaded http://localhost:45516/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:45516/tests/kraken/driver.html?testName=imaging-desaturate) 12:53:20 INFO - PID 17342 | RSS: Main: 150126592 12:53:20 INFO - PID 17342 | 12:53:22 INFO - PID 17342 | Cycle 1(1): loaded http://localhost:45516/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:45516/tests/kraken/driver.html?testName=json-parse-financial) 12:53:23 INFO - PID 17342 | RSS: Main: 151470080 12:53:23 INFO - PID 17342 | 12:53:25 INFO - PID 17342 | Cycle 1(1): loaded http://localhost:45516/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:45516/tests/kraken/driver.html?testName=json-stringify-tinderbox) 12:53:25 INFO - PID 17342 | RSS: Main: 151982080 12:53:25 INFO - PID 17342 | 12:53:27 INFO - PID 17342 | Cycle 1(1): loaded http://localhost:45516/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:45516/tests/kraken/driver.html?testName=stanford-crypto-aes) 12:53:27 INFO - PID 17342 | RSS: Main: 151494656 12:53:27 INFO - PID 17342 | 12:53:29 INFO - PID 17342 | Cycle 1(1): loaded http://localhost:45516/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:45516/tests/kraken/driver.html?testName=stanford-crypto-ccm) 12:53:30 INFO - PID 17342 | RSS: Main: 148086784 12:53:30 INFO - PID 17342 | 12:53:32 INFO - PID 17342 | Cycle 1(1): loaded http://localhost:45516/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:45516/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 12:53:33 INFO - PID 17342 | RSS: Main: 148074496 12:53:33 INFO - PID 17342 | 12:53:36 INFO - PID 17342 | Cycle 1(1): loaded http://localhost:45516/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:45516/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 12:53:36 INFO - PID 17342 | RSS: Main: 148647936 12:53:36 INFO - PID 17342 | 12:53:38 INFO - PID 17342 | Cycle 1(1): loaded http://localhost:45516/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:45516/tests/kraken/driver.html?testName=ai-astar) 12:53:38 INFO - PID 17342 | RSS: Main: 150401024 12:53:38 INFO - PID 17342 | 12:53:38 INFO - PID 17342 | __start_tp_report 12:53:38 INFO - PID 17342 | _x_x_mozilla_page_load 12:53:38 INFO - PID 17342 | _x_x_mozilla_page_load_details 12:53:38 INFO - PID 17342 | |i|pagename|runs| 12:53:38 INFO - PID 17342 | |0;ai-astar;107;107;104;106;106;107;112;105;106;105 12:53:38 INFO - PID 17342 | |1;audio-beat-detection;110;111;114;114;111;115;138;110;110;111 12:53:38 INFO - PID 17342 | |2;audio-dft;161;162;163;162;163;159;161;162;161;162 12:53:38 INFO - PID 17342 | |3;audio-fft;73;75;72;73;73;73;73;73;75;74 12:53:38 INFO - PID 17342 | |4;audio-oscillator;77;84;83;77;78;77;79;76;77;79 12:53:38 INFO - PID 17342 | |5;imaging-gaussian-blur;113;114;110;113;113;114;114;114;111;116 12:53:38 INFO - PID 17342 | |6;imaging-darkroom;150;148;149;153;149;147;149;148;149;148 12:53:38 INFO - PID 17342 | |7;imaging-desaturate;93;94;94;94;93;96;95;94;94;95 12:53:38 INFO - PID 17342 | |8;json-parse-financial;45;41;42;43;42;43;43;43;42;41 12:53:38 INFO - PID 17342 | |9;json-stringify-tinderbox;38;38;39;39;39;43;39;39;38;39 12:53:38 INFO - PID 17342 | |10;stanford-crypto-aes;70;70;70;72;69;69;70;70;69;69 12:53:38 INFO - PID 17342 | |11;stanford-crypto-ccm;106;106;111;107;106;107;106;106;102;100 12:53:38 INFO - PID 17342 | |12;stanford-crypto-pbkdf2;145;154;146;144;144;145;152;149;159;146 12:53:38 INFO - PID 17342 | |13;stanford-crypto-sha256-iterative;60;57;57;58;59;59;57;58;58;57 12:53:38 INFO - PID 17342 | __end_tp_report 12:53:38 INFO - PID 17342 | __start_cc_report 12:53:38 INFO - PID 17342 | _x_x_mozilla_cycle_collect,672 12:53:38 INFO - PID 17342 | __end_cc_report 12:53:38 INFO - PID 17342 | __startTimestamp1506455618568__endTimestamp 12:53:38 INFO - PID 17342 | 12:53:38 INFO - PID 17342 | ------- Summary: start ------- 12:53:38 INFO - PID 17342 | Number of tests: 14 12:53:38 INFO - PID 17342 | 12:53:38 INFO - PID 17342 | [#0] ai-astar Cycles:10 Average:106.50 Median:106.50 stddev:2.17 (2.0%) stddev-sans-first:2.30 12:53:38 INFO - PID 17342 | Values: 107.0 107.0 104.0 106.0 106.0 107.0 112.0 105.0 106.0 105.0 12:53:38 INFO - PID 17342 | 12:53:38 INFO - PID 17342 | [#1] audio-beat-detection Cycles:10 Average:114.40 Median:112.50 stddev:8.50 (7.6%) stddev-sans-first:8.87 12:53:38 INFO - PID 17342 | Values: 110.0 111.0 114.0 114.0 111.0 115.0 138.0 110.0 110.0 111.0 12:53:38 INFO - PID 17342 | 12:53:38 INFO - PID 17342 | [#2] audio-dft Cycles:10 Average:161.60 Median:162.00 stddev:1.17 (0.7%) stddev-sans-first:1.22 12:53:38 INFO - PID 17342 | Values: 161.0 162.0 163.0 162.0 163.0 159.0 161.0 162.0 161.0 162.0 12:53:38 INFO - PID 17342 | 12:53:38 INFO - PID 17342 | [#3] audio-fft Cycles:10 Average:73.40 Median:73.00 stddev:0.97 (1.3%) stddev-sans-first:1.01 12:53:38 INFO - PID 17342 | Values: 73.0 75.0 72.0 73.0 73.0 73.0 73.0 73.0 75.0 74.0 12:53:38 INFO - PID 17342 | 12:53:38 INFO - PID 17342 | [#4] audio-oscillator Cycles:10 Average:78.70 Median:78.50 stddev:2.71 (3.5%) stddev-sans-first:2.80 12:53:38 INFO - PID 17342 | Values: 77.0 84.0 83.0 77.0 78.0 77.0 79.0 76.0 77.0 79.0 12:53:38 INFO - PID 17342 | 12:53:38 INFO - PID 17342 | [#5] imaging-gaussian-blur Cycles:10 Average:113.20 Median:114.00 stddev:1.69 (1.5%) stddev-sans-first:1.79 12:53:38 INFO - PID 17342 | Values: 113.0 114.0 110.0 113.0 113.0 114.0 114.0 114.0 111.0 116.0 12:53:38 INFO - PID 17342 | 12:53:38 INFO - PID 17342 | [#6] imaging-darkroom Cycles:10 Average:149.00 Median:149.00 stddev:1.63 (1.1%) stddev-sans-first:1.69 12:53:38 INFO - PID 17342 | Values: 150.0 148.0 149.0 153.0 149.0 147.0 149.0 148.0 149.0 148.0 12:53:38 INFO - PID 17342 | 12:53:38 INFO - PID 17342 | [#7] imaging-desaturate Cycles:10 Average:94.20 Median:94.00 stddev:0.92 (1.0%) stddev-sans-first:0.87 12:53:38 INFO - PID 17342 | Values: 93.0 94.0 94.0 94.0 93.0 96.0 95.0 94.0 94.0 95.0 12:53:38 INFO - PID 17342 | 12:53:38 INFO - PID 17342 | [#8] json-parse-financial Cycles:10 Average:42.50 Median:43.00 stddev:1.18 (2.7%) stddev-sans-first:0.83 12:53:38 INFO - PID 17342 | Values: 45.0 41.0 42.0 43.0 42.0 43.0 43.0 43.0 42.0 41.0 12:53:38 INFO - PID 17342 | 12:53:38 INFO - PID 17342 | [#9] json-stringify-tinderbox Cycles:10 Average:39.10 Median:39.00 stddev:1.45 (3.7%) stddev-sans-first:1.48 12:53:38 INFO - PID 17342 | Values: 38.0 38.0 39.0 39.0 39.0 43.0 39.0 39.0 38.0 39.0 12:53:38 INFO - PID 17342 | 12:53:38 INFO - PID 17342 | [#10] stanford-crypto-aes Cycles:10 Average:69.80 Median:70.00 stddev:0.92 (1.3%) stddev-sans-first:0.97 12:53:38 INFO - PID 17342 | Values: 70.0 70.0 70.0 72.0 69.0 69.0 70.0 70.0 69.0 69.0 12:53:38 INFO - PID 17342 | 12:53:38 INFO - PID 17342 | [#11] stanford-crypto-ccm Cycles:10 Average:105.70 Median:106.00 stddev:2.95 (2.8%) stddev-sans-first:3.12 12:53:38 INFO - PID 17342 | Values: 106.0 106.0 111.0 107.0 106.0 107.0 106.0 106.0 102.0 100.0 12:53:38 INFO - PID 17342 | 12:53:38 INFO - PID 17342 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:148.40 Median:147.50 stddev:5.06 (3.4%) stddev-sans-first:5.21 12:53:38 INFO - PID 17342 | Values: 145.0 154.0 146.0 144.0 144.0 145.0 152.0 149.0 159.0 146.0 12:53:38 INFO - PID 17342 | 12:53:38 INFO - PID 17342 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:58.00 Median:58.00 stddev:1.05 (1.8%) stddev-sans-first:0.83 12:53:38 INFO - PID 17342 | Values: 60.0 57.0 57.0 58.0 59.0 59.0 57.0 58.0 58.0 57.0 12:53:38 INFO - PID 17342 | -------- Summary: end -------- 12:53:38 INFO - PID 17342 | 12:53:39 INFO - PID 17342 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 12:53:39 INFO - TEST-INFO | 17342: exit 0 12:53:39 INFO - TEST-OK | kraken | took 58890ms 12:53:39 INFO - SUITE-END | took 1166s 12:53:39 INFO - Completed test suite (00:19:26) 12:53:39 INFO - javascript benchmark 12:53:39 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 9385.447066095136, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [4034.193161367725, 4048.615381538753, 4050.210209009243, 4078.612531809478, 4084.6936479764026, 6501.674916254186, 6569.24453687826, 6654.966725166368, 6668.133142691456, 6677.866442671144, 6462.547621666486, 6579.967100164505, 6629.767958121467, 6655.0682904393425, 6710.8657826843555, 5942.435468630473, 5981.013132833077, 6003.579749417553, 6006.729697163616, 6044.0, 5968.1346204800275, 5975.52195824333, 5977.222961015062, 6076.817695469143, 6098.268207815068, 5903.203067585864, 6023.518118550527, 6059.606125601844, 6060.2121724175795, 6068.150458935753, 5890.793822216223, 5921.526277897801, 5932.080527518198, 5980.102984552308, 6011.489023433035, 5740.368559458456, 5763.682997435139, 5814.854628634275, 5850.444207800295, 5885.882282354329, 6487.6756162191705, 6530.771423000172, 6533.869322613568, 6543.738250469975, 6556.672166391661, 7190.640467976633, 7272.8545429091655, 7281.235470275651, 7297.854042919165, 7300.7444739434395, 7219.458540609423, 7230.746923857692, 7272.4909256352075, 7303.452241081887, 7336.046313979202, 6554.377334153248, 6595.1096601958125, 6622.403983641495, 6640.966795166041, 6661.500387470959, 7288.344049035506, 7298.197198308182, 7318.414526837947, 7390.5196162249285, 7439.995600593958, 7105.076340075757, 7115.89326160108, 7121.181064177582, 7209.423246140296, 7223.061002069698, 7175.8564828704175, 7215.711371545184, 7247.347738703436, 7290.270972902774, 7327.303906128909, 7015.473839462061, 7088.645567721594, 7093.574385536885, 7099.183593886666, 7125.42996560274, 7096.893546596805, 7113.608751518716, 7159.713611455588, 7189.4967352285885, 7190.316919892602, 5306.522412982773, 5362.329708786402, 5376.946230537723, 5378.408375078739, 5383.569314454834, 4815.927761083586, 4866.829660961849, 4872.731999739977, 4885.047415753965, 4896.290037944478, 6590.670466476657, 6661.4004739573675, 6678.799636010927, 6692.631905245161, 6755.425788807908, 7046.577205367695, 7091.290870912868, 7098.60957647324, 7126.928730712731, 7133.0, 6626.171728533934, 6630.0, 6635.701393437307, 6677.699503522354, 6712.12742343502, 6084.0, 6090.23872015998, 6144.969275153596, 6167.938320616826, 6177.351378105324, 7285.7814265572115, 7433.070866141732, 7459.738909138154, 7473.065866766654, 7491.0, 7078.787636370917, 7082.0, 7123.465740069412, 7168.67740951648, 7173.5337203081635, 7374.078240219973, 7379.963100184465, 7382.744933361234, 7457.2542745724995, 7478.626068696434, 6845.897311540431, 6892.793216203522, 6975.093237879043, 6985.44116470671, 7172.713091476283, 7137.10786151731, 7221.494495385273, 7284.125904891235, 7284.271572842674, 7289.16174639902, 6821.113255276782, 6957.512974091967, 6980.581165130108, 7047.788566343018, 7055.2944705529035, 6839.487038472035, 6866.0, 6866.759663411756, 6869.107016087876, 6880.346367095118, 6807.3873351398615, 6813.2846051163915, 6818.352256535622, 6818.965905170442, 6836.145481814773, 6731.865362692816, 6756.527043107132, 6797.592144471348, 6843.076184715199, 6872.347127022925, 6651.866962660622, 6686.53194276396, 6772.864542709217, 6774.390304872585, 6820.7271709133065], "value": 6553.900563397792, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [965.613754498201, 968.8498282766174, 976.214147611173, 1017.5065093429686, 1026.938383696978, 45440.0, 46197.538024619746, 46253.76873115634, 46378.0, 46453.30320045202, 44003.0, 44043.55956440435, 44054.55945440553, 44156.558434415725, 44258.11483770323, 8137.593120343989, 8200.917990820075, 8202.425830191889, 8203.753887383358, 8214.917850821475, 8104.3921705872, 8214.753557393287, 8221.136780638037, 8221.876671849897, 8234.094249632535, 8231.95884020579, 8880.822383552326, 8953.104689531026, 8990.145936136056, 9063.728088157366, 8869.778255543599, 8909.420887642282, 8926.062763409846, 8928.330375221853, 8929.508877011762, 8790.604422800989, 8866.202041816268, 8873.911260887438, 8921.464712117293, 8923.687670931486, 41485.79257103695, 41767.791161044, 41815.1636967259, 41883.0, 41934.370984435256, 3815.2560250751117, 3853.499045124144, 3860.884173474772, 3871.612838716134, 3875.65119139276, 34244.0, 34379.656203437895, 34445.655543444496, 34457.82771086154, 34523.13692157691, 5649.6327738696855, 5667.149927510906, 5720.3135623725, 5733.713314334308, 5844.064949608042, 222041.0, 223005.0, 224379.87810061008, 224738.0, 224836.0, 51986.22020669693, 52140.47859521432, 52391.0, 54247.45752542424, 55002.17496737552, 57783.0, 58133.0, 58157.0, 58291.70854145787, 58294.41705582975, 17838.643227135643, 18001.459956201335, 18124.45626631203, 18128.728069078974, 18143.0, 14901.776473352907, 14914.552563423114, 14923.626909327353, 14946.32741526634, 15071.246437678072, 15665.608359791097, 15707.842921570867, 15708.136052516993, 15730.528084157493, 15745.291461884242, 5909.586328957018, 5962.284525856925, 5988.6706231157705, 6057.757689692451, 6092.8674963763215, 1055.0926203465015, 1064.2177999170603, 1083.1118482843992, 1091.6397588795678, 1101.4712937789907, 25668.486630267664, 25748.48503029929, 25815.225543233733, 25894.35264118412, 25915.0, 1177.364223319415, 1183.0240051956998, 1195.1872726545857, 1205.6744678936639, 1225.197495640357, 13187.142835715647, 13428.731425371438, 13664.521741738992, 13681.794773078413, 13873.236971966639, 309420.0, 310877.0, 310890.0, 311727.0, 312931.0, 52505.0, 52617.0, 53690.73154634202, 60464.697676512216, 61565.69217153885, 1573.913434761099, 1575.322611277139, 1584.6513766971248, 1589.3563106941708, 1589.4039735099338, 31066.0, 31266.687333126378, 31392.372152557276, 32245.838770805996, 32354.514682279314, 42620.14759704727, 42712.14575708531, 42726.0, 42737.57262427336, 42746.0, 252947.0, 254261.0, 254484.0, 254565.0, 255258.0, 36744.81627591845, 37589.624103758615, 38319.23361532809, 38348.6165138345, 38384.23231535409, 48422.0, 48647.75676121597, 48661.5133848657, 49308.75345623393, 49722.0, 35440.46839297361, 35875.28249434944, 36102.8194859024, 36121.27757444889, 36176.27647447089, 35310.23448827497, 35422.291554169286, 35499.467507987916, 35602.46596301006, 35928.46107308445, 41304.0, 41354.586454135075, 41532.3770143442, 41542.0, 41545.0, 34254.14364640804, 34405.65594344125, 34447.311053778285, 34768.130796730286, 35072.29855402929, 26070.608940865524, 26529.867350663895, 26797.330066748487, 26805.731942681105, 27109.864450678408], "value": 19342.910451317897, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [634.3434545245672, 634.4004915354989, 634.9713464188011, 638.3616383616383, 653.1900443450122, 23234.41913952152, 24378.39054023648, 24807.75192248077, 25202.49595008099, 25295.36761580964, 27723.584146237772, 28038.579421308696, 28062.298442538948, 28087.0, 28096.578551321694, 6654.866902661944, 6829.078074459934, 6835.07726456927, 6891.448684105285, 7176.964115179417, 6989.54567953084, 7027.051348068022, 7029.5430796998035, 7033.683484243222, 7040.753573624924, 6950.582965022089, 6953.304669533057, 6990.231074581792, 7000.439964802829, 7007.964960175192, 6913.688884000232, 6917.51577389583, 6946.097007389032, 6958.338957799001, 6983.755568555076, 6513.250976137758, 6523.478121750249, 6536.673166341711, 6540.0, 6541.34586541342, 29059.564106538208, 31392.686073139204, 31529.684703152903, 31553.0, 31583.210419739462, 2407.3500154958065, 2432.0514999150346, 2435.0, 2439.0731522021697, 2439.3657649011207, 19882.801171988238, 20192.899035504728, 20705.68941465879, 20710.378688639365, 20789.376318710463, 2532.4048848520583, 2561.1676205233375, 2567.858767767772, 2605.726398728144, 2608.960865587018, 129165.0, 135936.0, 160216.0, 167530.0, 168088.99999999878, 16230.269637866324, 16421.83578164227, 16834.831651683326, 17209.397671081453, 17371.913140434215, 27051.323716907234, 27242.727572724416, 27282.5907611386, 27337.0, 27400.314992124957, 10745.731356716145, 10859.67420977356, 10964.671059868217, 10970.0, 11024.724381890517, 9944.453055081894, 9992.200623950066, 10019.098281154731, 10109.342892712097, 10147.238957078102, 9828.31201815866, 9920.206383489303, 10119.595216191417, 10172.440515771703, 10304.639337623148, 3015.0, 3095.721385075354, 3102.875884964576, 3139.4035133324596, 3193.1857376369344, 1058.6982709927634, 1071.8606581144556, 1076.2143635146388, 1078.3044936016227, 1084.810158222308, 21660.0, 21696.78303216979, 21898.9050547472, 21916.23293184731, 22144.0, 1144.6337172104847, 1148.362658724416, 1151.6429906728774, 1151.6660168551027, 1153.4521102476256, 11848.526058957545, 12236.571719989757, 12264.325462099492, 12353.876461235452, 12361.814572781415, 566944.0, 575049.0, 582199.0, 588855.0, 614297.0, 133556.0, 134123.0, 137233.0, 137281.0, 139125.0, 1280.4238092858066, 1330.068951733771, 1371.2663724907327, 1395.5255213227551, 1400.7548678981138, 23476.060957561505, 23512.76487235174, 23640.054397823893, 23882.40293992664, 23890.40273993164, 67611.0, 68459.65770171117, 68671.31328686849, 68919.31080689329, 69160.65419672869, 78432.03919902048, 78797.0, 79622.60188699019, 79727.0, 79739.60130199311, 16405.42581009659, 16634.584135396228, 16646.916765416096, 16745.91627041857, 16779.664406711552, 25163.622545661463, 25207.0, 25231.495370092864, 25643.743562564134, 25773.484530308913, 19260.518487037934, 19416.611667766283, 19607.509812254808, 19634.705479418106, 19654.60690786205, 18235.270589176285, 18475.445736627924, 18587.535311617317, 18647.533811654816, 18751.812481875008, 20152.697709534663, 21024.0, 21139.365819025454, 21288.574228515652, 21296.893515532942, 15522.689546209238, 16302.0, 16360.754588680942, 16383.836161638708, 16452.177391130634, 19539.70690439616, 19553.902230488755, 19588.510287242934, 19750.703739443634, 19987.300444484372], "value": 13317.956729726413, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1443.3432788081425, 1482.1033274868705, 1495.7008598280347, 1502.9398824047041, 1515.5756388211298, 17282.395116170937, 17978.910105449486, 18003.729944050832, 18014.0, 18032.63934721308, 17361.91319043403, 17542.561435964108, 17603.471895843115, 17626.735598965995, 17699.64600707985, 2918.4163167366505, 2918.6497620285595, 2969.4506516294555, 2983.8060526065738, 2988.178250980976, 2870.4833130036586, 2907.665618453884, 2924.7660187184974, 2929.2969687275113, 2933.6919623439444, 2901.434220327037, 3001.789874708771, 3086.552449894764, 3086.66046734859, 3105.0529588475506, 2975.4495418347674, 2978.4638765022287, 3021.3957208558377, 3054.0, 3068.4783586790077, 2869.6556413230546, 2893.146521776081, 2936.060460652592, 2937.911862644124, 2938.853057347124, 16975.91512042444, 17134.05762683052, 17175.914120429443, 17257.137143142918, 17352.0, 8810.0, 9016.8647470288, 9067.954660226722, 9068.0, 9098.999110097884, 5993.9400605993815, 6024.21685180928, 6205.937940620626, 6215.471684906788, 6241.78153764616, 2134.8292136629034, 2150.1506904772527, 2173.6124827177596, 2222.122261706633, 2224.4216503709154, 31515.321197698224, 31764.523532147035, 31777.682223177933, 31812.84093579517, 31834.044978650676, 7264.164621068539, 7389.0, 7431.554106753612, 7600.619969001527, 7616.04799400075, 19520.121594528282, 19590.510237244183, 19649.410517684493, 19701.50746231327, 19756.407307780788, 8273.586320683942, 8502.44734092282, 8511.74464766058, 8511.95744021276, 8515.14848515156, 7641.656125474367, 7719.498232614862, 7792.220777922275, 7805.492642978188, 7877.0, 5758.654480731169, 5943.70281485924, 6111.54163437744, 6113.57204995646, 6209.627422354673, 1507.8190617126015, 1530.9387624495118, 1596.0583255879087, 1631.4779270633283, 1721.5696075981004, 966.8936416994125, 971.4074414607084, 974.8732664753537, 985.074030411411, 995.5520015992687, 9001.729948101567, 9085.13691199335, 9190.49452280131, 9476.431414115175, 9492.098250666175, 1068.1027936533194, 1079.4440862955585, 1088.5591335509132, 1093.7593729379682, 1102.2009043443438, 4951.876203094951, 4965.205567109245, 5049.545540901263, 5073.594112470993, 5126.179811230185, 25296.0, 25841.353966150997, 26449.47101057968, 26674.066407675637, 26696.866515667298, 25591.23226303214, 25911.352216194748, 26096.739032609432, 26109.608355874676, 26131.869340653557, 12054.457549410297, 12647.367631618383, 12802.295873727035, 12814.35928203586, 12886.484540618458, 9062.954685226532, 9096.408733432305, 9109.271258299188, 9133.041030691948, 9162.037986011374, 21418.678719818905, 21654.783452165906, 21891.562168756853, 21919.671204932256, 22205.444863877885, 22655.773442266025, 22758.65862012038, 22904.427389315402, 23299.417514562272, 23468.76531234734, 12299.754004919672, 12569.371531423576, 12629.2422454653, 12684.429200685807, 12695.238285702888, 15288.235588220767, 15581.610459738597, 15747.291371888063, 15794.76307855406, 15796.36814527406, 11661.883381166079, 12061.939690301493, 12312.322822244505, 12317.137800353888, 13032.283224422748, 12438.253704777742, 12648.810267845805, 12837.101402901708, 12854.293013884326, 12859.29273889945, 9928.205743540355, 10030.348027378197, 10047.598096076075, 10048.89951100509, 10093.848592270975, 7772.378209743094, 7863.449558530848, 7912.881306780518, 7938.24586664266, 7958.761237162895, 8106.229908158715, 8145.67417303325, 8173.34613230952, 8195.057568379474, 8275.62759675828], "value": 7454.01780734648, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [565.4430386069721, 574.8936446757348, 591.6982339007106, 612.0818771842237, 612.3233826621583, 6383.553151279412, 6423.454006409455, 6488.837779055526, 6532.575382600127, 6587.110740050091, 6406.903896441546, 6442.742290308382, 6465.48276137909, 6476.514261430388, 6489.383508566691, 5316.6544174628525, 5386.602961682053, 5414.106672399069, 5445.292112025431, 5448.174861421408, 5153.3815942087, 5213.530782229599, 5222.843314700565, 5248.947510524903, 5448.37343705475, 5173.767180476869, 5183.678162068667, 5225.346831646044, 5231.136862417697, 5239.633225674204, 5220.582353411756, 5233.3981592116825, 5235.1623740201385, 5239.607029472805, 5256.7897284108785, 4709.387779588666, 4715.905681886343, 4743.715377077352, 4748.738819364934, 4783.354247176656, 6421.711023003976, 6447.484201263887, 6451.612903225775, 6474.838129046764, 6491.415772580491, 6124.418180272912, 6157.706881554879, 6163.537734669872, 6190.380961903774, 6194.783182588633, 6928.272531384233, 6992.937083560311, 7000.929990700079, 7011.684474198673, 7016.824784316878, 5141.845744627667, 5350.91973620396, 5356.571474282048, 5361.276227709248, 5387.622866399353, 7113.573185608829, 7125.82185445368, 7168.702396897382, 7247.528910620846, 7304.598247096407, 5485.533729633026, 5490.56075513958, 5498.835034948958, 5505.421930697299, 5507.531859791962, 5573.526250268692, 5580.553555715533, 5586.385497595261, 5645.068563687028, 5650.26546548946, 6224.657643829542, 6233.283172435228, 6241.469475094668, 6243.500519958392, 6267.905981410283, 6927.7228910844005, 6979.3020697930815, 7008.404285635676, 7034.6282474917925, 7037.859242815115, 1891.3380316889254, 1915.3775023117541, 1922.6539222939725, 1929.9421017369502, 1937.5156210947264, 1341.9463221471226, 1376.2018029542842, 1383.1355402873205, 1384.806127142201, 1386.7172865099742, 6427.807165785034, 6479.838004049937, 6487.610743355413, 6575.276719560845, 6585.814553380437, 6989.89515157273, 7022.754203602952, 7031.8242043948285, 7048.753293634698, 7098.68055937484, 6438.356164383524, 6490.221173459121, 6524.934750652527, 6560.704768285439, 6577.506686998494, 3658.2683463307444, 3698.278835627027, 3702.148505843671, 3714.60996595359, 3739.8504059837846, 7180.3537681608905, 7223.92776072243, 7270.890936635955, 7313.780586582411, 7327.8534429312185, 7265.927340726631, 7269.8546029079125, 7277.345038946414, 7282.162551306562, 7318.780436586911, 7224.8079066954415, 7365.668544915385, 7399.408047356199, 7452.590107544029, 7476.663550140257, 6917.13535808024, 6991.405730512964, 6993.755218567326, 7030.367266945999, 7039.753608623673, 7007.824804379931, 7046.577205367695, 7107.573545587281, 7126.394256488256, 7140.571565706075, 7338.743143989935, 7355.8896616551865, 7362.411007119525, 7377.299156580117, 7429.591372474566, 5437.184422336523, 5485.533729632866, 5502.449755024466, 5510.118381059172, 5523.917141242804, 6840.179178498612, 6846.863062738617, 6955.339242771928, 6969.756058537927, 7052.294770522906, 6828.0, 6879.1744990599445, 6894.207166175954, 6922.134733158356, 6955.8956615649795, 6817.488688348493, 6862.176538815374, 6885.2770459101075, 6890.793276201722, 6918.962155676689, 6737.494687898526, 6807.353301436356, 6830.590164589942, 6839.418649414855, 6843.281455447106, 6837.2992667894905, 6879.828004299732, 6934.583924964519, 6986.650667466504, 7022.0, 6676.494840208929, 6715.5299129060495, 6723.932760672331, 6736.74319103106, 6790.083338749403], "value": 5444.33986443552, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1018.7656838927047, 1027.7071034755093, 1028.1209565821218, 1032.9567137191434, 1056.482323661406, 18313.54216144597, 18532.62934741306, 18839.43481695548, 18900.905495472536, 18960.62078758424, 17003.0, 17019.914900425512, 17075.82924170758, 17099.572510687238, 17173.656526869454, 1082.9025387715103, 1099.8845121262273, 1101.5043230546246, 1106.634810512529, 1107.1696227829127, 1063.0698139128262, 1093.8851420600843, 1099.34039576254, 1101.432762127505, 1101.6474728087014, 1151.5739176504662, 1155.104793784815, 1157.056998546182, 1163.1973937982807, 1164.7262893220086, 1147.615548791156, 1147.7073346296725, 1150.6433005768156, 1151.8157094864823, 1155.537784886044, 831.7587899509135, 847.3433089355736, 858.150431073233, 858.9785255368603, 859.2052351574769, 19312.517187070294, 19683.606327873506, 19701.704474432896, 19800.306989255307, 21195.0, 22837.20069797566, 23322.533549328917, 23625.527489450287, 23682.0, 23824.523509529714, 17960.730589041174, 18100.185491652777, 18110.456686299432, 18244.270229190817, 18261.360852370235, 4055.513338399411, 4070.124923141509, 4114.814833332507, 4117.114820313617, 4118.546959834416, 162881.0, 166496.0, 167152.0, 168134.0, 168431.1578442112, 15508.5347439577, 15563.377464901278, 15577.844221557865, 15580.065196088271, 15601.219939003004, 35630.64369356325, 36135.0, 36212.818935905154, 36221.8188909059, 36308.27383452369, 9094.590743416562, 9148.359614827032, 9155.450672959643, 9235.26117910579, 9240.122188392092, 4792.257200133985, 4863.708177509361, 4878.926816097762, 4880.511948805091, 4893.926591101136, 6386.425221730066, 6396.9360306397275, 6505.447037001908, 6527.5430719849155, 6532.0, 1209.6492017314881, 1216.1145141273546, 1228.2507670321097, 1228.3060071059822, 1229.6802831263935, 720.2797202797203, 733.7211859493465, 740.9407247420194, 746.0711414289244, 757.121738783009, 12139.077174764072, 12357.629271121881, 12851.16467429614, 13088.476460941456, 13150.0, 725.7532438970775, 727.3308556128375, 741.3957624535985, 742.8848528478095, 756.1833220122255, 5811.56413268998, 5866.501347385435, 5962.463378295887, 5971.552133589998, 6043.244594425697, 154914.0, 157012.0, 157545.21227393788, 157653.0, 165120.0, 137522.0, 137574.0, 138404.30797846147, 142100.0, 146460.0, 119920.0, 122026.38986805009, 122394.38802806108, 122530.0, 125470.99999999818, 11313.943430282796, 11347.751747307624, 11380.772384552429, 11452.942735286604, 11547.826782598437, 57598.0, 58481.0, 58601.70699146477, 59302.0, 60983.0, 74248.0, 74757.2524274772, 75380.0, 77498.6125069371, 77677.223227767, 18083.90958045254, 18230.17964191588, 18412.35556755507, 18499.630007399508, 18596.0, 17784.0, 17924.731129032814, 17939.551511212325, 17946.461606151835, 17956.19197136106, 18932.810671893105, 19074.23703051918, 19198.232070717015, 19204.943728095088, 19381.224751009802, 18803.623927521647, 18898.52753681169, 18915.432537023913, 18916.148773304958, 18958.52603684919, 15808.683826323639, 15933.12367819781, 15982.200889955688, 16017.519474415787, 16086.517404477885, 12728.809067863804, 12738.0, 12802.487900483877, 12947.482100715866, 12996.935015324863, 12351.320677362472, 12527.560233451317, 12549.0, 12636.810447843474, 12705.682357941125], "value": 9974.924346919888, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1354.5000000000002, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [107.0, 107.0, 104.0, 106.0, 106.0, 107.0, 112.0, 105.0, 106.0, 105.0], "value": 106.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 111.0, 114.0, 114.0, 111.0, 115.0, 138.0, 110.0, 110.0, 111.0], "value": 114.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 162.0, 163.0, 162.0, 163.0, 159.0, 161.0, 162.0, 161.0, 162.0], "value": 161.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 75.0, 72.0, 73.0, 73.0, 73.0, 73.0, 73.0, 75.0, 74.0], "value": 73.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 84.0, 83.0, 77.0, 78.0, 77.0, 79.0, 76.0, 77.0, 79.0], "value": 78.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 114.0, 110.0, 113.0, 113.0, 114.0, 114.0, 114.0, 111.0, 116.0], "value": 113.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 148.0, 149.0, 153.0, 149.0, 147.0, 149.0, 148.0, 149.0, 148.0], "value": 149.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 94.0, 94.0, 94.0, 93.0, 96.0, 95.0, 94.0, 94.0, 95.0], "value": 94.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [45.0, 41.0, 42.0, 43.0, 42.0, 43.0, 43.0, 43.0, 42.0, 41.0], "value": 42.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [38.0, 38.0, 39.0, 39.0, 39.0, 43.0, 39.0, 39.0, 38.0, 39.0], "value": 39.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 70.0, 70.0, 72.0, 69.0, 69.0, 70.0, 70.0, 69.0, 69.0], "value": 69.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [106.0, 106.0, 111.0, 107.0, 106.0, 107.0, 106.0, 106.0, 102.0, 100.0], "value": 105.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 154.0, 146.0, 144.0, 144.0, 145.0, 152.0, 149.0, 159.0, 146.0], "value": 148.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 57.0, 57.0, 58.0, 59.0, 59.0, 57.0, 58.0, 58.0, 57.0], "value": 58.0, "unit": "score"}]}]} 12:53:39 INFO - Return code: 0 12:53:39 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 12:53:39 INFO - # TBPL SUCCESS # 12:53:39 INFO - Running post-action listener: _package_coverage_data 12:53:39 INFO - Running post-action listener: _resource_record_post_action 12:53:39 INFO - [mozharness: 2017-09-26 19:53:39.885017Z] Finished run-tests step (success) 12:53:39 INFO - Running post-run listener: _resource_record_post_run 12:53:39 INFO - Total resource usage - Wall time: 1181s; CPU: 13.0%; Read bytes: 12288; Write bytes: 283250688; Read time: 548; Write time: 191032 12:53:39 INFO - TinderboxPrint: CPU usage
13.1% 12:53:39 INFO - TinderboxPrint: I/O read bytes / time
12,288 / 548 12:53:39 INFO - TinderboxPrint: I/O write bytes / time
283,250,688 / 191,032 12:53:39 INFO - TinderboxPrint: CPU idle
8,186.7 (86.9%) 12:53:39 INFO - TinderboxPrint: CPU user
1,179.7 (12.5%) 12:53:39 INFO - TinderboxPrint: Swap in / out
0 / 0 12:53:39 INFO - install - Wall time: 15s; CPU: 13.0%; Read bytes: 0; Write bytes: 12484608; Read time: 0; Write time: 1428 12:53:39 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 12:53:39 INFO - run-tests - Wall time: 1167s; CPU: 13.0%; Read bytes: 12288; Write bytes: 270766080; Read time: 548; Write time: 189604 12:53:40 INFO - Running post-run listener: _upload_blobber_files 12:53:40 INFO - Blob upload gear active. 12:53:40 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 12:53:40 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 12:53:40 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', 'Mozilla-Beta-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 12:53:40 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 Mozilla-Beta-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 12:53:40 INFO - (blobuploader) - INFO - Open directory for files ... 12:53:40 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 12:53:40 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:53:40 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:53:41 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 12:53:41 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:53:41 INFO - (blobuploader) - INFO - Done attempting. 12:53:41 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 12:53:41 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:53:41 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:53:43 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 12:53:43 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:53:43 INFO - (blobuploader) - INFO - Done attempting. 12:53:43 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 12:53:43 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:53:43 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:53:51 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 12:53:51 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:53:51 INFO - (blobuploader) - INFO - Done attempting. 12:53:51 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 12:53:51 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:53:51 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:53:52 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 12:53:52 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:53:52 INFO - (blobuploader) - INFO - Done attempting. 12:53:52 INFO - (blobuploader) - INFO - Iteration through files over. 12:53:52 INFO - Return code: 0 12:53:52 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 12:53:52 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 12:53:52 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/0b1697559950850942d97e50875962eb0bbba23e4ad2463ba4dbb0075eded10b208f4f9d015b02fb227287dd9e475a078c7120d9af7e62f2757032c6973bf35c", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/ce588daa02afae835046d7a259dbef04e6818e6bd161a5bd0401d07e1f7de3a817eb84948486767f309d9a6458cdfdc075749b1720144def87ab2e743f58cba7", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/c08c742249965293889ad712017b3b072bd1136906a0c379772f603d690931706f5184ed26ab941185cd96179f5a6249aa008c6d6e733747e749ec03b3072e3f", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/2065c187397d8402f00224a4818d47befcccf0d92dca8a4e569b9c5e2598bb1c99dd7769e0d513b5a24f54a676d56d16a87c451c00c99385a5d3b556b2ba401a"} 12:53:52 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 12:53:52 INFO - Writing to file /builds/slave/test/properties/blobber_files 12:53:52 INFO - Contents: 12:53:52 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/0b1697559950850942d97e50875962eb0bbba23e4ad2463ba4dbb0075eded10b208f4f9d015b02fb227287dd9e475a078c7120d9af7e62f2757032c6973bf35c", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/ce588daa02afae835046d7a259dbef04e6818e6bd161a5bd0401d07e1f7de3a817eb84948486767f309d9a6458cdfdc075749b1720144def87ab2e743f58cba7", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/c08c742249965293889ad712017b3b072bd1136906a0c379772f603d690931706f5184ed26ab941185cd96179f5a6249aa008c6d6e733747e749ec03b3072e3f", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/2065c187397d8402f00224a4818d47befcccf0d92dca8a4e569b9c5e2598bb1c99dd7769e0d513b5a24f54a676d56d16a87c451c00c99385a5d3b556b2ba401a"} 12:53:52 INFO - Running post-run listener: copy_logs_to_upload_dir 12:53:52 INFO - Copying logs to upload dir... 12:53:52 INFO - mkdir: /builds/slave/test/build/upload/logs 12:53:52 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1235.925227 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 35 secs) (at 2017-09-26 12:53:52.263312) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-26 12:53:52.269125) ========= 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=5cf47e208febbcd81da23b2e0000026f-1506453608.174477-904915991 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/Mozilla-Beta-Non-PGO/sha512/0b1697559950850942d97e50875962eb0bbba23e4ad2463ba4dbb0075eded10b208f4f9d015b02fb227287dd9e475a078c7120d9af7e62f2757032c6973bf35c", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/ce588daa02afae835046d7a259dbef04e6818e6bd161a5bd0401d07e1f7de3a817eb84948486767f309d9a6458cdfdc075749b1720144def87ab2e743f58cba7", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/c08c742249965293889ad712017b3b072bd1136906a0c379772f603d690931706f5184ed26ab941185cd96179f5a6249aa008c6d6e733747e749ec03b3072e3f", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/2065c187397d8402f00224a4818d47befcccf0d92dca8a4e569b9c5e2598bb1c99dd7769e0d513b5a24f54a676d56d16a87c451c00c99385a5d3b556b2ba401a"} build_url:https://queue.taskcluster.net/v1/task/I1eCh6_kSp-ZjFnEQUHzVw/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011569 build_url: 'https://queue.taskcluster.net/v1/task/I1eCh6_kSp-ZjFnEQUHzVw/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/0b1697559950850942d97e50875962eb0bbba23e4ad2463ba4dbb0075eded10b208f4f9d015b02fb227287dd9e475a078c7120d9af7e62f2757032c6973bf35c", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/ce588daa02afae835046d7a259dbef04e6818e6bd161a5bd0401d07e1f7de3a817eb84948486767f309d9a6458cdfdc075749b1720144def87ab2e743f58cba7", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/c08c742249965293889ad712017b3b072bd1136906a0c379772f603d690931706f5184ed26ab941185cd96179f5a6249aa008c6d6e733747e749ec03b3072e3f", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/2065c187397d8402f00224a4818d47befcccf0d92dca8a4e569b9c5e2598bb1c99dd7769e0d513b5a24f54a676d56d16a87c451c00c99385a5d3b556b2ba401a"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-26 12:53:52.304595) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-26 12:53:52.304963) ========= 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=5cf47e208febbcd81da23b2e0000026f-1506453608.174477-904915991 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004603 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-26 12:53:52.386452) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-26 12:53:52.386765) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-26 12:53:52.387049) ========= ========= Total master_lag: 0.21 =========