builder: mozilla-central_ubuntu64_hw_test-dromaeojs-stylo-disabled-e10s slave: talos-linux64-ix-036 starttime: 1506222737.38 results: success (0) revision: 42aa84eec339c29bf3d21178ae6e5c138d50e82b ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-09-23 20:12:17.383912) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-09-23 20:12:17.384482) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-23 20:12:17.384753) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-23 20:12:17.407734) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-23 20:12:17.408055) ========= 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=14ef55db36f7623abb31b9cf000001d5-1506222262.388993-634593663 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-09-23 20:12:17-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 222M=0s 2017-09-23 20:12:17 (222 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.105699 ========= master_lag: 0.30 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-23 20:12:17.808780) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-23 20:12:17.809121) ========= 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=14ef55db36f7623abb31b9cf000001d5-1506222262.388993-634593663 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019023 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-23 20:12:17.862611) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-23 20:12:17.864952) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 42aa84eec339c29bf3d21178ae6e5c138d50e82b --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'python archiver_client.py mozharness --repo mozilla-central --rev 42aa84eec339c29bf3d21178ae6e5c138d50e82b --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=14ef55db36f7623abb31b9cf000001d5-1506222262.388993-634593663 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-09-23 20:12:18,070 truncating revision to first 12 chars 2017-09-23 20:12:18,070 Setting DEBUG logging. 2017-09-23 20:12:18,070 attempt 1/10 2017-09-23 20:12:18,070 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/42aa84eec339?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-09-23 20:12:18,593 unpacking tar archive at: mozilla-central-42aa84eec339/testing/mozharness/ program finished with exit code 0 elapsedTime=0.810212 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-23 20:12:18.690815) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-23 20:12:18.694111) ========= script_repo_revision: 42aa84eec339c29bf3d21178ae6e5c138d50e82b ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-23 20:12:18.694462) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-23 20:12:18.694718) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-23 20:12:18.710667) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 37 secs) (at 2017-09-23 20:12:18.710989) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-stylo-disabled-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-stylo-disabled-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=14ef55db36f7623abb31b9cf000001d5-1506222262.388993-634593663 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 20:12:19 INFO - MultiFileLogger online at 20170923 20:12:19 in /builds/slave/test 20:12:19 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-stylo-disabled-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 20:12:19 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 20:12:19 INFO - {'append_to_log': False, 20:12:19 INFO - 'base_work_dir': '/builds/slave/test', 20:12:19 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 20:12:19 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 20:12:19 INFO - 'branch': 'Firefox-Non-PGO', 20:12:19 INFO - 'buildbot_json_path': 'buildprops.json', 20:12:19 INFO - 'code_coverage': False, 20:12:19 INFO - 'config_files': ('talos/linux_config.py',), 20:12:19 INFO - 'default_actions': ('clobber', 20:12:19 INFO - 'read-buildbot-config', 20:12:19 INFO - 'download-and-extract', 20:12:19 INFO - 'populate-webroot', 20:12:19 INFO - 'create-virtualenv', 20:12:19 INFO - 'install', 20:12:19 INFO - 'setup-mitmproxy', 20:12:19 INFO - 'run-tests'), 20:12:19 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 20:12:19 INFO - 'disable_ccov_upload': False, 20:12:19 INFO - 'disable_stylo': False, 20:12:19 INFO - 'download_minidump_stackwalk': True, 20:12:19 INFO - 'download_symbols': 'ondemand', 20:12:19 INFO - 'enable_stylo': False, 20:12:19 INFO - 'enable_webrender': False, 20:12:19 INFO - 'exes': {'tooltool.py': '/tools/tooltool.py'}, 20:12:19 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 20:12:19 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 20:12:19 INFO - 'gecko_profile': False, 20:12:19 INFO - 'gecko_profile_interval': 0, 20:12:19 INFO - 'installer_path': 'installer.exe', 20:12:19 INFO - 'log_level': 'info', 20:12:19 INFO - 'log_name': 'talos', 20:12:19 INFO - 'log_to_console': True, 20:12:19 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 20:12:19 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 20:12:19 INFO - 'opt_config_files': (), 20:12:19 INFO - 'pip_index': False, 20:12:19 INFO - 'suite': 'dromaeojs-stylo-disabled-e10s', 20:12:19 INFO - 'system_bits': '32', 20:12:19 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 20:12:19 INFO - 'title': 'talos-linux64-ix-036', 20:12:19 INFO - 'tooltool_cache': '/builds/tooltool_cache', 20:12:19 INFO - 'use_talos_json': True, 20:12:19 INFO - 'verify': 'False', 20:12:19 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 20:12:19 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 20:12:19 INFO - 'work_dir': 'build'} 20:12:19 INFO - [mozharness: 2017-09-24 03:12:19.059295Z] Running clobber step. 20:12:19 INFO - Running pre-action listener: _resource_record_pre_action 20:12:19 INFO - Running main action method: clobber 20:12:19 INFO - rmtree: /builds/slave/test/build 20:12:19 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 20:12:20 INFO - Running post-action listener: _resource_record_post_action 20:12:20 INFO - [mozharness: 2017-09-24 03:12:20.061312Z] Finished clobber step (success) 20:12:20 INFO - [mozharness: 2017-09-24 03:12:20.061412Z] Running read-buildbot-config step. 20:12:20 INFO - Running pre-action listener: _resource_record_pre_action 20:12:20 INFO - Running main action method: read_buildbot_config 20:12:20 INFO - Using buildbot properties: 20:12:20 INFO - { 20:12:20 INFO - "project": "", 20:12:20 INFO - "product": "firefox", 20:12:20 INFO - "who": "philringnalda@gmail.com", 20:12:20 INFO - "installer_path": "public/build/target.tar.bz2", 20:12:20 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-stylo-disabled-e10s", 20:12:20 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 20:12:20 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-stylo-disabled-e10s", 20:12:20 INFO - "stage_platform": "linux64", 20:12:20 INFO - "basedir": "/builds/slave/test", 20:12:20 INFO - "buildnumber": 65, 20:12:20 INFO - "platform": "ubuntu64_hw", 20:12:20 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 20:12:20 INFO - "slavebuilddir": "test", 20:12:20 INFO - "taskId": "T6ehV6ZnT6mJwi1YVmrjDw", 20:12:20 INFO - "branch": "mozilla-central", 20:12:20 INFO - "script_repo_revision": "production", 20:12:20 INFO - "revision": "42aa84eec339c29bf3d21178ae6e5c138d50e82b", 20:12:20 INFO - "slavename": "talos-linux64-ix-036", 20:12:20 INFO - "repo_path": "mozilla-central" 20:12:20 INFO - } 20:12:20 INFO - Finding installer, test and symbols from parent task. 20:12:20 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/T6ehV6ZnT6mJwi1YVmrjDw'}, attempt #1 20:12:20 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/T6ehV6ZnT6mJwi1YVmrjDw'}, attempt #1 20:12:20 INFO - Task dependencies: JuOc-pfvTaqJ1Q-nyQhMGg 20:12:20 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/JuOc-pfvTaqJ1Q-nyQhMGg'}, attempt #1 20:12:21 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/JuOc-pfvTaqJ1Q-nyQhMGg/artifacts/public/build/target.tar.bz2 20:12:21 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/JuOc-pfvTaqJ1Q-nyQhMGg/artifacts/public/build/target.test_packages.json 20:12:21 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/JuOc-pfvTaqJ1Q-nyQhMGg/artifacts/public/build/target.crashreporter-symbols.zip 20:12:21 INFO - Running post-action listener: _resource_record_post_action 20:12:21 INFO - [mozharness: 2017-09-24 03:12:21.422842Z] Finished read-buildbot-config step (success) 20:12:21 INFO - [mozharness: 2017-09-24 03:12:21.423061Z] Running download-and-extract step. 20:12:21 INFO - Running pre-action listener: _resource_record_pre_action 20:12:21 INFO - Running main action method: download_and_extract 20:12:21 INFO - mkdir: /builds/slave/test/build/tests 20:12:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:12:21 INFO - trying https://queue.taskcluster.net/v1/task/JuOc-pfvTaqJ1Q-nyQhMGg/artifacts/public/build/target.test_packages.json 20:12:21 INFO - Downloading https://queue.taskcluster.net/v1/task/JuOc-pfvTaqJ1Q-nyQhMGg/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 20:12:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/JuOc-pfvTaqJ1Q-nyQhMGg/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 20:12:22 INFO - Downloaded 989 bytes. 20:12:22 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 20:12:22 INFO - Using the following test package requirements: 20:12:22 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 20:12:22 INFO - u'common': [u'target.common.tests.zip'], 20:12:22 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 20:12:22 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 20:12:22 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 20:12:22 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 20:12:22 INFO - u'mozbase': [u'target.common.tests.zip'], 20:12:22 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 20:12:22 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 20:12:22 INFO - u'web-platform': [u'target.common.tests.zip', 20:12:22 INFO - u'target.web-platform.tests.tar.gz'], 20:12:22 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 20:12:22 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite categories: ['common', 'talos'] 20:12:22 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/JuOc-pfvTaqJ1Q-nyQhMGg/artifacts/public/build/target.common.tests.zip 20:12:22 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/JuOc-pfvTaqJ1Q-nyQhMGg/artifacts/public/build/target.common.tests.zip'}, attempt #1 20:12:22 INFO - Fetch https://queue.taskcluster.net/v1/task/JuOc-pfvTaqJ1Q-nyQhMGg/artifacts/public/build/target.common.tests.zip into memory 20:12:23 INFO - Content-Length response header: 54943858 20:12:23 INFO - Bytes received: 54943858 20:12:33 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/JuOc-pfvTaqJ1Q-nyQhMGg/artifacts/public/build/target.talos.tests.zip 20:12:33 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/JuOc-pfvTaqJ1Q-nyQhMGg/artifacts/public/build/target.talos.tests.zip'}, attempt #1 20:12:33 INFO - Fetch https://queue.taskcluster.net/v1/task/JuOc-pfvTaqJ1Q-nyQhMGg/artifacts/public/build/target.talos.tests.zip into memory 20:12:34 INFO - Content-Length response header: 14513823 20:12:34 INFO - Bytes received: 14513823 20:12: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')]} 20:12:34 INFO - trying https://queue.taskcluster.net/v1/task/JuOc-pfvTaqJ1Q-nyQhMGg/artifacts/public/build/target.tar.bz2 20:12:34 INFO - Downloading https://queue.taskcluster.net/v1/task/JuOc-pfvTaqJ1Q-nyQhMGg/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 20:12:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/JuOc-pfvTaqJ1Q-nyQhMGg/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 20:12:36 INFO - Downloaded 61639506 bytes. 20:12:36 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/JuOc-pfvTaqJ1Q-nyQhMGg/artifacts/public/build/target.tar.bz2 20:12:36 INFO - mkdir: /builds/slave/test/properties 20:12:36 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 20:12:36 INFO - Writing to file /builds/slave/test/properties/build_url 20:12:36 INFO - Contents: 20:12:36 INFO - build_url:https://queue.taskcluster.net/v1/task/JuOc-pfvTaqJ1Q-nyQhMGg/artifacts/public/build/target.tar.bz2 20:12:36 INFO - Running post-action listener: _resource_record_post_action 20:12:36 INFO - Running post-action listener: find_tests_for_verification 20:12:36 INFO - Running post-action listener: set_extra_try_arguments 20:12:36 INFO - [mozharness: 2017-09-24 03:12:36.059316Z] Finished download-and-extract step (success) 20:12:36 INFO - [mozharness: 2017-09-24 03:12:36.059411Z] Running populate-webroot step. 20:12:36 INFO - Running pre-action listener: _resource_record_pre_action 20:12:36 INFO - Running main action method: populate_webroot 20:12:36 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 20:12:36 INFO - 'chromez-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 20:12:36 INFO - 'tests': ['tresize', 20:12:36 INFO - 'tcanvasmark']}, 20:12:36 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 20:12:36 INFO - 'dromaeojs-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 20:12:36 INFO - 'tests': ['dromaeo_css', 20:12:36 INFO - 'kraken']}, 20:12:36 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 20:12:36 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 20:12:36 INFO - 'g1-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 20:12:36 INFO - 'talos_options': ['--disable-stylo'], 20:12:36 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 20:12:36 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 20:12:36 INFO - 'tests': ['damp', 'tps']}, 20:12:36 INFO - 'g2-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 20:12:36 INFO - 'talos_options': ['--disable-stylo'], 20:12:36 INFO - 'tests': ['damp', 'tps']}, 20:12:36 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 20:12:36 INFO - 'g3-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 20:12:36 INFO - 'tests': ['dromaeo_dom']}, 20:12:36 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 20:12:36 INFO - 'g4-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 20:12:36 INFO - 'tests': ['basic_compositor_video', 20:12:36 INFO - 'glvideo']}, 20:12:36 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 20:12:36 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 20:12:36 INFO - 'g5-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 20:12:36 INFO - 'talos_options': ['--disable-stylo'], 20:12:36 INFO - 'tests': ['ts_paint_webext', 20:12:36 INFO - 'tp5o_webext']}, 20:12:36 INFO - 'other-e10s': {'tests': ['a11yr', 20:12:36 INFO - 'ts_paint', 20:12:36 INFO - 'tpaint', 20:12:36 INFO - 'sessionrestore', 20:12:36 INFO - 'sessionrestore_many_windows', 20:12:36 INFO - 'sessionrestore_no_auto_restore', 20:12:36 INFO - 'tabpaint']}, 20:12:36 INFO - 'other-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 20:12:36 INFO - 'tests': ['a11yr', 20:12:36 INFO - 'ts_paint', 20:12:36 INFO - 'tpaint', 20:12:36 INFO - 'sessionrestore', 20:12:36 INFO - 'sessionrestore_many_windows', 20:12:36 INFO - 'sessionrestore_no_auto_restore', 20:12:36 INFO - 'tabpaint']}, 20:12:36 INFO - 'perf-reftest-e10s': {'tests': ['perf_reftest']}, 20:12:36 INFO - 'perf-reftest-singletons-e10s': {'tests': ['perf_reftest_singletons']}, 20:12:36 INFO - 'perf-reftest-singletons-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 20:12:36 INFO - 'tests': ['perf_reftest_singletons']}, 20:12:36 INFO - 'perf-reftest-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 20:12:36 INFO - 'tests': ['perf_reftest']}, 20:12:36 INFO - 'svgr-e10s': {'tests': ['tsvgx', 20:12:36 INFO - 'tsvgr_opacity', 20:12:36 INFO - 'tart', 20:12:36 INFO - 'tscrollx', 20:12:36 INFO - 'tsvg_static']}, 20:12:36 INFO - 'svgr-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 20:12:36 INFO - 'tests': ['tsvgx', 20:12:36 INFO - 'tsvgr_opacity', 20:12:36 INFO - 'tart', 20:12:36 INFO - 'tscrollx', 20:12:36 INFO - 'tsvg_static']}, 20:12:36 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 20:12:36 INFO - 'tp5o-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 20:12:36 INFO - 'talos_options': ['--disable-stylo'], 20:12:36 INFO - 'tests': ['tp5o']}, 20:12:36 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 20:12:36 INFO - 'mitmproxy_release_bin_osx': 'mitmproxy-2.0.2-osx.tar.gz', 20:12:36 INFO - 'talos_options': ['--mitmproxy', 20:12:36 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 20:12:36 INFO - '--firstNonBlankPaint'], 20:12:36 INFO - 'tests': ['tp6_google', 20:12:36 INFO - 'tp6_youtube', 20:12:36 INFO - 'tp6_amazon', 20:12:36 INFO - 'tp6_facebook']}, 20:12:36 INFO - 'tp6-stylo-disabled-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 20:12:36 INFO - 'mitmproxy_release_bin_osx': 'mitmproxy-2.0.2-osx.tar.gz', 20:12:36 INFO - 'talos_options': ['--disable-stylo', 20:12:36 INFO - '--mitmproxy', 20:12:36 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 20:12:36 INFO - '--firstNonBlankPaint'], 20:12:36 INFO - 'tests': ['tp6_google', 20:12:36 INFO - 'tp6_youtube', 20:12:36 INFO - 'tp6_amazon', 20:12:36 INFO - 'tp6_facebook']}, 20:12:36 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 20:12:36 INFO - 'mitmproxy_release_bin_osx': 'mitmproxy-2.0.2-osx.tar.gz', 20:12:36 INFO - 'talos_options': ['--stylo-threads=1', 20:12:36 INFO - '--mitmproxy', 20:12:36 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 20:12:36 INFO - '--firstNonBlankPaint'], 20:12:36 INFO - 'tests': ['tp6_google', 20:12:36 INFO - 'tp6_youtube', 20:12:36 INFO - 'tp6_amazon', 20:12:36 INFO - 'tp6_facebook']}, 20:12:36 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 20:12:36 INFO - 'talos_options': ['--xperf_path', 20:12:36 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 20:12:36 INFO - 'tests': ['tp5n']}, 20:12:36 INFO - 'xperf-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 20:12:36 INFO - 'talos_options': ['--disable-stylo', 20:12:36 INFO - '--xperf_path', 20:12:36 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 20:12:36 INFO - 'tests': ['tp5n']}}} 20:12:36 INFO - Running post-action listener: _resource_record_post_action 20:12:36 INFO - [mozharness: 2017-09-24 03:12:36.074916Z] Finished populate-webroot step (success) 20:12:36 INFO - [mozharness: 2017-09-24 03:12:36.075006Z] Running create-virtualenv step. 20:12:36 INFO - Running pre-action listener: _resource_record_pre_action 20:12:36 INFO - Running main action method: create_virtualenv 20:12:36 INFO - Creating virtualenv /builds/slave/test/build/venv 20:12:36 INFO - Running command: ['virtualenv', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 20:12:36 INFO - Copy/paste: virtualenv --no-site-packages --distribute /builds/slave/test/build/venv 20:12:36 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 20:12:36 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 20:12:36 INFO - New python executable in /builds/slave/test/build/venv/bin/python 20:12:36 INFO - Installing distribute.............................................................................................................................................................................................done. 20:12:36 INFO - Installing pip...............done. 20:12:36 INFO - Return code: 0 20:12:36 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 20:12:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 20:12:37 INFO - Reading from file tmpfile_stdout 20:12:37 INFO - Output received: 20:12: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) 20:12:37 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 20:12: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')]} 20:12:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:12: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')]} 20:12:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:12: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 0x156d1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1735b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18da9c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18d7d60>, '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 0x18d8a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18d8ef0>, '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': '14ef55db36f7623abb31b9cf000001d5-1506222262.388993-634593663', '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 20:12: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 20:12: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 20:12:37 INFO - Using env: {'DISPLAY': ':0', 20:12:37 INFO - 'HOME': '/home/cltbld', 20:12:37 INFO - 'LANG': 'en_US.UTF-8', 20:12:37 INFO - 'LANGUAGE': 'en_US:en', 20:12:37 INFO - 'LOGNAME': 'cltbld', 20:12:37 INFO - 'MAIL': '/var/mail/cltbld', 20:12:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:12:37 INFO - 'MOZ_NO_REMOTE': '1', 20:12:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:12:37 INFO - 'NO_EM_RESTART': '1', 20:12:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:12:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:12:37 INFO - 'PWD': '/builds/slave/test', 20:12:37 INFO - 'SHELL': '/bin/bash', 20:12:37 INFO - 'SHLVL': '1', 20:12:37 INFO - 'TERM': 'linux', 20:12:37 INFO - 'TMOUT': '86400', 20:12:37 INFO - 'USER': 'cltbld', 20:12:37 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1506222262.388993-634593663', 20:12:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:12:37 INFO - '_': '/tools/buildbot/bin/python'} 20:12:38 INFO - Ignoring indexes: http://pypi.python.org/simple/ 20:12:38 INFO - Downloading/unpacking pip>=1.5 20:12:38 INFO - Running setup.py egg_info for package pip 20:12:38 INFO - warning: no files found matching 'pip/cacert.pem' 20:12:38 INFO - warning: no files found matching '*.html' under directory 'docs' 20:12:38 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 20:12:38 INFO - no previously-included directories found matching 'docs/_build/_sources' 20:12:38 INFO - Installing collected packages: pip 20:12:38 INFO - Found existing installation: pip 1.1 20:12:38 INFO - Uninstalling pip: 20:12:38 INFO - Successfully uninstalled pip 20:12:38 INFO - Running setup.py install for pip 20:12:38 INFO - warning: no files found matching 'pip/cacert.pem' 20:12:38 INFO - warning: no files found matching '*.html' under directory 'docs' 20:12:38 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 20:12:38 INFO - no previously-included directories found matching 'docs/_build/_sources' 20:12:38 INFO - Installing pip script to /builds/slave/test/build/venv/bin 20:12:38 INFO - Installing pip2.7 script to /builds/slave/test/build/venv/bin 20:12:38 INFO - Installing pip2 script to /builds/slave/test/build/venv/bin 20:12:38 INFO - Successfully installed pip 20:12:38 INFO - Cleaning up... 20:12:38 INFO - Return code: 0 20:12:38 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 20:12: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')]} 20:12:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:12: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')]} 20:12:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:12: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 0x156d1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1735b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18da9c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18d7d60>, '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 0x18d8a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18d8ef0>, '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': '14ef55db36f7623abb31b9cf000001d5-1506222262.388993-634593663', '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 20:12: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 20:12: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 20:12:38 INFO - Using env: {'DISPLAY': ':0', 20:12:38 INFO - 'HOME': '/home/cltbld', 20:12:38 INFO - 'LANG': 'en_US.UTF-8', 20:12:38 INFO - 'LANGUAGE': 'en_US:en', 20:12:38 INFO - 'LOGNAME': 'cltbld', 20:12:38 INFO - 'MAIL': '/var/mail/cltbld', 20:12:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:12:38 INFO - 'MOZ_NO_REMOTE': '1', 20:12:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:12:38 INFO - 'NO_EM_RESTART': '1', 20:12:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:12:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:12:38 INFO - 'PWD': '/builds/slave/test', 20:12:38 INFO - 'SHELL': '/bin/bash', 20:12:38 INFO - 'SHLVL': '1', 20:12:38 INFO - 'TERM': 'linux', 20:12:38 INFO - 'TMOUT': '86400', 20:12:38 INFO - 'USER': 'cltbld', 20:12:38 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1506222262.388993-634593663', 20:12:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:12:38 INFO - '_': '/tools/buildbot/bin/python'} 20:12:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:12:38 INFO - Downloading/unpacking psutil>=3.1.1 20:12: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 20:12: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 20:12: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 20:12: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 20:12:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 20:12:39 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 20:12:39 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 20:12:39 INFO - Installing collected packages: psutil 20:12:39 INFO - Running setup.py install for psutil 20:12:39 INFO - building 'psutil._psutil_linux' extension 20:12:39 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 20:12: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 20:12:40 INFO - building 'psutil._psutil_posix' extension 20:12: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 20:12: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 20:12:40 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 20:12:40 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 20:12:40 INFO - Successfully installed psutil 20:12:40 INFO - Cleaning up... 20:12:40 INFO - Return code: 0 20:12:40 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 20:12: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')]} 20:12:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:12: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')]} 20:12:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:12: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 0x156d1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1735b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18da9c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18d7d60>, '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 0x18d8a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18d8ef0>, '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': '14ef55db36f7623abb31b9cf000001d5-1506222262.388993-634593663', '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 20:12: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 20:12: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 20:12:40 INFO - Using env: {'DISPLAY': ':0', 20:12:40 INFO - 'HOME': '/home/cltbld', 20:12:40 INFO - 'LANG': 'en_US.UTF-8', 20:12:40 INFO - 'LANGUAGE': 'en_US:en', 20:12:40 INFO - 'LOGNAME': 'cltbld', 20:12:40 INFO - 'MAIL': '/var/mail/cltbld', 20:12:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:12:40 INFO - 'MOZ_NO_REMOTE': '1', 20:12:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:12:40 INFO - 'NO_EM_RESTART': '1', 20:12:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:12:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:12:40 INFO - 'PWD': '/builds/slave/test', 20:12:40 INFO - 'SHELL': '/bin/bash', 20:12:40 INFO - 'SHLVL': '1', 20:12:40 INFO - 'TERM': 'linux', 20:12:40 INFO - 'TMOUT': '86400', 20:12:40 INFO - 'USER': 'cltbld', 20:12:40 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1506222262.388993-634593663', 20:12:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:12:40 INFO - '_': '/tools/buildbot/bin/python'} 20:12:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:12:40 INFO - Downloading/unpacking mozsystemmonitor==0.3 20:12: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 20:12: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 20:12: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 20:12: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 20:12:41 INFO - Downloading mozsystemmonitor-0.3.tar.gz 20:12:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 20:12:41 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 20:12:41 INFO - Installing collected packages: mozsystemmonitor 20:12:41 INFO - Running setup.py install for mozsystemmonitor 20:12:41 INFO - Successfully installed mozsystemmonitor 20:12:41 INFO - Cleaning up... 20:12:42 INFO - Return code: 0 20:12:42 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 20:12:42 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')]} 20:12:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:12:42 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')]} 20:12:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:12:42 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 0x156d1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1735b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18da9c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18d7d60>, '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 0x18d8a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18d8ef0>, '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': '14ef55db36f7623abb31b9cf000001d5-1506222262.388993-634593663', '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 20:12:42 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 20:12:42 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 20:12:42 INFO - Using env: {'DISPLAY': ':0', 20:12:42 INFO - 'HOME': '/home/cltbld', 20:12:42 INFO - 'LANG': 'en_US.UTF-8', 20:12:42 INFO - 'LANGUAGE': 'en_US:en', 20:12:42 INFO - 'LOGNAME': 'cltbld', 20:12:42 INFO - 'MAIL': '/var/mail/cltbld', 20:12:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:12:42 INFO - 'MOZ_NO_REMOTE': '1', 20:12:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:12:42 INFO - 'NO_EM_RESTART': '1', 20:12:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:12:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:12:42 INFO - 'PWD': '/builds/slave/test', 20:12:42 INFO - 'SHELL': '/bin/bash', 20:12:42 INFO - 'SHLVL': '1', 20:12:42 INFO - 'TERM': 'linux', 20:12:42 INFO - 'TMOUT': '86400', 20:12:42 INFO - 'USER': 'cltbld', 20:12:42 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1506222262.388993-634593663', 20:12:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:12:42 INFO - '_': '/tools/buildbot/bin/python'} 20:12:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:12:43 INFO - Downloading/unpacking jsonschema==2.5.1 20:12:43 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 20:12:43 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 20:12:43 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 20:12:43 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 20:12:44 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 20:12:44 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 20:12: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 20:12: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 20:12: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 20:12: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 20:12:44 INFO - Downloading functools32-3.2.3-2.tar.gz 20:12:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 20:12:44 INFO - warning: no files found matching '*.txt' 20:12:44 INFO - no previously-included directories found matching 'build' 20:12:44 INFO - no previously-included directories found matching 'dist' 20:12:44 INFO - no previously-included directories found matching '.git*' 20:12:44 INFO - Installing collected packages: jsonschema, functools32 20:12:45 INFO - Running setup.py install for functools32 20:12:45 INFO - warning: no files found matching '*.txt' 20:12:45 INFO - no previously-included directories found matching 'build' 20:12:45 INFO - no previously-included directories found matching 'dist' 20:12:45 INFO - no previously-included directories found matching '.git*' 20:12:45 INFO - Successfully installed jsonschema functools32 20:12:45 INFO - Cleaning up... 20:12:45 INFO - Return code: 0 20:12:45 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 20:12:45 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')]} 20:12:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:12:45 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')]} 20:12:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:12:45 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 0x156d1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1735b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18da9c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18d7d60>, '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 0x18d8a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18d8ef0>, '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': '14ef55db36f7623abb31b9cf000001d5-1506222262.388993-634593663', '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 20:12:45 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 20:12:45 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 20:12:45 INFO - Using env: {'DISPLAY': ':0', 20:12:45 INFO - 'HOME': '/home/cltbld', 20:12:45 INFO - 'LANG': 'en_US.UTF-8', 20:12:45 INFO - 'LANGUAGE': 'en_US:en', 20:12:45 INFO - 'LOGNAME': 'cltbld', 20:12:45 INFO - 'MAIL': '/var/mail/cltbld', 20:12:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:12:45 INFO - 'MOZ_NO_REMOTE': '1', 20:12:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:12:45 INFO - 'NO_EM_RESTART': '1', 20:12:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:12:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:12:45 INFO - 'PWD': '/builds/slave/test', 20:12:45 INFO - 'SHELL': '/bin/bash', 20:12:45 INFO - 'SHLVL': '1', 20:12:45 INFO - 'TERM': 'linux', 20:12:45 INFO - 'TMOUT': '86400', 20:12:45 INFO - 'USER': 'cltbld', 20:12:45 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1506222262.388993-634593663', 20:12:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:12:45 INFO - '_': '/tools/buildbot/bin/python'} 20:12:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:12:46 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 20:12:46 INFO - Cleaning up... 20:12:46 INFO - Return code: 0 20:12:46 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 20:12: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')]} 20:12:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:12: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')]} 20:12:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:12: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 0x156d1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1735b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18da9c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18d7d60>, '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 0x18d8a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18d8ef0>, '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': '14ef55db36f7623abb31b9cf000001d5-1506222262.388993-634593663', '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 20:12: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 20:12: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 20:12:46 INFO - Using env: {'DISPLAY': ':0', 20:12:46 INFO - 'HOME': '/home/cltbld', 20:12:46 INFO - 'LANG': 'en_US.UTF-8', 20:12:46 INFO - 'LANGUAGE': 'en_US:en', 20:12:46 INFO - 'LOGNAME': 'cltbld', 20:12:46 INFO - 'MAIL': '/var/mail/cltbld', 20:12:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:12:46 INFO - 'MOZ_NO_REMOTE': '1', 20:12:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:12:46 INFO - 'NO_EM_RESTART': '1', 20:12:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:12:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:12:46 INFO - 'PWD': '/builds/slave/test', 20:12:46 INFO - 'SHELL': '/bin/bash', 20:12:46 INFO - 'SHLVL': '1', 20:12:46 INFO - 'TERM': 'linux', 20:12:46 INFO - 'TMOUT': '86400', 20:12:46 INFO - 'USER': 'cltbld', 20:12:46 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1506222262.388993-634593663', 20:12:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:12:46 INFO - '_': '/tools/buildbot/bin/python'} 20:12:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:12:46 INFO - Downloading/unpacking blobuploader==1.2.4 20:12: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 20:12: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 20:12: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 20:12: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 20:12:47 INFO - Downloading blobuploader-1.2.4.tar.gz 20:12:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 20:12:47 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 20:12: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 20:12: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 20:12: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 20:12: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 20:12:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 20:12:48 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 20:12: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 20:12: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 20:12: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 20:12: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 20:12:48 INFO - Downloading docopt-0.6.1.tar.gz 20:12:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 20:12:48 INFO - Installing collected packages: blobuploader, requests, docopt 20:12:48 INFO - Running setup.py install for blobuploader 20:12:48 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 20:12:48 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 20:12:48 INFO - Running setup.py install for requests 20:12:48 INFO - Running setup.py install for docopt 20:12:48 INFO - Successfully installed blobuploader requests docopt 20:12:48 INFO - Cleaning up... 20:12:48 INFO - Return code: 0 20:12:48 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:12:48 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')]} 20:12:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:12:48 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')]} 20:12:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:12:48 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 0x156d1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1735b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18da9c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18d7d60>, '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 0x18d8a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18d8ef0>, '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': '14ef55db36f7623abb31b9cf000001d5-1506222262.388993-634593663', '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 20:12:48 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 20:12:48 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 20:12:48 INFO - Using env: {'DISPLAY': ':0', 20:12:48 INFO - 'HOME': '/home/cltbld', 20:12:48 INFO - 'LANG': 'en_US.UTF-8', 20:12:48 INFO - 'LANGUAGE': 'en_US:en', 20:12:48 INFO - 'LOGNAME': 'cltbld', 20:12:48 INFO - 'MAIL': '/var/mail/cltbld', 20:12:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:12:48 INFO - 'MOZ_NO_REMOTE': '1', 20:12:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:12:48 INFO - 'NO_EM_RESTART': '1', 20:12:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:12:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:12:48 INFO - 'PWD': '/builds/slave/test', 20:12:48 INFO - 'SHELL': '/bin/bash', 20:12:48 INFO - 'SHLVL': '1', 20:12:48 INFO - 'TERM': 'linux', 20:12:48 INFO - 'TMOUT': '86400', 20:12:48 INFO - 'USER': 'cltbld', 20:12:48 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1506222262.388993-634593663', 20:12:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:12:48 INFO - '_': '/tools/buildbot/bin/python'} 20:12:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:12:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 20:12:49 INFO - Running setup.py (path:/tmp/pip-bwkLy5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 20:12:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 20:12:49 INFO - Running setup.py (path:/tmp/pip-WAX0qn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 20:12:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 20:12:49 INFO - Running setup.py (path:/tmp/pip-Cq2rtH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 20:12:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 20:12:49 INFO - Running setup.py (path:/tmp/pip-_HrePa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 20:12:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 20:12:49 INFO - Running setup.py (path:/tmp/pip-JKYVkq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 20:12:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 20:12:49 INFO - Running setup.py (path:/tmp/pip-aktHem-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 20:12:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 20:12:49 INFO - Running setup.py (path:/tmp/pip-JgdqKf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 20:12:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 20:12:49 INFO - Running setup.py (path:/tmp/pip-O_w0Th-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 20:12:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 20:12:49 INFO - Running setup.py (path:/tmp/pip-8Umhky-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 20:12:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 20:12:49 INFO - Running setup.py (path:/tmp/pip-FVyrNH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 20:12:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 20:12:49 INFO - Running setup.py (path:/tmp/pip-ywyiOZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 20:12:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 20:12:49 INFO - Running setup.py (path:/tmp/pip-59cktW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 20:12:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 20:12:49 INFO - Running setup.py (path:/tmp/pip-5QBw8F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 20:12:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 20:12:49 INFO - Running setup.py (path:/tmp/pip-uoOw3A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 20:12:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 20:12:50 INFO - Running setup.py (path:/tmp/pip-HpN8IS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 20:12:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 20:12:50 INFO - Running setup.py (path:/tmp/pip-HugChm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 20:12:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 20:12:50 INFO - Running setup.py (path:/tmp/pip-RnDZvP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 20:12:50 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 20:12:50 INFO - Running setup.py install for manifestparser 20:12:50 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 20:12:50 INFO - Running setup.py install for mozcrash 20:12:50 INFO - Running setup.py install for mozdebug 20:12:50 INFO - Running setup.py install for mozdevice 20:12:50 INFO - Installing dm script to /builds/slave/test/build/venv/bin 20:12:50 INFO - Running setup.py install for mozfile 20:12:50 INFO - Running setup.py install for mozhttpd 20:12:50 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 20:12:50 INFO - Running setup.py install for mozinfo 20:12:50 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 20:12:50 INFO - Running setup.py install for mozInstall 20:12:50 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 20:12:50 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 20:12:50 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 20:12:50 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 20:12:51 INFO - Running setup.py install for mozleak 20:12:51 INFO - Running setup.py install for mozlog 20:12:51 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 20:12:51 INFO - Running setup.py install for moznetwork 20:12:51 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 20:12:51 INFO - Running setup.py install for mozprocess 20:12:51 INFO - Running setup.py install for mozprofile 20:12:51 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 20:12:51 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 20:12:51 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 20:12:51 INFO - Running setup.py install for mozrunner 20:12:51 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 20:12:51 INFO - Running setup.py install for mozscreenshot 20:12:51 INFO - Running setup.py install for moztest 20:12:51 INFO - Running setup.py install for mozversion 20:12:51 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 20:12:51 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 20:12:51 INFO - Cleaning up... 20:12:51 INFO - Return code: 0 20:12:51 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:12:51 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')]} 20:12:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:12:51 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')]} 20:12:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:12: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 0x156d1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1735b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18da9c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18d7d60>, '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 0x18d8a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18d8ef0>, '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': '14ef55db36f7623abb31b9cf000001d5-1506222262.388993-634593663', '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 20:12: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 20:12: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 20:12:52 INFO - Using env: {'DISPLAY': ':0', 20:12:52 INFO - 'HOME': '/home/cltbld', 20:12:52 INFO - 'LANG': 'en_US.UTF-8', 20:12:52 INFO - 'LANGUAGE': 'en_US:en', 20:12:52 INFO - 'LOGNAME': 'cltbld', 20:12:52 INFO - 'MAIL': '/var/mail/cltbld', 20:12:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:12:52 INFO - 'MOZ_NO_REMOTE': '1', 20:12:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:12:52 INFO - 'NO_EM_RESTART': '1', 20:12:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:12:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:12:52 INFO - 'PWD': '/builds/slave/test', 20:12:52 INFO - 'SHELL': '/bin/bash', 20:12:52 INFO - 'SHLVL': '1', 20:12:52 INFO - 'TERM': 'linux', 20:12:52 INFO - 'TMOUT': '86400', 20:12:52 INFO - 'USER': 'cltbld', 20:12:52 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1506222262.388993-634593663', 20:12:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:12:52 INFO - '_': '/tools/buildbot/bin/python'} 20:12:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:12:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 20:12:52 INFO - Running setup.py (path:/tmp/pip-4PQuIR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 20:12: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)) 20:12:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 20:12:52 INFO - Running setup.py (path:/tmp/pip-BQR5S4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 20:12: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)) 20:12:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 20:12:52 INFO - Running setup.py (path:/tmp/pip-XqMlTp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 20:12: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)) 20:12:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 20:12:52 INFO - Running setup.py (path:/tmp/pip-pUVZJi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 20:12: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)) 20:12:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 20:12:52 INFO - Running setup.py (path:/tmp/pip-7GiIvj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 20:12: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)) 20:12:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 20:12:52 INFO - Running setup.py (path:/tmp/pip-rKBhBC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 20:12: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)) 20:12:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 20:12:52 INFO - Running setup.py (path:/tmp/pip-MnMY54-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 20:12: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)) 20:12:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 20:12:52 INFO - Running setup.py (path:/tmp/pip-tSDKt0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 20:12:52 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)) 20:12:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 20:12:52 INFO - Running setup.py (path:/tmp/pip-puSpcw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 20:12:52 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)) 20:12:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 20:12:52 INFO - Running setup.py (path:/tmp/pip-kuyT46-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 20:12:52 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)) 20:12:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 20:12:52 INFO - Running setup.py (path:/tmp/pip-tOzPqn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 20:12:52 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)) 20:12:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 20:12:52 INFO - Running setup.py (path:/tmp/pip-5OpAOT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 20:12: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)) 20:12:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 20:12:53 INFO - Running setup.py (path:/tmp/pip-1tOmaS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 20:12: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)) 20:12:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 20:12:53 INFO - Running setup.py (path:/tmp/pip-Rm1OsW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 20:12: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)) 20:12:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 20:12:53 INFO - Running setup.py (path:/tmp/pip-S2zLmU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 20:12: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)) 20:12:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 20:12:53 INFO - Running setup.py (path:/tmp/pip-tew8BA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 20:12: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)) 20:12:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 20:12:53 INFO - Running setup.py (path:/tmp/pip-5YCbKp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 20:12: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)) 20:12: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)) 20:12: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)) 20:12: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)) 20:12: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)) 20:12: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)) 20:12: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)) 20:12:53 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 20:12: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 20:12: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 20:12: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 20:12: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 20:12:54 INFO - Downloading blessings-1.6.tar.gz 20:12:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 20:12:54 INFO - Installing collected packages: blessings 20:12:54 INFO - Running setup.py install for blessings 20:12:54 INFO - Successfully installed blessings 20:12:54 INFO - Cleaning up... 20:12:54 INFO - Return code: 0 20:12:54 INFO - Done creating virtualenv /builds/slave/test/build/venv. 20:12:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 20:12:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 20:12:54 INFO - Reading from file tmpfile_stdout 20:12:54 INFO - Current package versions: 20:12:54 INFO - argparse == 1.2.1 20:12:54 INFO - blessings == 1.6 20:12:54 INFO - blobuploader == 1.2.4 20:12:54 INFO - docopt == 0.6.1 20:12:54 INFO - functools32 == 3.2.3-2 20:12:54 INFO - jsonschema == 2.5.1 20:12:54 INFO - manifestparser == 1.1 20:12:54 INFO - mozInstall == 1.13 20:12:54 INFO - mozcrash == 1.0 20:12:54 INFO - mozdebug == 0.1 20:12:54 INFO - mozdevice == 0.51 20:12:54 INFO - mozfile == 1.2 20:12:54 INFO - mozhttpd == 0.7 20:12:54 INFO - mozinfo == 0.10 20:12:54 INFO - mozleak == 0.1 20:12:54 INFO - mozlog == 3.5 20:12:54 INFO - moznetwork == 0.27 20:12:54 INFO - mozprocess == 0.25 20:12:54 INFO - mozprofile == 0.28 20:12:54 INFO - mozrunner == 6.13 20:12:54 INFO - mozscreenshot == 0.1 20:12:54 INFO - mozsystemmonitor == 0.3 20:12:54 INFO - moztest == 0.8 20:12:54 INFO - mozversion == 1.4 20:12:54 INFO - psutil == 3.1.1 20:12:54 INFO - requests == 1.2.3 20:12:54 INFO - wsgiref == 0.1.2 20:12:54 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:12:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:12:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:12:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:12:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:12:54 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 0x156d1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1735b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18da9c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18d7d60>, '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 0x18d8a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18d8ef0>, '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': '14ef55db36f7623abb31b9cf000001d5-1506222262.388993-634593663', '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 20:12:54 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 20:12:54 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 20:12:54 INFO - Using env: {'DISPLAY': ':0', 20:12:54 INFO - 'HOME': '/home/cltbld', 20:12:54 INFO - 'LANG': 'en_US.UTF-8', 20:12:54 INFO - 'LANGUAGE': 'en_US:en', 20:12:54 INFO - 'LOGNAME': 'cltbld', 20:12:54 INFO - 'MAIL': '/var/mail/cltbld', 20:12:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:12:54 INFO - 'MOZ_NO_REMOTE': '1', 20:12:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:12:54 INFO - 'NO_EM_RESTART': '1', 20:12:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:12:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:12:54 INFO - 'PWD': '/builds/slave/test', 20:12:54 INFO - 'SHELL': '/bin/bash', 20:12:54 INFO - 'SHLVL': '1', 20:12:54 INFO - 'TERM': 'linux', 20:12:54 INFO - 'TMOUT': '86400', 20:12:54 INFO - 'USER': 'cltbld', 20:12:54 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1506222262.388993-634593663', 20:12:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:12:54 INFO - '_': '/tools/buildbot/bin/python'} 20:12:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:12: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)) 20:12: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)) 20:12: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)) 20:12: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)) 20:12: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)) 20:12: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)) 20:12: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)) 20:12: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)) 20:12: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)) 20:12:55 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 20:12: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 20:12: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 20:12: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 20:12: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 20:12:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 20:12: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)) 20:12: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)) 20:12:56 INFO - Installing collected packages: simplejson 20:12:56 INFO - Running setup.py install for simplejson 20:12:56 INFO - building 'simplejson._speedups' extension 20:12: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 20:12: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 20:12:57 INFO - Successfully installed simplejson 20:12:57 INFO - Cleaning up... 20:12:57 INFO - Return code: 0 20:12:57 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 20:12: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')]} 20:12:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:12: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')]} 20:12:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:12: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 0x156d1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1735b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18da9c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18d7d60>, '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 0x18d8a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18d8ef0>, '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': '14ef55db36f7623abb31b9cf000001d5-1506222262.388993-634593663', '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 20:12: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 20:12: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 20:12:57 INFO - Using env: {'DISPLAY': ':0', 20:12:57 INFO - 'HOME': '/home/cltbld', 20:12:57 INFO - 'LANG': 'en_US.UTF-8', 20:12:57 INFO - 'LANGUAGE': 'en_US:en', 20:12:57 INFO - 'LOGNAME': 'cltbld', 20:12:57 INFO - 'MAIL': '/var/mail/cltbld', 20:12:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:12:57 INFO - 'MOZ_NO_REMOTE': '1', 20:12:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:12:57 INFO - 'NO_EM_RESTART': '1', 20:12:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:12:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:12:57 INFO - 'PWD': '/builds/slave/test', 20:12:57 INFO - 'SHELL': '/bin/bash', 20:12:57 INFO - 'SHLVL': '1', 20:12:57 INFO - 'TERM': 'linux', 20:12:57 INFO - 'TMOUT': '86400', 20:12:57 INFO - 'USER': 'cltbld', 20:12:57 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1506222262.388993-634593663', 20:12:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:12:57 INFO - '_': '/tools/buildbot/bin/python'} 20:12:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:12:57 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 20:12:57 INFO - Cleaning up... 20:12:57 INFO - Return code: 0 20:12:57 INFO - Running post-action listener: _resource_record_post_action 20:12:57 INFO - Running post-action listener: _start_resource_monitoring 20:12:57 INFO - Starting resource monitoring. 20:12:57 INFO - [mozharness: 2017-09-24 03:12:57.720649Z] Finished create-virtualenv step (success) 20:12:57 INFO - [mozharness: 2017-09-24 03:12:57.721156Z] Running install step. 20:12:57 INFO - Running pre-action listener: _resource_record_pre_action 20:12:57 INFO - Running main action method: install 20:12:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 20:12:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 20:12:57 INFO - Reading from file tmpfile_stdout 20:12:57 INFO - Detecting whether we're running mozinstall >=1.0... 20:12:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 20:12:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 20:12:58 INFO - Reading from file tmpfile_stdout 20:12:58 INFO - Output received: 20:12:58 INFO - Usage: mozinstall [options] installer 20:12:58 INFO - Options: 20:12:58 INFO - -h, --help show this help message and exit 20:12:58 INFO - -d DEST, --destination=DEST 20:12:58 INFO - Directory to install application into. [default: 20:12:58 INFO - "/builds/slave/test"] 20:12:58 INFO - --app=APP Application being installed. [default: firefox] 20:12:58 INFO - mkdir: /builds/slave/test/build/application 20:12: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'] 20:12:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 20:13:15 INFO - Reading from file tmpfile_stdout 20:13:15 INFO - Output received: 20:13:15 INFO - /builds/slave/test/build/application/firefox/firefox 20:13:15 INFO - Running post-action listener: _resource_record_post_action 20:13:15 INFO - [mozharness: 2017-09-24 03:13:15.861591Z] Finished install step (success) 20:13:15 INFO - [mozharness: 2017-09-24 03:13:15.861841Z] Running setup-mitmproxy step. 20:13:15 INFO - Running pre-action listener: _resource_record_pre_action 20:13:15 INFO - Running main action method: setup_mitmproxy 20:13:15 INFO - Skipping: mitmproxy is not required 20:13:15 INFO - Running post-action listener: _resource_record_post_action 20:13:15 INFO - [mozharness: 2017-09-24 03:13:15.862977Z] Finished setup-mitmproxy step (success) 20:13:15 INFO - [mozharness: 2017-09-24 03:13:15.863198Z] Running run-tests step. 20:13:15 INFO - Running pre-action listener: _resource_record_pre_action 20:13:15 INFO - Running pre-action listener: _set_gcov_prefix 20:13:15 INFO - Running main action method: run_tests 20:13:15 WARNING - Try message not found. 20:13:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 20:13:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 20:13:15 INFO - Python 2.7.3 20:13:15 INFO - Return code: 0 20:13:15 INFO - grabbing minidump binary from tooltool 20:13:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:13:15 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 0x18d7d60>, '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 0x18d8a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18d8ef0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 20:13:15 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 20:13:15 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 20:13:15 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 20:13:15 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 20:13:15 INFO - Return code: 0 20:13:15 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 20:13:15 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 20:13:15 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 20:13:15 INFO - ENV: RUST_BACKTRACE is now full 20:13:15 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 20:13:15 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 20:13:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-stylo-disabled-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/JuOc-pfvTaqJ1Q-nyQhMGg/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-036', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_raw.log'] in /builds/slave/test/build 20:13:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs-stylo-disabled-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/JuOc-pfvTaqJ1Q-nyQhMGg/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-036 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_raw.log 20:13:16 INFO - Using env: {'DISPLAY': ':0', 20:13:16 INFO - 'HOME': '/home/cltbld', 20:13:16 INFO - 'LANG': 'en_US.UTF-8', 20:13:16 INFO - 'LANGUAGE': 'en_US:en', 20:13:16 INFO - 'LOGNAME': 'cltbld', 20:13:16 INFO - 'MAIL': '/var/mail/cltbld', 20:13:16 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 20:13:16 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 20:13:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:13:16 INFO - 'MOZ_NO_REMOTE': '1', 20:13:16 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 20:13:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:13:16 INFO - 'NO_EM_RESTART': '1', 20:13:16 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:13:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:13:16 INFO - 'PWD': '/builds/slave/test', 20:13:16 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 20:13:16 INFO - 'RUST_BACKTRACE': 'full', 20:13:16 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 20:13:16 INFO - 'SHELL': '/bin/bash', 20:13:16 INFO - 'SHLVL': '1', 20:13:16 INFO - 'TERM': 'linux', 20:13:16 INFO - 'TMOUT': '86400', 20:13:16 INFO - 'USER': 'cltbld', 20:13:16 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1506222262.388993-634593663', 20:13:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:13:16 INFO - '_': '/tools/buildbot/bin/python'} 20:13:16 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-stylo-disabled-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/JuOc-pfvTaqJ1Q-nyQhMGg/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-036', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_raw.log'] with output_timeout 3600 20:13:16 INFO - mozversion application_buildid: 20170924021622 20:13:16 INFO - mozversion application_changeset: 42aa84eec339c29bf3d21178ae6e5c138d50e82b 20:13:16 INFO - mozversion application_display_name: Nightly 20:13:16 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 20:13:16 INFO - mozversion application_name: Firefox 20:13:16 INFO - mozversion application_remotingname: firefox 20:13:16 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 20:13:16 INFO - mozversion application_vendor: Mozilla 20:13:16 INFO - mozversion application_version: 58.0a1 20:13:16 INFO - mozversion platform_buildid: 20170924021622 20:13:16 INFO - mozversion platform_changeset: 42aa84eec339c29bf3d21178ae6e5c138d50e82b 20:13:16 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 20:13:16 INFO - mozversion platform_version: 58.0a1 20:13:16 INFO - using testdate: 1506222796 20:13:16 INFO - actual date: 1506222796 20:13:16 INFO - starting webserver on 'localhost:33371' 20:13:16 INFO - SUITE-START | Running 2 tests 20:13:16 INFO - TEST-START | dromaeo_css 20:13:16 INFO - Initialising browser for dromaeo_css test... 20:13:16 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:33371/getInfo.html -profile /tmp/tmpnHIkxo/profile 20:13:16 INFO - TEST-INFO | started process 31545 (/builds/slave/test/build/application/firefox/firefox http://localhost:33371/getInfo.html) 20:13:21 INFO - TEST-INFO | 31545: exit 0 20:13:21 INFO - Browser initialized. 20:13:21 INFO - Running cycle 1/1 for dromaeo_css test... 20:13:21 INFO - Using env: {'DISPLAY': ':0', 20:13:21 INFO - 'HOME': '/home/cltbld', 20:13:21 INFO - 'JSGC_DISABLE_POISONING': '1', 20:13:21 INFO - 'LANG': 'en_US.UTF-8', 20:13:21 INFO - 'LANGUAGE': 'en_US:en', 20:13:21 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 20:13:21 INFO - 'LOGNAME': 'cltbld', 20:13:21 INFO - 'MAIL': '/var/mail/cltbld', 20:13:21 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 20:13:21 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 20:13:21 INFO - 'MOZ_CRASHREPORTER': '1', 20:13:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:13:21 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 20:13:21 INFO - 'MOZ_NO_REMOTE': '1', 20:13:21 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 20:13:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:13:21 INFO - 'NO_EM_RESTART': '1', 20:13:21 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:13:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:13:21 INFO - 'PWD': '/builds/slave/test', 20:13:21 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 20:13:21 INFO - 'RUST_BACKTRACE': 'full', 20:13:21 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 20:13:21 INFO - 'SHELL': '/bin/bash', 20:13:21 INFO - 'SHLVL': '1', 20:13:21 INFO - 'STYLO_FORCE_DISABLED': '1', 20:13:21 INFO - 'TERM': 'linux', 20:13:21 INFO - 'TMOUT': '86400', 20:13:21 INFO - 'USER': 'cltbld', 20:13:21 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1506222262.388993-634593663', 20:13:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:13:21 INFO - '_': '/tools/buildbot/bin/python'} 20:13:21 INFO - TEST-INFO | started process 31777 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpnHIkxo/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 20:13:22 INFO - PID 31777 | 20:13:22 INFO - PID 31777 | (/builds/slave/test/build/application/firefox/firefox:31826): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 20:13:22 INFO - PID 31777 | 20:13:33 INFO - PID 31777 | RSS: Main: 153698304 20:13:33 INFO - PID 31777 | 20:16:29 INFO - PID 31777 | Cycle 1(1): loaded http://localhost:33371/tests/dromaeo/cssquery-dojo.html (next: http://localhost:33371/tests/dromaeo/cssquery-ext.html) 20:16:31 INFO - PID 31777 | RSS: Main: 153833472 20:16:31 INFO - PID 31777 | 20:19:32 INFO - PID 31777 | Cycle 1(1): loaded http://localhost:33371/tests/dromaeo/cssquery-ext.html (next: http://localhost:33371/tests/dromaeo/cssquery-jquery.html) 20:19:33 INFO - PID 31777 | RSS: Main: 153538560 20:19:33 INFO - PID 31777 | 20:22:35 INFO - PID 31777 | Cycle 1(1): loaded http://localhost:33371/tests/dromaeo/cssquery-jquery.html (next: http://localhost:33371/tests/dromaeo/cssquery-mootools.html) 20:22:35 INFO - PID 31777 | RSS: Main: 155717632 20:22:35 INFO - PID 31777 | 20:25:37 INFO - PID 31777 | Cycle 1(1): loaded http://localhost:33371/tests/dromaeo/cssquery-mootools.html (next: http://localhost:33371/tests/dromaeo/cssquery-prototype.html) 20:25:38 INFO - PID 31777 | RSS: Main: 153104384 20:25:38 INFO - PID 31777 | 20:28:41 INFO - PID 31777 | Cycle 1(1): loaded http://localhost:33371/tests/dromaeo/cssquery-prototype.html (next: http://localhost:33371/tests/dromaeo/cssquery-yui.html) 20:28:41 INFO - PID 31777 | RSS: Main: 155144192 20:28:41 INFO - PID 31777 | 20:31:43 INFO - PID 31777 | Cycle 1(1): loaded http://localhost:33371/tests/dromaeo/cssquery-yui.html (next: http://localhost:33371/tests/dromaeo/cssquery-dojo.html) 20:31:43 INFO - PID 31777 | RSS: Main: 157757440 20:31:43 INFO - PID 31777 | 20:31:43 INFO - PID 31777 | __start_tp_report 20:31:43 INFO - PID 31777 | _x_x_mozilla_page_load 20:31:43 INFO - PID 31777 | _x_x_mozilla_page_load_details 20:31:43 INFO - PID 31777 | |i|pagename|runs| 20:31:43 INFO - PID 31777 | |0;dojo.html;3052.572639830423;3096.3497665490245;3097.891573794918;3113.891013814517;3130.968690313098;6142.109394137848;6162.568620196583;6265.655388953617;6312.936870631293;6384.457321127709;6205.131281620576;6246.375362463751;6287.15123458333;6301.590396624216;6326.462250708684;5660.066089095294;5712.2574065371655;5721.9427805721825;5820.185174075622;5824.767009319643;5901.232839730829;5940.3762604926505;5955.106733989893;5957.523398128139;5971;534.480283660921;5745.741441635095;5909.586328956974;5960;5994.46049855513;5751.19483272338;5838.883222335529;5917.52659787216;5918.940810591925;5919.289685237799;5803.622764520335;5803.872554854565;5883.970580147115;5889.02831032879;5893.0276504376725;6292.244930608311;6293.30773614902;6310.716017779211;6349.968250158766;6406.871862562769;6748.089007983908;6748.190217173921;6790.32096790322;6834.2482326944;6852;6676.998450232455;6744.325567443266;6853.520253582202;6919.515633905628;6925.965370173168;6219.968900155515;6244.032175012835;6246.593971391845;6309.337519560426;6401.679916004227;6973.755918542826;7088.539244949062;7101.325374089453;7117.288271172842;7121.287871212838;6682.097916781269;6684.465242780566;6704.698288577026;6705.564138330993;6782.491313151435;6571.80284591463;6785.050092986986;6805.2173999989645;6829.248782633907;6870.31296870309;6552.049952756824;6710.429613482811;6770.69531871067;6775.762848300285;6775.762848300385;6780.096181381903;6832.760853370109;6888.311168883071;6895.069165662671;6913.89629155563;5238.188080847474;5324.707141107198;5379.5427388671615;5399.190121481809;5402.135658294654;4591.334256532851;4597.310403439511;4607.838725644587;4646.442426908792;4696.835610753607;5807.216025836458;5883.382244864313;5887.1463637772285;5891.911621325684;5893.469587737124;6688.29772873851;6781.423578995742;6844.555103918229;6928.653567321614;6933;5723.227364305849;5836.970815145897;5839.299284085937;5845.678487683133;5852.092925596539;5825.854353641108;5886.23478947734;5918.852028699231;5925.4370834770625;5934.406559344031;6514.120593719882;6521.315261897527;6603.570767900071;6604.273529911706;6651.268360480343;6684.364985326386;6785.185777706707;6814.182298124257;6822.761203357859;6937.618430986344;6538.738450461929;6559.8032059038305;6607.372299631527;6608.537402381787;6608.669566521751;6716.361945615159;6789.355011273921;6792.0830687856505;6806.693698783468;6812.080369150101;6842.726290948306;6848.520603557703;6852.383285504328;6946.79159625212;6948.861022779415;6447.3552644735155;6537.182852143482;6539.11721917535;6544.8363790905605;6554.246261679968;6404.295527492065;6479.838004049937;6480.870382592416;6485.929821579387;6494.415502604599;6502.089707440868;6532.804015879341;6584.868302634016;6608.6365249909795;6632.867342653023;6663.500237482305;6671.466282697275;6671.66641667905;6673.733050677918;6760.661966901734;6261.029540421242;6345.206849143857;6408.935910640834;6482.54622176462;6494.220693516808 20:31:43 INFO - PID 31777 | |1;ext.html;873.6592728835753;889.968851090212;893.3657103456545;897.0312062971991;903.724364068959;38764.80617596912;39632;41786.955326116826;42396;42560.99999999992;38619;38943.41584876229;38956.80521597388;38984.41523377145;39308.80345598268;7206.315400036988;7336.156342020656;7350.044494215745;7754;7949.364050875945;7797.0643522777345;7900.802479938019;7924.564148971805;7925.405594580401;7926.80182995424;7876.212378762107;7896;7930.206979302081;7940.960295198516;7964.800879978018;7913.960430197841;7948.523088614702;7958.204179582053;7961.323287520568;7964.522128672298;7902.367810575198;7940.364770818321;7942.086660034054;7949;7949.64226609804;38137.42793858094;38392.80803595992;38466.61533384658;38575.614243857766;38669.226615467815;3547.822608869546;3578.785272883635;3583.3549961007006;3585.032041348847;3587.94618080729;31518.842405788055;31524.36951260985;31570.684293157003;31582.684173158435;31653.20866978344;5063.341765570489;5071.1632580624155;5106.336176297094;5114.974425127851;5142.74286285688;179134;179182;180543;180695.9999999987;182141.0892945527;46677.76661116673;47484;48268.517314827106;48457;48457.273140902915;49345.259821102714;49466;49493;49498.25752613714;49545;14209.644758880904;14238.2168980705;14242.07426517273;14371.353289102015;14576.927115364568;11528;11559.537618495335;11587.88412115885;11598.76802463946;11604.361760103275;14537.854621453862;14596.41614335436;14640.853591463949;14711.926440367944;14763.48327808543;5724.971375143097;5765.394633563499;5821.18503409523;5825.475707186373;5946;1005.1406047829147;1009.222898368267;1016.7813920007086;1019.8113349030453;1034.3586976074882;23284;23353;23480;23590;23601.527969440514;1110.2727713347608;1111.2721167635211;1121.9102471802237;1123.292325834719;1130.5138790320077;12272.202306850026;12370;12447.875521244672;12452.252864828139;12500.312482813351;223115;223535;224373;224472;225642;53587.46412535903;53697;53774;53825.46174538205;53835.73082134643;1446.7395868743517;1463.0343972977785;1468.0892414872023;1485.7919891215238;1488.4343949299198;24739.752602473745;27304.59043114315;27758.028469004297;27763.305917352227;27969;48595.75702121467;48633.05467781249;48649;48681.756591216814;48695.26957095717;195062;195846;196172;196226;196617;34245.48631770476;34361.82819085989;34399.48400774041;34495;34552.30895382028;41119.588804111576;42819.78590107154;43485.56514434942;43545.78227108844;44002.33996489991;31131.533027005065;31175.220619484695;31192.532112017885;31226.37547248997;31226.687733122377;31319.686803131677;31489.370212596077;31654.366912662077;31738;31787.841060794548;35056;35139.82430087833;35147.29705405826;35422.64577354193;35446.29107417889;30635.2341191472;30810.383792324476;30989;31033.069007929796;31708.682913171495;22902;22936;23018;23203.303900883002;23267 20:31:43 INFO - PID 31777 | |2;jquery.html;576.2854060964405;582.8076734677556;586.4311617730805;587.1251834766198;594.922660054193;21634;22531.774682253174;22629.321120366374;22669.54660906781;22688.659670104942;23137.19019834306;24416.877915610443;24500.632490512657;24659;24669.506609867793;6482.708278127496;6678.833029174261;6684.565503242298;6693;6699.799006029827;6596.274409814917;6689.096971908779;6698.3971442570155;6819.727210911582;7072.752453664123;7060.435165186798;7064.858702825941;7077.186123595801;7080.504364694473;7082.893756593655;6755.932440675604;6929.44564434844;7010.859782804367;7077.186123595801;7079.575225486487;6934.791956241321;6953.860922781516;6954.23503414624;6956.826079348057;6965.233824279325;29219.707802921912;29834.254143646365;30192.8490357549;30228.697713022808;30235.848820755975;2087.1025459052603;2121.7029615853794;2121.9045142968603;2128.4891626009803;2128.5530038691895;18645.25418983239;19890.70163947542;20056;20070.59858802816;20114;2571.7556832100922;2598.792096632265;2622.3050891513763;2637.274749443899;2642.6696662917134;128494;134980;141265;144820;145239;19579.748328942354;20346.59306813885;20928.790712092683;21785.346439606838;21924.23265185711;42652.786736066744;42849;42922.356164657554;42980;43027.56972430235;11220.607278745205;11247.943760281147;11255.774884502263;11420.029297509638;11437.08503319749;9396.953015235016;9426.481543515036;9465.100815422524;9482.620695172254;9605.615775368908;10684.732881677864;10725.89274107249;10967.780644387227;11062.446877656084;11404.48679809394;3479.530263414407;3599.9820000900354;3719.516462859865;3751.8124093795745;4112.362583799516;952.46661869352;957.3537861943161;957.5786653872274;974.4104816586005;991.8958509356557;18481.544922918718;18927.14827832751;19054.14256358467;19444.80555194458;19664.803351966584;1001.5993602559034;1017.6031347774374;1026.0047753678919;1036.5180191211123;1041.4480325427385;10528.842067368996;10592.735181620521;10620.840687389695;10698.197635177392;10768.730781730363;447551;454988;457075;457845;458275;112192.43903780429;112977;114107;114394;114962;1147.2313549921573;1154.2035995163478;1169.7309618787556;1170.1867202294325;1180.0382688109164;16699.137767386794;16854.57863553421;17046.14769261507;17336.65326693484;17374.39189628357;55357.44642553523;56491.71754141203;56942.86114277774;57076.42923570711;57452.71273643605;68717.3128268731;69296;69355;69554.65222673854;69620.30379696138;19305.903470482557;19423.514412139808;19704.507387315432;19853.305134320228;19899.701504477733;22213.666794997764;22734.317970460914;22758.20346287872;22801.88599056994;22959.540809184058;17419.129043548026;17728.91135544314;17955.371561995267;18048.729269060714;18211.635767284846;15884;16560.420385286456;16697.582560436087;16763.74854377161;16870.915645421694;18027.188776504827;18220.90889545544;18332.266709331478;18356.632867342847;18645.81354186441;19169.233230670616;19221.90389048046;19235.90382048137;19246.8075319245;19348.129334180278;17763.111844407988;17795.555111122325;17838.807880147895;17849;17935.103244837966 20:31:43 INFO - PID 31777 | |3;mootools.html;1358.8777010069093;1387.1884947305825;1395.5045958684666;1404.9719005619882;1422.6514503946535;14863.628409289773;15517.146556939364;15530.145841978687;15547.455839045635;15576.454824081145;15065.39738410465;15135.848641513581;15189.848101518981;15201.315940782664;15207.61980950474;2670.8798104085267;2786.9303267418272;2791.8185317954267;2792.3298408382047;2798.566222235547;2662.5207462656713;2766.073365422586;2773.237359726071;2780.8748606312765;2783.220698204506;2456.9017239310497;2783.6381270434813;2816.985915070432;2817.070366778958;2825.519661657523;2834.674012488559;2859.8284102953785;2867.584200290967;2894.8986785462407;2896.9275768105754;2796.874140663675;2810.4519618674367;2818.873150708223;2822.5907243449583;2832.06541841194;14705.485308014275;15072.321745521478;15130.924345378313;15229.923850380788;15238.619034524114;8138.308243799284;8395.118512556215;8412.200840920103;8415.83168336636;8417.789555261106;5291.973540132313;5526.253955715967;5595.132754423071;5682.204491371212;5767.1637612546365;1923.4998900285887;1941.2817257614772;1960.980390196094;2005.8997050147434;2022.352847088932;25633.61549576758;25642.615360769603;25837.870810646204;25906;25940.092096776523;6949.93050069503;7028.226895041541;7051.753188638373;7109.217986021534;7121.430285577245;17495.65008699819;17520.737188942177;17602.559936001704;17681.204345804468;17701.38045168413;8294.958525207336;8323.791905202297;8550.230479256898;8563.614637341334;8572.785680358042;7484.288992545699;7557.35762460186;7561.735339263099;7710.460267781314;7745.845083098419;5103.132467480537;5257.211418287287;5268.552173065333;5298.602604804655;5303.761330740126;1509.5018643847504;1510.20714125083;1619.247050121699;1636.5663099278702;1653.8511533962;850.7277671145174;852.3905407633448;872.6553011560525;877.6664867350366;887.1394747095308;8643;8681.479111253346;8717.607707653171;8741.606627701769;8804.955975220082;959.3428501476511;973.9756506087263;979.7795496013482;984.8276551603584;988.9307748457683;5444.455554444524;5467.5625949923915;5500.202470641734;5503.174523821379;5601.411851755588;21462.24882129118;21731.348059558237;21829.563408731738;22061;22218.77781222167;21806.454838628844;22188.778112218995;22204.222852200095;22267.665985010237;22306.553868922856;11105.666829995112;11380.829287560693;11457.598984035685;11719.472623731783;11721.882781172078;7912.406569507195;8375.62309696053;8405.663773449238;8422;8447.493150410995;18628.441146765617;18867.433976980712;18932.716009259595;19010.334638287593;19072;19025.90487047556;19085.71371429402;19205.039748012823;19264;19286;10917.563297468012;10986.395748233925;11201.327920324806;11207.943960280147;11331.490082946451;14173.858261417254;14305.070170438888;14383.568492945229;14420.062695924731;14428.062175958528;11202.719932001764;11237.101031917591;11320.716982075513;11369.658910232707;11462.426878655868;10657.20070994663;10742.83885741699;10769.461526923778;10801.837972430263;11063.170262230526;10010.699679009642;10082.344647597884;10116.59533618647;10175.643852465128;10227.335223210468;6901.344372284625;6954.687039083152;6959.095317608679;6972.4073453757;7047.929520704933;6714.597124172566;6758.763443279461;6769.356911093439;6783.762568310085;6842.315768423118 20:31:43 INFO - PID 31777 | |4;prototype.html;507.3860628639346;516.9508896654818;529.6716036057645;537.2639483907046;554.2130175151285;6135.141080248769;6234.750609975596;6258.06129080637;6282;6303.495720342373;6151.569390142692;6159.445649891509;6171.722272497737;6182.5981311214855;6200.286966998797;5130.3074084998425;5172.327597412331;5180.792768289264;5208.244804503363;5211.45279745627;5217.608679349045;5233.267342572043;5253.86865328366;5304.968224149655;5323.547498462635;5210.296609957664;5222.817201397933;5224.3730752309775;5250.842474725764;5260.473952604747;5240.737963101848;5254.474552544753;5299.33758280215;5320.494553017457;5342.946570534284;4979.427365852937;4989.850304490835;4997.375328083989;5005.724685142316;5026.6983980960895;6142.447179753844;6165.907511387333;6227.283862355842;6248.687565621701;6310.1796766420075;5972.343042265347;5979.581429299951;6008.48927841134;6067.7269522871575;6124.112003759475;6685;6700.162479690039;6709.630970296632;6725.596464212163;6730.024146498779;5294.205869119624;5331.946680533184;5343.503818930706;5371.865703357408;5387.568994480433;6853.965730171317;6935.167779866449;6958.512904096715;6998.475114366392;7026.578405295648;5533.667979921218;5568.969740598002;5572.3870374258795;5599.608027438122;5621.297337832771;5682.630629009184;5687.772489100473;5689.971550142305;5728.885422291531;5734.799282025109;5947.672877991666;6000.8799824004145;6054.878902422015;6106.603070800384;6108.755649774048;6355.968220158869;6414.903776443357;6577.704003319862;6620.768273110418;6773.491988100912;1939.9030048497518;1956.960860782805;1963.4600484866776;1969.8818070915504;1975.9012049397472;1253.2918900821007;1417.6030711400824;1445.3062529985666;1455.345094707386;1481.2149560732828;5644.74598643062;5660.575456840754;5732.512736417368;5800.564957628195;5823.272090988627;6631.18174775728;6648.936170212743;6703.748681889279;6737.831554211184;6781.491388145909;5762.193292938992;5768.451997060357;5782.710864456761;5846.766129354864;5865.709543900335;3560.181158333598;3593.6047034826147;3620.9637903621156;3624.3294990426857;3658.140337020798;6529.412352888263;6529.738810447624;6569.704363303663;6590.7693230736695;6623.4701223901975;6968.163820341591;7008.299170082951;7024.402925751267;7041.4718896082995;7043.260457651975;6599.505037122139;6603.70283337251;6627.271000190071;6654.401103900672;6665.800025999228;6682.231543372574;6743.15710536183;6743.494237932076;6764.526483146133;6906.274841141809;6662.333766623299;6673.232578253369;6695.564788288746;6707.564008339442;6747.156605424322;6415.582987105823;6474.352564743676;6506.772262970962;6511.511636627177;6549.672516374258;5062.974685126551;5089;5092.643514954066;5099.515546023122;5103.260027296095;6852.074969879002;6852.5203235773015;6866.279040700854;6879.759208427681;6880.931190688029;6575.178102737158;6593.736250550116;6602.273749887412;6623.437007854386;6632.204135503771;6302.903112976602;6464.604069232779;6483.157189565326;6490.545661803629;6525.9021114684265;6263.592866463665;6347.39699728525;6389.7220555889935;6427.9430582213245;6460.479038923704;6230.719617617127;6409.9038514423255;6501.447376972821;6542.934570654233;6578.552718401944;6170.784022559189;6216.005439129898;6299.590526615755;6307.716152773044;6359.109724638647 20:31:43 INFO - PID 31777 | |5;yui.html;897.735168125403;924.4915296586878;930.6137952749609;934.308611627396;954.9761255968602;18659;19755.012249387528;19830.7025394619;19875.20499180031;19883.30408435705;16583.336666533356;16723.16384180792;17268.481945541655;17971.82028179718;18081.276748930028;984.1290457944734;1000.7598176437639;1001.319103009953;1002.0931057393071;1002.7493126718321;965.3918031640092;975.5219942228292;979.9461029643367;989.9653512127077;994.7910938702845;1063.3726101600055;1064.3986147826492;1064.973375665607;1065.5524679634534;1066.7173199102244;995.7411073120968;1021.667957913681;1042.8279333909895;1052.55792567122;1053.6312290698233;751.8872169174613;754.607604045893;756.7767508584981;757.685560492395;759.0057025296824;20269;20403;20489.897550512153;20633.38099857007;20634.690479642817;20795.480112997146;21853.125874964982;21997.67003494949;22124.115035398565;22154.778452215432;16614.25235864389;16729;16824.83175168245;16879.49361519144;16975.15124243795;3729.533808273966;3746.2320224353944;3752.0994961209385;3762.6801721853676;3763.6236376362417;135467;136720.31639841836;137133.3143334277;137267;138760.99999999898;16596.419125330554;16633;16778.832211677727;16888.662226755398;16903.915480422518;30014.399712005637;30386.54420183699;30673.846630766704;30919;31012.844935775178;7876.56678882667;8122.5126492410645;8124.984376952881;8161.755147345589;8169.101398846122;4367.344898265285;4393.956060439355;4401.339799030171;4450.221211288076;4487.416635837386;4859.708417494961;4941.48114447985;4949.331840201598;4969.90060198794;5017.598592112622;961.7643677299106;992.1665800727424;994.9054839790208;995.5171741705267;1005.2309982863115;686.2999740264902;692.6190595172635;705.4532737128663;710.4068103133837;713.6039498078616;11067.557297708001;11621.709457263636;11666.416679166008;11825.994790442737;12130.5147794089;690.7893092606703;696.5959743348845;699.734101041601;706.8338940349014;719.3669570777682;5472.50747432733;5499.230107784913;5559.638623489541;5567.638103523258;5587.608867379326;111288.44355778169;113080;115025.4248728751;115668;116106.41946790212;101447;102473.48763256136;103474;103543;103818;86925;91093.08906910979;91941.54029229812;92308;92738.53630731803;10035.29752917318;10208.336458130494;10375.94812025935;10390.428526431118;10516.894831051592;42841.571584285004;44018.559814401444;44576.331355029055;45268.8682782933;46222;53907;55283.72358138183;56282.43717562772;56523.434765651815;57192.42807571871;15743.370265189264;16009.039457632114;16044.117573533567;16062;16215.594610134842;15386.615334616725;15410.229488525752;15698.76451853246;15707.607309817346;15717.371305148123;15194.468193613171;15345.6163595911;15383.923080384526;15493.612659683598;15508.844911551192;13934.721305574034;14048.2975851205;14131.64670883195;14247.572572822832;14294.428222870969;15058.397664093314;15209.695806084037;15269.541913742605;15473.226338683246;15488;11060.67023794693;11220.55117795279;11223.969528227497;11241.437928103725;11431.714207144887;12112.333821639895;12140.696482588006;12262.4481898313;12323;12457.937710311391 20:31:43 INFO - PID 31777 | __end_tp_report 20:31:43 INFO - PID 31777 | __start_cc_report 20:31:43 INFO - PID 31777 | _x_x_mozilla_cycle_collect,295 20:31:43 INFO - PID 31777 | __end_cc_report 20:31:43 INFO - PID 31777 | __startTimestamp1506223903730__endTimestamp 20:31:43 INFO - PID 31777 | 20:31:43 INFO - PID 31777 | ------- Summary: start ------- 20:31:43 INFO - PID 31777 | Number of tests: 6 20:31:43 INFO - PID 31777 | 20:31:43 INFO - PID 31777 | [#0] dojo.html Cycles:165 Average:6210.49 Median:6482.55 stddev:883.13 (13.6%) stddev-sans-first:850.38 20:31:43 INFO - PID 31777 | Values: 3052.6 3096.3 3097.9 3113.9 3131.0 6142.1 6162.6 6265.7 6312.9 6384.5 6205.1 6246.4 6287.2 6301.6 6326.5 5660.1 5712.3 5721.9 5820.2 5824.8 5901.2 5940.4 5955.1 5957.5 5971.0 534.5 5745.7 5909.6 5960.0 5994.5 5751.2 5838.9 5917.5 5918.9 5919.3 5803.6 5803.9 5884.0 5889.0 5893.0 6292.2 6293.3 6310.7 6350.0 6406.9 6748.1 6748.2 6790.3 6834.2 6852.0 6677.0 6744.3 6853.5 6919.5 6926.0 6220.0 6244.0 6246.6 6309.3 6401.7 6973.8 7088.5 7101.3 7117.3 7121.3 6682.1 6684.5 6704.7 6705.6 6782.5 6571.8 6785.1 6805.2 6829.2 6870.3 6552.0 6710.4 6770.7 6775.8 6775.8 6780.1 6832.8 6888.3 6895.1 6913.9 5238.2 5324.7 5379.5 5399.2 5402.1 4591.3 4597.3 4607.8 4646.4 4696.8 5807.2 5883.4 5887.1 5891.9 5893.5 6688.3 6781.4 6844.6 6928.7 6933.0 5723.2 5837.0 5839.3 5845.7 5852.1 5825.9 5886.2 5918.9 5925.4 5934.4 6514.1 6521.3 6603.6 6604.3 6651.3 6684.4 6785.2 6814.2 6822.8 6937.6 6538.7 6559.8 6607.4 6608.5 6608.7 6716.4 6789.4 6792.1 6806.7 6812.1 6842.7 6848.5 6852.4 6946.8 6948.9 6447.4 6537.2 6539.1 6544.8 6554.2 6404.3 6479.8 6480.9 6485.9 6494.4 6502.1 6532.8 6584.9 6608.6 6632.9 6663.5 6671.5 6671.7 6673.7 6760.7 6261.0 6345.2 6408.9 6482.5 6494.2 20:31:43 INFO - PID 31777 | 20:31:43 INFO - PID 31777 | [#1] ext.html Cycles:180 Average:37265.94 Median:35097.91 stddev:52056.43 (148.3%) stddev-sans-first:52130.74 20:31:43 INFO - PID 31777 | Values: 873.7 890.0 893.4 897.0 903.7 38764.8 39632.0 41787.0 42396.0 42561.0 38619.0 38943.4 38956.8 38984.4 39308.8 7206.3 7336.2 7350.0 7754.0 7949.4 7797.1 7900.8 7924.6 7925.4 7926.8 7876.2 7896.0 7930.2 7941.0 7964.8 7914.0 7948.5 7958.2 7961.3 7964.5 7902.4 7940.4 7942.1 7949.0 7949.6 38137.4 38392.8 38466.6 38575.6 38669.2 3547.8 3578.8 3583.4 3585.0 3587.9 31518.8 31524.4 31570.7 31582.7 31653.2 5063.3 5071.2 5106.3 5115.0 5142.7 179134.0 179182.0 180543.0 180696.0 182141.1 46677.8 47484.0 48268.5 48457.0 48457.3 49345.3 49466.0 49493.0 49498.3 49545.0 14209.6 14238.2 14242.1 14371.4 14576.9 11528.0 11559.5 11587.9 11598.8 11604.4 14537.9 14596.4 14640.9 14711.9 14763.5 5725.0 5765.4 5821.2 5825.5 5946.0 1005.1 1009.2 1016.8 1019.8 1034.4 23284.0 23353.0 23480.0 23590.0 23601.5 1110.3 1111.3 1121.9 1123.3 1130.5 12272.2 12370.0 12447.9 12452.3 12500.3 223115.0 223535.0 224373.0 224472.0 225642.0 53587.5 53697.0 53774.0 53825.5 53835.7 1446.7 1463.0 1468.1 1485.8 1488.4 24739.8 27304.6 27758.0 27763.3 27969.0 48595.8 48633.1 48649.0 48681.8 48695.3 195062.0 195846.0 196172.0 196226.0 196617.0 34245.5 34361.8 34399.5 34495.0 34552.3 41119.6 42819.8 43485.6 43545.8 44002.3 31131.5 31175.2 31192.5 31226.4 31226.7 31319.7 31489.4 31654.4 31738.0 31787.8 35056.0 35139.8 35147.3 35422.6 35446.3 30635.2 30810.4 30989.0 31033.1 31708.7 22902.0 22936.0 23018.0 23203.3 23267.0 20:31:43 INFO - PID 31777 | 20:31:43 INFO - PID 31777 | [#2] jquery.html Cycles:180 Average:34760.31 Median:22068.95 stddev:77048.78 (349.1%) stddev-sans-first:77222.18 20:31:43 INFO - PID 31777 | Values: 576.3 582.8 586.4 587.1 594.9 21634.0 22531.8 22629.3 22669.5 22688.7 23137.2 24416.9 24500.6 24659.0 24669.5 6482.7 6678.8 6684.6 6693.0 6699.8 6596.3 6689.1 6698.4 6819.7 7072.8 7060.4 7064.9 7077.2 7080.5 7082.9 6755.9 6929.4 7010.9 7077.2 7079.6 6934.8 6953.9 6954.2 6956.8 6965.2 29219.7 29834.3 30192.8 30228.7 30235.8 2087.1 2121.7 2121.9 2128.5 2128.6 18645.3 19890.7 20056.0 20070.6 20114.0 2571.8 2598.8 2622.3 2637.3 2642.7 128494.0 134980.0 141265.0 144820.0 145239.0 19579.7 20346.6 20928.8 21785.3 21924.2 42652.8 42849.0 42922.4 42980.0 43027.6 11220.6 11247.9 11255.8 11420.0 11437.1 9397.0 9426.5 9465.1 9482.6 9605.6 10684.7 10725.9 10967.8 11062.4 11404.5 3479.5 3600.0 3719.5 3751.8 4112.4 952.5 957.4 957.6 974.4 991.9 18481.5 18927.1 19054.1 19444.8 19664.8 1001.6 1017.6 1026.0 1036.5 1041.4 10528.8 10592.7 10620.8 10698.2 10768.7 447551.0 454988.0 457075.0 457845.0 458275.0 112192.4 112977.0 114107.0 114394.0 114962.0 1147.2 1154.2 1169.7 1170.2 1180.0 16699.1 16854.6 17046.1 17336.7 17374.4 55357.4 56491.7 56942.9 57076.4 57452.7 68717.3 69296.0 69355.0 69554.7 69620.3 19305.9 19423.5 19704.5 19853.3 19899.7 22213.7 22734.3 22758.2 22801.9 22959.5 17419.1 17728.9 17955.4 18048.7 18211.6 15884.0 16560.4 16697.6 16763.7 16870.9 18027.2 18220.9 18332.3 18356.6 18645.8 19169.2 19221.9 19235.9 19246.8 19348.1 17763.1 17795.6 17838.8 17849.0 17935.1 20:31:43 INFO - PID 31777 | 20:31:43 INFO - PID 31777 | [#3] mootools.html Cycles:180 Average:9434.45 Median:14301.31 stddev:6673.56 (46.7%) stddev-sans-first:6664.70 20:31:43 INFO - PID 31777 | Values: 1358.9 1387.2 1395.5 1405.0 1422.7 14863.6 15517.1 15530.1 15547.5 15576.5 15065.4 15135.8 15189.8 15201.3 15207.6 2670.9 2786.9 2791.8 2792.3 2798.6 2662.5 2766.1 2773.2 2780.9 2783.2 2456.9 2783.6 2817.0 2817.1 2825.5 2834.7 2859.8 2867.6 2894.9 2896.9 2796.9 2810.5 2818.9 2822.6 2832.1 14705.5 15072.3 15130.9 15229.9 15238.6 8138.3 8395.1 8412.2 8415.8 8417.8 5292.0 5526.3 5595.1 5682.2 5767.2 1923.5 1941.3 1961.0 2005.9 2022.4 25633.6 25642.6 25837.9 25906.0 25940.1 6949.9 7028.2 7051.8 7109.2 7121.4 17495.7 17520.7 17602.6 17681.2 17701.4 8295.0 8323.8 8550.2 8563.6 8572.8 7484.3 7557.4 7561.7 7710.5 7745.8 5103.1 5257.2 5268.6 5298.6 5303.8 1509.5 1510.2 1619.2 1636.6 1653.9 850.7 852.4 872.7 877.7 887.1 8643.0 8681.5 8717.6 8741.6 8805.0 959.3 974.0 979.8 984.8 988.9 5444.5 5467.6 5500.2 5503.2 5601.4 21462.2 21731.3 21829.6 22061.0 22218.8 21806.5 22188.8 22204.2 22267.7 22306.6 11105.7 11380.8 11457.6 11719.5 11721.9 7912.4 8375.6 8405.7 8422.0 8447.5 18628.4 18867.4 18932.7 19010.3 19072.0 19025.9 19085.7 19205.0 19264.0 19286.0 10917.6 10986.4 11201.3 11207.9 11331.5 14173.9 14305.1 14383.6 14420.1 14428.1 11202.7 11237.1 11320.7 11369.7 11462.4 10657.2 10742.8 10769.5 10801.8 11063.2 10010.7 10082.3 10116.6 10175.6 10227.3 6901.3 6954.7 6959.1 6972.4 7047.9 6714.6 6758.8 6769.4 6783.8 6842.3 20:31:43 INFO - PID 31777 | 20:31:43 INFO - PID 31777 | [#4] prototype.html Cycles:180 Average:5654.53 Median:6171.25 stddev:1503.39 (24.4%) stddev-sans-first:1457.13 20:31:43 INFO - PID 31777 | Values: 507.4 517.0 529.7 537.3 554.2 6135.1 6234.8 6258.1 6282.0 6303.5 6151.6 6159.4 6171.7 6182.6 6200.3 5130.3 5172.3 5180.8 5208.2 5211.5 5217.6 5233.3 5253.9 5305.0 5323.5 5210.3 5222.8 5224.4 5250.8 5260.5 5240.7 5254.5 5299.3 5320.5 5342.9 4979.4 4989.9 4997.4 5005.7 5026.7 6142.4 6165.9 6227.3 6248.7 6310.2 5972.3 5979.6 6008.5 6067.7 6124.1 6685.0 6700.2 6709.6 6725.6 6730.0 5294.2 5331.9 5343.5 5371.9 5387.6 6854.0 6935.2 6958.5 6998.5 7026.6 5533.7 5569.0 5572.4 5599.6 5621.3 5682.6 5687.8 5690.0 5728.9 5734.8 5947.7 6000.9 6054.9 6106.6 6108.8 6356.0 6414.9 6577.7 6620.8 6773.5 1939.9 1957.0 1963.5 1969.9 1975.9 1253.3 1417.6 1445.3 1455.3 1481.2 5644.7 5660.6 5732.5 5800.6 5823.3 6631.2 6648.9 6703.7 6737.8 6781.5 5762.2 5768.5 5782.7 5846.8 5865.7 3560.2 3593.6 3621.0 3624.3 3658.1 6529.4 6529.7 6569.7 6590.8 6623.5 6968.2 7008.3 7024.4 7041.5 7043.3 6599.5 6603.7 6627.3 6654.4 6665.8 6682.2 6743.2 6743.5 6764.5 6906.3 6662.3 6673.2 6695.6 6707.6 6747.2 6415.6 6474.4 6506.8 6511.5 6549.7 5063.0 5089.0 5092.6 5099.5 5103.3 6852.1 6852.5 6866.3 6879.8 6880.9 6575.2 6593.7 6602.3 6623.4 6632.2 6302.9 6464.6 6483.2 6490.5 6525.9 6263.6 6347.4 6389.7 6427.9 6460.5 6230.7 6409.9 6501.4 6542.9 6578.6 6170.8 6216.0 6299.6 6307.7 6359.1 20:31:43 INFO - PID 31777 | 20:31:43 INFO - PID 31777 | [#5] yui.html Cycles:180 Average:23495.10 Median:19792.86 stddev:33797.31 (170.8%) stddev-sans-first:33849.53 20:31:43 INFO - PID 31777 | Values: 897.7 924.5 930.6 934.3 955.0 18659.0 19755.0 19830.7 19875.2 19883.3 16583.3 16723.2 17268.5 17971.8 18081.3 984.1 1000.8 1001.3 1002.1 1002.7 965.4 975.5 979.9 990.0 994.8 1063.4 1064.4 1065.0 1065.6 1066.7 995.7 1021.7 1042.8 1052.6 1053.6 751.9 754.6 756.8 757.7 759.0 20269.0 20403.0 20489.9 20633.4 20634.7 20795.5 21853.1 21997.7 22124.1 22154.8 16614.3 16729.0 16824.8 16879.5 16975.2 3729.5 3746.2 3752.1 3762.7 3763.6 135467.0 136720.3 137133.3 137267.0 138761.0 16596.4 16633.0 16778.8 16888.7 16903.9 30014.4 30386.5 30673.8 30919.0 31012.8 7876.6 8122.5 8125.0 8161.8 8169.1 4367.3 4394.0 4401.3 4450.2 4487.4 4859.7 4941.5 4949.3 4969.9 5017.6 961.8 992.2 994.9 995.5 1005.2 686.3 692.6 705.5 710.4 713.6 11067.6 11621.7 11666.4 11826.0 12130.5 690.8 696.6 699.7 706.8 719.4 5472.5 5499.2 5559.6 5567.6 5587.6 111288.4 113080.0 115025.4 115668.0 116106.4 101447.0 102473.5 103474.0 103543.0 103818.0 86925.0 91093.1 91941.5 92308.0 92738.5 10035.3 10208.3 10375.9 10390.4 10516.9 42841.6 44018.6 44576.3 45268.9 46222.0 53907.0 55283.7 56282.4 56523.4 57192.4 15743.4 16009.0 16044.1 16062.0 16215.6 15386.6 15410.2 15698.8 15707.6 15717.4 15194.5 15345.6 15383.9 15493.6 15508.8 13934.7 14048.3 14131.6 14247.6 14294.4 15058.4 15209.7 15269.5 15473.2 15488.0 11060.7 11220.6 11224.0 11241.4 11431.7 12112.3 12140.7 12262.4 12323.0 12457.9 20:31:43 INFO - PID 31777 | -------- Summary: end -------- 20:31:43 INFO - PID 31777 | 20:31:44 INFO - TEST-INFO | 31777: exit 0 20:31:44 INFO - TEST-OK | dromaeo_css | took 1108253ms 20:31:44 INFO - TEST-START | kraken 20:31:44 INFO - Initialising browser for kraken test... 20:31:44 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:33371/getInfo.html -profile /tmp/tmpMXefp_/profile 20:31:44 INFO - TEST-INFO | started process 32146 (/builds/slave/test/build/application/firefox/firefox http://localhost:33371/getInfo.html) 20:31:50 INFO - TEST-INFO | 32146: exit 0 20:31:50 INFO - Browser initialized. 20:31:50 INFO - Running cycle 1/1 for kraken test... 20:31:50 INFO - Using env: {'DISPLAY': ':0', 20:31:50 INFO - 'HOME': '/home/cltbld', 20:31:50 INFO - 'JSGC_DISABLE_POISONING': '1', 20:31:50 INFO - 'LANG': 'en_US.UTF-8', 20:31:50 INFO - 'LANGUAGE': 'en_US:en', 20:31:50 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 20:31:50 INFO - 'LOGNAME': 'cltbld', 20:31:50 INFO - 'MAIL': '/var/mail/cltbld', 20:31:50 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 20:31:50 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 20:31:50 INFO - 'MOZ_CRASHREPORTER': '1', 20:31:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:31:50 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 20:31:50 INFO - 'MOZ_NO_REMOTE': '1', 20:31:50 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 20:31:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:31:50 INFO - 'NO_EM_RESTART': '1', 20:31:50 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:31:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:31:50 INFO - 'PWD': '/builds/slave/test', 20:31:50 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 20:31:50 INFO - 'RUST_BACKTRACE': 'full', 20:31:50 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 20:31:50 INFO - 'SHELL': '/bin/bash', 20:31:50 INFO - 'SHLVL': '1', 20:31:50 INFO - 'STYLO_FORCE_DISABLED': '1', 20:31:50 INFO - 'TERM': 'linux', 20:31:50 INFO - 'TMOUT': '86400', 20:31:50 INFO - 'USER': 'cltbld', 20:31:50 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1506222262.388993-634593663', 20:31:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:31:50 INFO - '_': '/tools/buildbot/bin/python'} 20:31:50 INFO - TEST-INFO | started process 32382 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpMXefp_/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 20:31:51 INFO - PID 32382 | 20:31:51 INFO - PID 32382 | (/builds/slave/test/build/application/firefox/firefox:32431): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 20:31:51 INFO - PID 32382 | 20:32:01 INFO - PID 32382 | RSS: Main: 150986752 20:32:01 INFO - PID 32382 | 20:32:04 INFO - PID 32382 | Cycle 1(1): loaded http://localhost:33371/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:33371/tests/kraken/driver.html?testName=audio-beat-detection) 20:32:04 INFO - PID 32382 | RSS: Main: 158920704 20:32:04 INFO - PID 32382 | 20:32:07 INFO - PID 32382 | Cycle 1(1): loaded http://localhost:33371/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:33371/tests/kraken/driver.html?testName=audio-dft) 20:32:08 INFO - PID 32382 | RSS: Main: 158859264 20:32:08 INFO - PID 32382 | 20:32:11 INFO - PID 32382 | Cycle 1(1): loaded http://localhost:33371/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:33371/tests/kraken/driver.html?testName=audio-fft) 20:32:11 INFO - PID 32382 | RSS: Main: 154894336 20:32:11 INFO - PID 32382 | 20:32:13 INFO - PID 32382 | Cycle 1(1): loaded http://localhost:33371/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:33371/tests/kraken/driver.html?testName=audio-oscillator) 20:32:14 INFO - PID 32382 | RSS: Main: 155521024 20:32:14 INFO - PID 32382 | 20:32:16 INFO - PID 32382 | Cycle 1(1): loaded http://localhost:33371/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:33371/tests/kraken/driver.html?testName=imaging-gaussian-blur) 20:32:17 INFO - PID 32382 | RSS: Main: 155582464 20:32:17 INFO - PID 32382 | 20:32:20 INFO - PID 32382 | Cycle 1(1): loaded http://localhost:33371/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:33371/tests/kraken/driver.html?testName=imaging-darkroom) 20:32:21 INFO - PID 32382 | RSS: Main: 157806592 20:32:21 INFO - PID 32382 | 20:32:24 INFO - PID 32382 | Cycle 1(1): loaded http://localhost:33371/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:33371/tests/kraken/driver.html?testName=imaging-desaturate) 20:32:25 INFO - PID 32382 | RSS: Main: 158113792 20:32:25 INFO - PID 32382 | 20:32:28 INFO - PID 32382 | Cycle 1(1): loaded http://localhost:33371/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:33371/tests/kraken/driver.html?testName=json-parse-financial) 20:32:28 INFO - PID 32382 | RSS: Main: 157667328 20:32:28 INFO - PID 32382 | 20:32:30 INFO - PID 32382 | Cycle 1(1): loaded http://localhost:33371/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:33371/tests/kraken/driver.html?testName=json-stringify-tinderbox) 20:32:31 INFO - PID 32382 | RSS: Main: 157945856 20:32:31 INFO - PID 32382 | 20:32:32 INFO - PID 32382 | Cycle 1(1): loaded http://localhost:33371/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:33371/tests/kraken/driver.html?testName=stanford-crypto-aes) 20:32:33 INFO - PID 32382 | RSS: Main: 155316224 20:32:33 INFO - PID 32382 | 20:32:35 INFO - PID 32382 | Cycle 1(1): loaded http://localhost:33371/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:33371/tests/kraken/driver.html?testName=stanford-crypto-ccm) 20:32:36 INFO - PID 32382 | RSS: Main: 155193344 20:32:36 INFO - PID 32382 | 20:32:38 INFO - PID 32382 | Cycle 1(1): loaded http://localhost:33371/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:33371/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 20:32:39 INFO - PID 32382 | RSS: Main: 155283456 20:32:39 INFO - PID 32382 | 20:32:42 INFO - PID 32382 | Cycle 1(1): loaded http://localhost:33371/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:33371/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 20:32:42 INFO - PID 32382 | RSS: Main: 155504640 20:32:42 INFO - PID 32382 | 20:32:44 INFO - PID 32382 | Cycle 1(1): loaded http://localhost:33371/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:33371/tests/kraken/driver.html?testName=ai-astar) 20:32:44 INFO - PID 32382 | RSS: Main: 156774400 20:32:44 INFO - PID 32382 | 20:32:44 INFO - PID 32382 | __start_tp_report 20:32:44 INFO - PID 32382 | _x_x_mozilla_page_load 20:32:44 INFO - PID 32382 | _x_x_mozilla_page_load_details 20:32:44 INFO - PID 32382 | |i|pagename|runs| 20:32:44 INFO - PID 32382 | |0;ai-astar;107;107;107;109;107;107;110;107;109;110 20:32:44 INFO - PID 32382 | |1;audio-beat-detection;116;118;117;116;117;120;120;120;116;142 20:32:44 INFO - PID 32382 | |2;audio-dft;161;161;162;161;162;161;163;165;171;167 20:32:44 INFO - PID 32382 | |3;audio-fft;75;73;77;77;77;77;78;74;77;74 20:32:44 INFO - PID 32382 | |4;audio-oscillator;80;80;80;80;78;80;80;81;79;79 20:32:44 INFO - PID 32382 | |5;imaging-gaussian-blur;115;114;114;114;114;114;115;114;111;116 20:32:44 INFO - PID 32382 | |6;imaging-darkroom;149;153;149;150;151;147;148;148;149;148 20:32:44 INFO - PID 32382 | |7;imaging-desaturate;94;95;94;96;95;95;100;94;94;94 20:32:44 INFO - PID 32382 | |8;json-parse-financial;53;53;54;55;56;56;56;55;56;54 20:32:44 INFO - PID 32382 | |9;json-stringify-tinderbox;37;38;38;38;37;38;38;38;38;38 20:32:44 INFO - PID 32382 | |10;stanford-crypto-aes;73;74;74;75;74;79;79;76;72;75 20:32:44 INFO - PID 32382 | |11;stanford-crypto-ccm;116;108;113;114;115;118;110;120;115;115 20:32:44 INFO - PID 32382 | |12;stanford-crypto-pbkdf2;178;165;168;168;171;174;169;164;169;170 20:32:44 INFO - PID 32382 | |13;stanford-crypto-sha256-iterative;66;68;66;67;67;63;65;65;67;64 20:32:44 INFO - PID 32382 | __end_tp_report 20:32:44 INFO - PID 32382 | __start_cc_report 20:32:44 INFO - PID 32382 | _x_x_mozilla_cycle_collect,726 20:32:44 INFO - PID 32382 | __end_cc_report 20:32:44 INFO - PID 32382 | __startTimestamp1506223964924__endTimestamp 20:32:44 INFO - PID 32382 | 20:32:44 INFO - PID 32382 | ------- Summary: start ------- 20:32:44 INFO - PID 32382 | Number of tests: 14 20:32:44 INFO - PID 32382 | 20:32:44 INFO - PID 32382 | [#0] ai-astar Cycles:10 Average:108.00 Median:108.00 stddev:1.33 (1.2%) stddev-sans-first:1.36 20:32:44 INFO - PID 32382 | Values: 107.0 107.0 107.0 109.0 107.0 107.0 110.0 107.0 109.0 110.0 20:32:44 INFO - PID 32382 | 20:32:44 INFO - PID 32382 | [#1] audio-beat-detection Cycles:10 Average:120.20 Median:119.00 stddev:7.84 (6.6%) stddev-sans-first:8.17 20:32:44 INFO - PID 32382 | Values: 116.0 118.0 117.0 116.0 117.0 120.0 120.0 120.0 116.0 142.0 20:32:44 INFO - PID 32382 | 20:32:44 INFO - PID 32382 | [#2] audio-dft Cycles:10 Average:163.40 Median:162.50 stddev:3.34 (2.1%) stddev-sans-first:3.43 20:32:44 INFO - PID 32382 | Values: 161.0 161.0 162.0 161.0 162.0 161.0 163.0 165.0 171.0 167.0 20:32:44 INFO - PID 32382 | 20:32:44 INFO - PID 32382 | [#3] audio-fft Cycles:10 Average:75.90 Median:77.00 stddev:1.73 (2.2%) stddev-sans-first:1.80 20:32:44 INFO - PID 32382 | Values: 75.0 73.0 77.0 77.0 77.0 77.0 78.0 74.0 77.0 74.0 20:32:44 INFO - PID 32382 | 20:32:44 INFO - PID 32382 | [#4] audio-oscillator Cycles:10 Average:79.70 Median:80.00 stddev:0.82 (1.0%) stddev-sans-first:0.87 20:32:44 INFO - PID 32382 | Values: 80.0 80.0 80.0 80.0 78.0 80.0 80.0 81.0 79.0 79.0 20:32:44 INFO - PID 32382 | 20:32:44 INFO - PID 32382 | [#5] imaging-gaussian-blur Cycles:10 Average:114.10 Median:114.00 stddev:1.29 (1.1%) stddev-sans-first:1.32 20:32:44 INFO - PID 32382 | Values: 115.0 114.0 114.0 114.0 114.0 114.0 115.0 114.0 111.0 116.0 20:32:44 INFO - PID 32382 | 20:32:44 INFO - PID 32382 | [#6] imaging-darkroom Cycles:10 Average:149.20 Median:149.00 stddev:1.75 (1.2%) stddev-sans-first:1.86 20:32:44 INFO - PID 32382 | Values: 149.0 153.0 149.0 150.0 151.0 147.0 148.0 148.0 149.0 148.0 20:32:44 INFO - PID 32382 | 20:32:44 INFO - PID 32382 | [#7] imaging-desaturate Cycles:10 Average:95.10 Median:94.50 stddev:1.85 (2.0%) stddev-sans-first:1.92 20:32:44 INFO - PID 32382 | Values: 94.0 95.0 94.0 96.0 95.0 95.0 100.0 94.0 94.0 94.0 20:32:44 INFO - PID 32382 | 20:32:44 INFO - PID 32382 | [#8] json-parse-financial Cycles:10 Average:54.80 Median:55.50 stddev:1.23 (2.2%) stddev-sans-first:1.12 20:32:44 INFO - PID 32382 | Values: 53.0 53.0 54.0 55.0 56.0 56.0 56.0 55.0 56.0 54.0 20:32:44 INFO - PID 32382 | 20:32:44 INFO - PID 32382 | [#9] json-stringify-tinderbox Cycles:10 Average:37.80 Median:38.00 stddev:0.42 (1.1%) stddev-sans-first:0.33 20:32:44 INFO - PID 32382 | Values: 37.0 38.0 38.0 38.0 37.0 38.0 38.0 38.0 38.0 38.0 20:32:44 INFO - PID 32382 | 20:32:44 INFO - PID 32382 | [#10] stanford-crypto-aes Cycles:10 Average:75.10 Median:75.00 stddev:2.33 (3.1%) stddev-sans-first:2.35 20:32:44 INFO - PID 32382 | Values: 73.0 74.0 74.0 75.0 74.0 79.0 79.0 76.0 72.0 75.0 20:32:44 INFO - PID 32382 | 20:32:44 INFO - PID 32382 | [#11] stanford-crypto-ccm Cycles:10 Average:114.40 Median:115.00 stddev:3.50 (3.0%) stddev-sans-first:3.67 20:32:44 INFO - PID 32382 | Values: 116.0 108.0 113.0 114.0 115.0 118.0 110.0 120.0 115.0 115.0 20:32:44 INFO - PID 32382 | 20:32:44 INFO - PID 32382 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:169.60 Median:169.50 stddev:4.09 (2.4%) stddev-sans-first:3.00 20:32:44 INFO - PID 32382 | Values: 178.0 165.0 168.0 168.0 171.0 174.0 169.0 164.0 169.0 170.0 20:32:44 INFO - PID 32382 | 20:32:44 INFO - PID 32382 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.80 Median:66.50 stddev:1.55 (2.3%) stddev-sans-first:1.64 20:32:44 INFO - PID 32382 | Values: 66.0 68.0 66.0 67.0 67.0 63.0 65.0 65.0 67.0 64.0 20:32:44 INFO - PID 32382 | -------- Summary: end -------- 20:32:44 INFO - PID 32382 | 20:32:45 INFO - PID 32382 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 20:32:45 INFO - TEST-INFO | 32382: exit 0 20:32:45 INFO - TEST-OK | kraken | took 61150ms 20:32:45 INFO - SUITE-END | took 1169s 20:32:46 INFO - Completed test suite (00:19:29) 20:32:46 INFO - javascript benchmark 20:32:46 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s", "stylo_disabled"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8648.943393119971, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3052.572639830423, 3096.3497665490245, 3097.891573794918, 3113.891013814517, 3130.968690313098, 6142.109394137848, 6162.568620196583, 6265.655388953617, 6312.936870631293, 6384.457321127709, 6205.131281620576, 6246.375362463751, 6287.15123458333, 6301.590396624216, 6326.462250708684, 5660.066089095294, 5712.2574065371655, 5721.9427805721825, 5820.185174075622, 5824.767009319643, 5901.232839730829, 5940.3762604926505, 5955.106733989893, 5957.523398128139, 5971.0, 534.480283660921, 5745.741441635095, 5909.586328956974, 5960.0, 5994.46049855513, 5751.19483272338, 5838.883222335529, 5917.52659787216, 5918.940810591925, 5919.289685237799, 5803.622764520335, 5803.872554854565, 5883.970580147115, 5889.02831032879, 5893.0276504376725, 6292.244930608311, 6293.30773614902, 6310.716017779211, 6349.968250158766, 6406.871862562769, 6748.089007983908, 6748.190217173921, 6790.32096790322, 6834.2482326944, 6852.0, 6676.998450232455, 6744.325567443266, 6853.520253582202, 6919.515633905628, 6925.965370173168, 6219.968900155515, 6244.032175012835, 6246.593971391845, 6309.337519560426, 6401.679916004227, 6973.755918542826, 7088.539244949062, 7101.325374089453, 7117.288271172842, 7121.287871212838, 6682.097916781269, 6684.465242780566, 6704.698288577026, 6705.564138330993, 6782.491313151435, 6571.80284591463, 6785.050092986986, 6805.2173999989645, 6829.248782633907, 6870.31296870309, 6552.049952756824, 6710.429613482811, 6770.69531871067, 6775.762848300285, 6775.762848300385, 6780.096181381903, 6832.760853370109, 6888.311168883071, 6895.069165662671, 6913.89629155563, 5238.188080847474, 5324.707141107198, 5379.5427388671615, 5399.190121481809, 5402.135658294654, 4591.334256532851, 4597.310403439511, 4607.838725644587, 4646.442426908792, 4696.835610753607, 5807.216025836458, 5883.382244864313, 5887.1463637772285, 5891.911621325684, 5893.469587737124, 6688.29772873851, 6781.423578995742, 6844.555103918229, 6928.653567321614, 6933.0, 5723.227364305849, 5836.970815145897, 5839.299284085937, 5845.678487683133, 5852.092925596539, 5825.854353641108, 5886.23478947734, 5918.852028699231, 5925.4370834770625, 5934.406559344031, 6514.120593719882, 6521.315261897527, 6603.570767900071, 6604.273529911706, 6651.268360480343, 6684.364985326386, 6785.185777706707, 6814.182298124257, 6822.761203357859, 6937.618430986344, 6538.738450461929, 6559.8032059038305, 6607.372299631527, 6608.537402381787, 6608.669566521751, 6716.361945615159, 6789.355011273921, 6792.0830687856505, 6806.693698783468, 6812.080369150101, 6842.726290948306, 6848.520603557703, 6852.383285504328, 6946.79159625212, 6948.861022779415, 6447.3552644735155, 6537.182852143482, 6539.11721917535, 6544.8363790905605, 6554.246261679968, 6404.295527492065, 6479.838004049937, 6480.870382592416, 6485.929821579387, 6494.415502604599, 6502.089707440868, 6532.804015879341, 6584.868302634016, 6608.6365249909795, 6632.867342653023, 6663.500237482305, 6671.466282697275, 6671.66641667905, 6673.733050677918, 6760.661966901734, 6261.029540421242, 6345.206849143857, 6408.935910640834, 6482.54622176462, 6494.220693516808], "value": 6145.3933946612715, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [873.6592728835753, 889.968851090212, 893.3657103456545, 897.0312062971991, 903.724364068959, 38764.80617596912, 39632.0, 41786.955326116826, 42396.0, 42560.99999999992, 38619.0, 38943.41584876229, 38956.80521597388, 38984.41523377145, 39308.80345598268, 7206.315400036988, 7336.156342020656, 7350.044494215745, 7754.0, 7949.364050875945, 7797.0643522777345, 7900.802479938019, 7924.564148971805, 7925.405594580401, 7926.80182995424, 7876.212378762107, 7896.0, 7930.206979302081, 7940.960295198516, 7964.800879978018, 7913.960430197841, 7948.523088614702, 7958.204179582053, 7961.323287520568, 7964.522128672298, 7902.367810575198, 7940.364770818321, 7942.086660034054, 7949.0, 7949.64226609804, 38137.42793858094, 38392.80803595992, 38466.61533384658, 38575.614243857766, 38669.226615467815, 3547.822608869546, 3578.785272883635, 3583.3549961007006, 3585.032041348847, 3587.94618080729, 31518.842405788055, 31524.36951260985, 31570.684293157003, 31582.684173158435, 31653.20866978344, 5063.341765570489, 5071.1632580624155, 5106.336176297094, 5114.974425127851, 5142.74286285688, 179134.0, 179182.0, 180543.0, 180695.9999999987, 182141.0892945527, 46677.76661116673, 47484.0, 48268.517314827106, 48457.0, 48457.273140902915, 49345.259821102714, 49466.0, 49493.0, 49498.25752613714, 49545.0, 14209.644758880904, 14238.2168980705, 14242.07426517273, 14371.353289102015, 14576.927115364568, 11528.0, 11559.537618495335, 11587.88412115885, 11598.76802463946, 11604.361760103275, 14537.854621453862, 14596.41614335436, 14640.853591463949, 14711.926440367944, 14763.48327808543, 5724.971375143097, 5765.394633563499, 5821.18503409523, 5825.475707186373, 5946.0, 1005.1406047829147, 1009.222898368267, 1016.7813920007086, 1019.8113349030453, 1034.3586976074882, 23284.0, 23353.0, 23480.0, 23590.0, 23601.527969440514, 1110.2727713347608, 1111.2721167635211, 1121.9102471802237, 1123.292325834719, 1130.5138790320077, 12272.202306850026, 12370.0, 12447.875521244672, 12452.252864828139, 12500.312482813351, 223115.0, 223535.0, 224373.0, 224472.0, 225642.0, 53587.46412535903, 53697.0, 53774.0, 53825.46174538205, 53835.73082134643, 1446.7395868743517, 1463.0343972977785, 1468.0892414872023, 1485.7919891215238, 1488.4343949299198, 24739.752602473745, 27304.59043114315, 27758.028469004297, 27763.305917352227, 27969.0, 48595.75702121467, 48633.05467781249, 48649.0, 48681.756591216814, 48695.26957095717, 195062.0, 195846.0, 196172.0, 196226.0, 196617.0, 34245.48631770476, 34361.82819085989, 34399.48400774041, 34495.0, 34552.30895382028, 41119.588804111576, 42819.78590107154, 43485.56514434942, 43545.78227108844, 44002.33996489991, 31131.533027005065, 31175.220619484695, 31192.532112017885, 31226.37547248997, 31226.687733122377, 31319.686803131677, 31489.370212596077, 31654.366912662077, 31738.0, 31787.841060794548, 35056.0, 35139.82430087833, 35147.29705405826, 35422.64577354193, 35446.29107417889, 30635.2341191472, 30810.383792324476, 30989.0, 31033.069007929796, 31708.682913171495, 22902.0, 22936.0, 23018.0, 23203.303900883002, 23267.0], "value": 17223.762097083138, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [576.2854060964405, 582.8076734677556, 586.4311617730805, 587.1251834766198, 594.922660054193, 21634.0, 22531.774682253174, 22629.321120366374, 22669.54660906781, 22688.659670104942, 23137.19019834306, 24416.877915610443, 24500.632490512657, 24659.0, 24669.506609867793, 6482.708278127496, 6678.833029174261, 6684.565503242298, 6693.0, 6699.799006029827, 6596.274409814917, 6689.096971908779, 6698.3971442570155, 6819.727210911582, 7072.752453664123, 7060.435165186798, 7064.858702825941, 7077.186123595801, 7080.504364694473, 7082.893756593655, 6755.932440675604, 6929.44564434844, 7010.859782804367, 7077.186123595801, 7079.575225486487, 6934.791956241321, 6953.860922781516, 6954.23503414624, 6956.826079348057, 6965.233824279325, 29219.707802921912, 29834.254143646365, 30192.8490357549, 30228.697713022808, 30235.848820755975, 2087.1025459052603, 2121.7029615853794, 2121.9045142968603, 2128.4891626009803, 2128.5530038691895, 18645.25418983239, 19890.70163947542, 20056.0, 20070.59858802816, 20114.0, 2571.7556832100922, 2598.792096632265, 2622.3050891513763, 2637.274749443899, 2642.6696662917134, 128494.0, 134980.0, 141265.0, 144820.0, 145239.0, 19579.748328942354, 20346.59306813885, 20928.790712092683, 21785.346439606838, 21924.23265185711, 42652.786736066744, 42849.0, 42922.356164657554, 42980.0, 43027.56972430235, 11220.607278745205, 11247.943760281147, 11255.774884502263, 11420.029297509638, 11437.08503319749, 9396.953015235016, 9426.481543515036, 9465.100815422524, 9482.620695172254, 9605.615775368908, 10684.732881677864, 10725.89274107249, 10967.780644387227, 11062.446877656084, 11404.48679809394, 3479.530263414407, 3599.9820000900354, 3719.516462859865, 3751.8124093795745, 4112.362583799516, 952.46661869352, 957.3537861943161, 957.5786653872274, 974.4104816586005, 991.8958509356557, 18481.544922918718, 18927.14827832751, 19054.14256358467, 19444.80555194458, 19664.803351966584, 1001.5993602559034, 1017.6031347774374, 1026.0047753678919, 1036.5180191211123, 1041.4480325427385, 10528.842067368996, 10592.735181620521, 10620.840687389695, 10698.197635177392, 10768.730781730363, 447551.0, 454988.0, 457075.0, 457845.0, 458275.0, 112192.43903780429, 112977.0, 114107.0, 114394.0, 114962.0, 1147.2313549921573, 1154.2035995163478, 1169.7309618787556, 1170.1867202294325, 1180.0382688109164, 16699.137767386794, 16854.57863553421, 17046.14769261507, 17336.65326693484, 17374.39189628357, 55357.44642553523, 56491.71754141203, 56942.86114277774, 57076.42923570711, 57452.71273643605, 68717.3128268731, 69296.0, 69355.0, 69554.65222673854, 69620.30379696138, 19305.903470482557, 19423.514412139808, 19704.507387315432, 19853.305134320228, 19899.701504477733, 22213.666794997764, 22734.317970460914, 22758.20346287872, 22801.88599056994, 22959.540809184058, 17419.129043548026, 17728.91135544314, 17955.371561995267, 18048.729269060714, 18211.635767284846, 15884.0, 16560.420385286456, 16697.582560436087, 16763.74854377161, 16870.915645421694, 18027.188776504827, 18220.90889545544, 18332.266709331478, 18356.632867342847, 18645.81354186441, 19169.233230670616, 19221.90389048046, 19235.90382048137, 19246.8075319245, 19348.129334180278, 17763.111844407988, 17795.555111122325, 17838.807880147895, 17849.0, 17935.103244837966], "value": 12732.28446600654, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1358.8777010069093, 1387.1884947305825, 1395.5045958684666, 1404.9719005619882, 1422.6514503946535, 14863.628409289773, 15517.146556939364, 15530.145841978687, 15547.455839045635, 15576.454824081145, 15065.39738410465, 15135.848641513581, 15189.848101518981, 15201.315940782664, 15207.61980950474, 2670.8798104085267, 2786.9303267418272, 2791.8185317954267, 2792.3298408382047, 2798.566222235547, 2662.5207462656713, 2766.073365422586, 2773.237359726071, 2780.8748606312765, 2783.220698204506, 2456.9017239310497, 2783.6381270434813, 2816.985915070432, 2817.070366778958, 2825.519661657523, 2834.674012488559, 2859.8284102953785, 2867.584200290967, 2894.8986785462407, 2896.9275768105754, 2796.874140663675, 2810.4519618674367, 2818.873150708223, 2822.5907243449583, 2832.06541841194, 14705.485308014275, 15072.321745521478, 15130.924345378313, 15229.923850380788, 15238.619034524114, 8138.308243799284, 8395.118512556215, 8412.200840920103, 8415.83168336636, 8417.789555261106, 5291.973540132313, 5526.253955715967, 5595.132754423071, 5682.204491371212, 5767.1637612546365, 1923.4998900285887, 1941.2817257614772, 1960.980390196094, 2005.8997050147434, 2022.352847088932, 25633.61549576758, 25642.615360769603, 25837.870810646204, 25906.0, 25940.092096776523, 6949.93050069503, 7028.226895041541, 7051.753188638373, 7109.217986021534, 7121.430285577245, 17495.65008699819, 17520.737188942177, 17602.559936001704, 17681.204345804468, 17701.38045168413, 8294.958525207336, 8323.791905202297, 8550.230479256898, 8563.614637341334, 8572.785680358042, 7484.288992545699, 7557.35762460186, 7561.735339263099, 7710.460267781314, 7745.845083098419, 5103.132467480537, 5257.211418287287, 5268.552173065333, 5298.602604804655, 5303.761330740126, 1509.5018643847504, 1510.20714125083, 1619.247050121699, 1636.5663099278702, 1653.8511533962, 850.7277671145174, 852.3905407633448, 872.6553011560525, 877.6664867350366, 887.1394747095308, 8643.0, 8681.479111253346, 8717.607707653171, 8741.606627701769, 8804.955975220082, 959.3428501476511, 973.9756506087263, 979.7795496013482, 984.8276551603584, 988.9307748457683, 5444.455554444524, 5467.5625949923915, 5500.202470641734, 5503.174523821379, 5601.411851755588, 21462.24882129118, 21731.348059558237, 21829.563408731738, 22061.0, 22218.77781222167, 21806.454838628844, 22188.778112218995, 22204.222852200095, 22267.665985010237, 22306.553868922856, 11105.666829995112, 11380.829287560693, 11457.598984035685, 11719.472623731783, 11721.882781172078, 7912.406569507195, 8375.62309696053, 8405.663773449238, 8422.0, 8447.493150410995, 18628.441146765617, 18867.433976980712, 18932.716009259595, 19010.334638287593, 19072.0, 19025.90487047556, 19085.71371429402, 19205.039748012823, 19264.0, 19286.0, 10917.563297468012, 10986.395748233925, 11201.327920324806, 11207.943960280147, 11331.490082946451, 14173.858261417254, 14305.070170438888, 14383.568492945229, 14420.062695924731, 14428.062175958528, 11202.719932001764, 11237.101031917591, 11320.716982075513, 11369.658910232707, 11462.426878655868, 10657.20070994663, 10742.83885741699, 10769.461526923778, 10801.837972430263, 11063.170262230526, 10010.699679009642, 10082.344647597884, 10116.59533618647, 10175.643852465128, 10227.335223210468, 6901.344372284625, 6954.687039083152, 6959.095317608679, 6972.4073453757, 7047.929520704933, 6714.597124172566, 6758.763443279461, 6769.356911093439, 6783.762568310085, 6842.315768423118], "value": 6778.166774353651, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [507.3860628639346, 516.9508896654818, 529.6716036057645, 537.2639483907046, 554.2130175151285, 6135.141080248769, 6234.750609975596, 6258.06129080637, 6282.0, 6303.495720342373, 6151.569390142692, 6159.445649891509, 6171.722272497737, 6182.5981311214855, 6200.286966998797, 5130.3074084998425, 5172.327597412331, 5180.792768289264, 5208.244804503363, 5211.45279745627, 5217.608679349045, 5233.267342572043, 5253.86865328366, 5304.968224149655, 5323.547498462635, 5210.296609957664, 5222.817201397933, 5224.3730752309775, 5250.842474725764, 5260.473952604747, 5240.737963101848, 5254.474552544753, 5299.33758280215, 5320.494553017457, 5342.946570534284, 4979.427365852937, 4989.850304490835, 4997.375328083989, 5005.724685142316, 5026.6983980960895, 6142.447179753844, 6165.907511387333, 6227.283862355842, 6248.687565621701, 6310.1796766420075, 5972.343042265347, 5979.581429299951, 6008.48927841134, 6067.7269522871575, 6124.112003759475, 6685.0, 6700.162479690039, 6709.630970296632, 6725.596464212163, 6730.024146498779, 5294.205869119624, 5331.946680533184, 5343.503818930706, 5371.865703357408, 5387.568994480433, 6853.965730171317, 6935.167779866449, 6958.512904096715, 6998.475114366392, 7026.578405295648, 5533.667979921218, 5568.969740598002, 5572.3870374258795, 5599.608027438122, 5621.297337832771, 5682.630629009184, 5687.772489100473, 5689.971550142305, 5728.885422291531, 5734.799282025109, 5947.672877991666, 6000.8799824004145, 6054.878902422015, 6106.603070800384, 6108.755649774048, 6355.968220158869, 6414.903776443357, 6577.704003319862, 6620.768273110418, 6773.491988100912, 1939.9030048497518, 1956.960860782805, 1963.4600484866776, 1969.8818070915504, 1975.9012049397472, 1253.2918900821007, 1417.6030711400824, 1445.3062529985666, 1455.345094707386, 1481.2149560732828, 5644.74598643062, 5660.575456840754, 5732.512736417368, 5800.564957628195, 5823.272090988627, 6631.18174775728, 6648.936170212743, 6703.748681889279, 6737.831554211184, 6781.491388145909, 5762.193292938992, 5768.451997060357, 5782.710864456761, 5846.766129354864, 5865.709543900335, 3560.181158333598, 3593.6047034826147, 3620.9637903621156, 3624.3294990426857, 3658.140337020798, 6529.412352888263, 6529.738810447624, 6569.704363303663, 6590.7693230736695, 6623.4701223901975, 6968.163820341591, 7008.299170082951, 7024.402925751267, 7041.4718896082995, 7043.260457651975, 6599.505037122139, 6603.70283337251, 6627.271000190071, 6654.401103900672, 6665.800025999228, 6682.231543372574, 6743.15710536183, 6743.494237932076, 6764.526483146133, 6906.274841141809, 6662.333766623299, 6673.232578253369, 6695.564788288746, 6707.564008339442, 6747.156605424322, 6415.582987105823, 6474.352564743676, 6506.772262970962, 6511.511636627177, 6549.672516374258, 5062.974685126551, 5089.0, 5092.643514954066, 5099.515546023122, 5103.260027296095, 6852.074969879002, 6852.5203235773015, 6866.279040700854, 6879.759208427681, 6880.931190688029, 6575.178102737158, 6593.736250550116, 6602.273749887412, 6623.437007854386, 6632.204135503771, 6302.903112976602, 6464.604069232779, 6483.157189565326, 6490.545661803629, 6525.9021114684265, 6263.592866463665, 6347.39699728525, 6389.7220555889935, 6427.9430582213245, 6460.479038923704, 6230.719617617127, 6409.9038514423255, 6501.447376972821, 6542.934570654233, 6578.552718401944, 6170.784022559189, 6216.005439129898, 6299.590526615755, 6307.716152773044, 6359.109724638647], "value": 5223.064500136796, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [897.735168125403, 924.4915296586878, 930.6137952749609, 934.308611627396, 954.9761255968602, 18659.0, 19755.012249387528, 19830.7025394619, 19875.20499180031, 19883.30408435705, 16583.336666533356, 16723.16384180792, 17268.481945541655, 17971.82028179718, 18081.276748930028, 984.1290457944734, 1000.7598176437639, 1001.319103009953, 1002.0931057393071, 1002.7493126718321, 965.3918031640092, 975.5219942228292, 979.9461029643367, 989.9653512127077, 994.7910938702845, 1063.3726101600055, 1064.3986147826492, 1064.973375665607, 1065.5524679634534, 1066.7173199102244, 995.7411073120968, 1021.667957913681, 1042.8279333909895, 1052.55792567122, 1053.6312290698233, 751.8872169174613, 754.607604045893, 756.7767508584981, 757.685560492395, 759.0057025296824, 20269.0, 20403.0, 20489.897550512153, 20633.38099857007, 20634.690479642817, 20795.480112997146, 21853.125874964982, 21997.67003494949, 22124.115035398565, 22154.778452215432, 16614.25235864389, 16729.0, 16824.83175168245, 16879.49361519144, 16975.15124243795, 3729.533808273966, 3746.2320224353944, 3752.0994961209385, 3762.6801721853676, 3763.6236376362417, 135467.0, 136720.31639841836, 137133.3143334277, 137267.0, 138760.99999999898, 16596.419125330554, 16633.0, 16778.832211677727, 16888.662226755398, 16903.915480422518, 30014.399712005637, 30386.54420183699, 30673.846630766704, 30919.0, 31012.844935775178, 7876.56678882667, 8122.5126492410645, 8124.984376952881, 8161.755147345589, 8169.101398846122, 4367.344898265285, 4393.956060439355, 4401.339799030171, 4450.221211288076, 4487.416635837386, 4859.708417494961, 4941.48114447985, 4949.331840201598, 4969.90060198794, 5017.598592112622, 961.7643677299106, 992.1665800727424, 994.9054839790208, 995.5171741705267, 1005.2309982863115, 686.2999740264902, 692.6190595172635, 705.4532737128663, 710.4068103133837, 713.6039498078616, 11067.557297708001, 11621.709457263636, 11666.416679166008, 11825.994790442737, 12130.5147794089, 690.7893092606703, 696.5959743348845, 699.734101041601, 706.8338940349014, 719.3669570777682, 5472.50747432733, 5499.230107784913, 5559.638623489541, 5567.638103523258, 5587.608867379326, 111288.44355778169, 113080.0, 115025.4248728751, 115668.0, 116106.41946790212, 101447.0, 102473.48763256136, 103474.0, 103543.0, 103818.0, 86925.0, 91093.08906910979, 91941.54029229812, 92308.0, 92738.53630731803, 10035.29752917318, 10208.336458130494, 10375.94812025935, 10390.428526431118, 10516.894831051592, 42841.571584285004, 44018.559814401444, 44576.331355029055, 45268.8682782933, 46222.0, 53907.0, 55283.72358138183, 56282.43717562772, 56523.434765651815, 57192.42807571871, 15743.370265189264, 16009.039457632114, 16044.117573533567, 16062.0, 16215.594610134842, 15386.615334616725, 15410.229488525752, 15698.76451853246, 15707.607309817346, 15717.371305148123, 15194.468193613171, 15345.6163595911, 15383.923080384526, 15493.612659683598, 15508.844911551192, 13934.721305574034, 14048.2975851205, 14131.64670883195, 14247.572572822832, 14294.428222870969, 15058.397664093314, 15209.695806084037, 15269.541913742605, 15473.226338683246, 15488.0, 11060.67023794693, 11220.55117795279, 11223.969528227497, 11241.437928103725, 11431.714207144887, 12112.333821639895, 12140.696482588006, 12262.4481898313, 12323.0, 12457.937710311391], "value": 8772.658302781783, "unit": "score"}]}, {"extraOptions": ["e10s", "stylo_disabled"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1423.1, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [107.0, 107.0, 107.0, 109.0, 107.0, 107.0, 110.0, 107.0, 109.0, 110.0], "value": 108.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 118.0, 117.0, 116.0, 117.0, 120.0, 120.0, 120.0, 116.0, 142.0], "value": 120.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 161.0, 162.0, 161.0, 162.0, 161.0, 163.0, 165.0, 171.0, 167.0], "value": 163.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 73.0, 77.0, 77.0, 77.0, 77.0, 78.0, 74.0, 77.0, 74.0], "value": 75.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 80.0, 80.0, 80.0, 78.0, 80.0, 80.0, 81.0, 79.0, 79.0], "value": 79.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 114.0, 114.0, 114.0, 114.0, 114.0, 115.0, 114.0, 111.0, 116.0], "value": 114.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 153.0, 149.0, 150.0, 151.0, 147.0, 148.0, 148.0, 149.0, 148.0], "value": 149.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 94.0, 96.0, 95.0, 95.0, 100.0, 94.0, 94.0, 94.0], "value": 95.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 53.0, 54.0, 55.0, 56.0, 56.0, 56.0, 55.0, 56.0, 54.0], "value": 54.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [37.0, 38.0, 38.0, 38.0, 37.0, 38.0, 38.0, 38.0, 38.0, 38.0], "value": 37.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 74.0, 74.0, 75.0, 74.0, 79.0, 79.0, 76.0, 72.0, 75.0], "value": 75.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 108.0, 113.0, 114.0, 115.0, 118.0, 110.0, 120.0, 115.0, 115.0], "value": 114.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [178.0, 165.0, 168.0, 168.0, 171.0, 174.0, 169.0, 164.0, 169.0, 170.0], "value": 169.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 68.0, 66.0, 67.0, 67.0, 63.0, 65.0, 65.0, 67.0, 64.0], "value": 65.8, "unit": "score"}]}]} 20:32:46 INFO - Return code: 0 20:32:46 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 20:32:46 INFO - # TBPL SUCCESS # 20:32:46 INFO - Running post-action listener: _package_coverage_data 20:32:46 INFO - Running post-action listener: _resource_record_post_action 20:32:46 INFO - [mozharness: 2017-09-24 03:32:46.202179Z] Finished run-tests step (success) 20:32:46 INFO - Running post-run listener: _resource_record_post_run 20:32:46 INFO - Total resource usage - Wall time: 1188s; CPU: 13.0%; Read bytes: 69632; Write bytes: 335769600; Read time: 60; Write time: 315308 20:32:46 INFO - TinderboxPrint: CPU usage
13.1% 20:32:46 INFO - TinderboxPrint: I/O read bytes / time
69,632 / 60 20:32:46 INFO - TinderboxPrint: I/O write bytes / time
335,769,600 / 315,308 20:32:46 INFO - TinderboxPrint: CPU idle
8,225.6 (86.8%) 20:32:46 INFO - TinderboxPrint: CPU user
1,193.3 (12.6%) 20:32:46 INFO - TinderboxPrint: Swap in / out
0 / 0 20:32:46 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 10391552; Read time: 0; Write time: 912 20:32:46 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 20:32:46 INFO - run-tests - Wall time: 1170s; CPU: 13.0%; Read bytes: 65536; Write bytes: 324792320; Read time: 40; Write time: 314344 20:32:46 INFO - Running post-run listener: _upload_blobber_files 20:32:46 INFO - Blob upload gear active. 20:32:46 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 20:32:46 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 20:32:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 20:32:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 20:32:47 INFO - (blobuploader) - INFO - Open directory for files ... 20:32:47 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 20:32:47 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:32:47 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:32:48 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 20:32:48 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:32:48 INFO - (blobuploader) - INFO - Done attempting. 20:32:48 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 20:32:48 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:32:48 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:32:54 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 20:32:54 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:32:54 INFO - (blobuploader) - INFO - Done attempting. 20:32:54 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_raw.log ... 20:32:54 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:32:54 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:32:55 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-stylo-disabled-e10s_raw.log: uploaded 20:32:55 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:32:55 INFO - (blobuploader) - INFO - Done attempting. 20:32:55 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_errorsummary.log ... 20:32:55 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:32:55 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:32:56 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-stylo-disabled-e10s_errorsummary.log: uploaded 20:32:56 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:32:56 INFO - (blobuploader) - INFO - Done attempting. 20:32:56 INFO - (blobuploader) - INFO - Iteration through files over. 20:32:56 INFO - Return code: 0 20:32:56 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 20:32:56 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 20:32:56 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/05c5ed07e1c8dbc15846f50f0a1c2961bc333e5cbfc5b59720874b02113073671ebe421970b00b2f4a53a3b193db7754656fd1cded0dee0a8a54d6b02aec5d3f", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/4c335adfcc74c4635ff2ec506b7c029f4b8b9175e83cbf3aa9725e4cc1938c2ccb2f09c86b9f67451039c01e0338a7f487131524082fd84dd613f9e331df0644", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/3e5658f1cd84d4f1dfb44f963f3c40f30d17ab4a892a0015139fd9f8ab3ab4eeb8868b880209ecf031b4f31705895d4be593eff40f45595174356775719d45b0", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/6e7bc8ea9d109a919b7957952d58c521fcc0defb0d00d37de5a15613416165c502d9db49631ed677f5beafc0160ae9d1f91029abdf08b7aa75ca27eed02c2018"} 20:32:56 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 20:32:56 INFO - Writing to file /builds/slave/test/properties/blobber_files 20:32:56 INFO - Contents: 20:32:56 INFO - blobber_files:{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/05c5ed07e1c8dbc15846f50f0a1c2961bc333e5cbfc5b59720874b02113073671ebe421970b00b2f4a53a3b193db7754656fd1cded0dee0a8a54d6b02aec5d3f", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/4c335adfcc74c4635ff2ec506b7c029f4b8b9175e83cbf3aa9725e4cc1938c2ccb2f09c86b9f67451039c01e0338a7f487131524082fd84dd613f9e331df0644", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/3e5658f1cd84d4f1dfb44f963f3c40f30d17ab4a892a0015139fd9f8ab3ab4eeb8868b880209ecf031b4f31705895d4be593eff40f45595174356775719d45b0", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/6e7bc8ea9d109a919b7957952d58c521fcc0defb0d00d37de5a15613416165c502d9db49631ed677f5beafc0160ae9d1f91029abdf08b7aa75ca27eed02c2018"} 20:32:56 INFO - Running post-run listener: copy_logs_to_upload_dir 20:32:56 INFO - Copying logs to upload dir... 20:32:56 INFO - mkdir: /builds/slave/test/build/upload/logs 20:32:56 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1237.623176 ========= master_lag: -0.18 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 37 secs) (at 2017-09-23 20:32:56.158495) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-23 20:32:56.167254) ========= 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=14ef55db36f7623abb31b9cf000001d5-1506222262.388993-634593663 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/05c5ed07e1c8dbc15846f50f0a1c2961bc333e5cbfc5b59720874b02113073671ebe421970b00b2f4a53a3b193db7754656fd1cded0dee0a8a54d6b02aec5d3f", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/4c335adfcc74c4635ff2ec506b7c029f4b8b9175e83cbf3aa9725e4cc1938c2ccb2f09c86b9f67451039c01e0338a7f487131524082fd84dd613f9e331df0644", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/3e5658f1cd84d4f1dfb44f963f3c40f30d17ab4a892a0015139fd9f8ab3ab4eeb8868b880209ecf031b4f31705895d4be593eff40f45595174356775719d45b0", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/6e7bc8ea9d109a919b7957952d58c521fcc0defb0d00d37de5a15613416165c502d9db49631ed677f5beafc0160ae9d1f91029abdf08b7aa75ca27eed02c2018"} build_url:https://queue.taskcluster.net/v1/task/JuOc-pfvTaqJ1Q-nyQhMGg/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011351 build_url: 'https://queue.taskcluster.net/v1/task/JuOc-pfvTaqJ1Q-nyQhMGg/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/05c5ed07e1c8dbc15846f50f0a1c2961bc333e5cbfc5b59720874b02113073671ebe421970b00b2f4a53a3b193db7754656fd1cded0dee0a8a54d6b02aec5d3f", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/4c335adfcc74c4635ff2ec506b7c029f4b8b9175e83cbf3aa9725e4cc1938c2ccb2f09c86b9f67451039c01e0338a7f487131524082fd84dd613f9e331df0644", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/3e5658f1cd84d4f1dfb44f963f3c40f30d17ab4a892a0015139fd9f8ab3ab4eeb8868b880209ecf031b4f31705895d4be593eff40f45595174356775719d45b0", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/6e7bc8ea9d109a919b7957952d58c521fcc0defb0d00d37de5a15613416165c502d9db49631ed677f5beafc0160ae9d1f91029abdf08b7aa75ca27eed02c2018"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-23 20:32:56.194594) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-23 20:32:56.194889) ========= 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=14ef55db36f7623abb31b9cf000001d5-1506222262.388993-634593663 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004545 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-23 20:32:56.249670) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-23 20:32:56.251024) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-23 20:32:56.251310) ========= ========= Total master_lag: 0.24 =========