builder: mozilla-central_ubuntu64_hw_test-dromaeojs-stylo-disabled-e10s slave: talos-linux64-ix-020 starttime: 1505845225.96 results: success (0) revision: ba69e294fc80f23d54fc68050f1b7d63d341aa9c ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-09-19 11:20:25.963098) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-09-19 11:20:25.963530) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-19 11:20:25.964058) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-19 11:20:26.046185) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-19 11:20:26.046489) ========= 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=af724c981e2a0f424dbabf99000001e7-1505839810.393748-2053307589 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-09-19 11:20:26-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 111M=0s 2017-09-19 11:20:26 (111 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.133666 ========= master_lag: 0.08 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-19 11:20:26.255462) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-19 11:20:26.255761) ========= 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=af724c981e2a0f424dbabf99000001e7-1505839810.393748-2053307589 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.023174 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-19 11:20:26.324738) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-19 11:20:26.325039) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev ba69e294fc80f23d54fc68050f1b7d63d341aa9c --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 ba69e294fc80f23d54fc68050f1b7d63d341aa9c --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=af724c981e2a0f424dbabf99000001e7-1505839810.393748-2053307589 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-09-19 11:20:26,377 truncating revision to first 12 chars 2017-09-19 11:20:26,377 Setting DEBUG logging. 2017-09-19 11:20:26,377 attempt 1/10 2017-09-19 11:20:26,377 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/ba69e294fc80?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-09-19 11:20:26,938 unpacking tar archive at: mozilla-central-ba69e294fc80/testing/mozharness/ program finished with exit code 0 elapsedTime=0.881714 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-19 11:20:27.227365) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-19 11:20:27.227678) ========= script_repo_revision: ba69e294fc80f23d54fc68050f1b7d63d341aa9c ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-19 11:20:27.231079) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-19 11:20:27.231360) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-19 11:20:27.264003) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 47 secs) (at 2017-09-19 11:20:27.264275) ========= /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=af724c981e2a0f424dbabf99000001e7-1505839810.393748-2053307589 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 11:20:27 INFO - MultiFileLogger online at 20170919 11:20:27 in /builds/slave/test 11:20:27 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 11:20:27 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 11:20:27 INFO - {'append_to_log': False, 11:20:27 INFO - 'base_work_dir': '/builds/slave/test', 11:20:27 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 11:20:27 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 11:20:27 INFO - 'branch': 'Firefox-Non-PGO', 11:20:27 INFO - 'buildbot_json_path': 'buildprops.json', 11:20:27 INFO - 'code_coverage': False, 11:20:27 INFO - 'config_files': ('talos/linux_config.py',), 11:20:27 INFO - 'default_actions': ('clobber', 11:20:27 INFO - 'read-buildbot-config', 11:20:27 INFO - 'download-and-extract', 11:20:27 INFO - 'populate-webroot', 11:20:27 INFO - 'create-virtualenv', 11:20:27 INFO - 'install', 11:20:27 INFO - 'setup-mitmproxy', 11:20:27 INFO - 'run-tests'), 11:20:27 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 11:20:27 INFO - 'disable_ccov_upload': False, 11:20:27 INFO - 'disable_stylo': False, 11:20:27 INFO - 'download_minidump_stackwalk': True, 11:20:27 INFO - 'download_symbols': 'ondemand', 11:20:27 INFO - 'enable_stylo': False, 11:20:27 INFO - 'enable_webrender': False, 11:20:27 INFO - 'exes': {'tooltool.py': '/tools/tooltool.py'}, 11:20:27 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 11:20:27 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 11:20:27 INFO - 'gecko_profile': False, 11:20:27 INFO - 'gecko_profile_interval': 0, 11:20:27 INFO - 'installer_path': 'installer.exe', 11:20:27 INFO - 'log_level': 'info', 11:20:27 INFO - 'log_name': 'talos', 11:20:27 INFO - 'log_to_console': True, 11:20:27 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 11:20:27 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 11:20:27 INFO - 'opt_config_files': (), 11:20:27 INFO - 'pip_index': False, 11:20:27 INFO - 'suite': 'dromaeojs-stylo-disabled-e10s', 11:20:27 INFO - 'system_bits': '32', 11:20:27 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 11:20:27 INFO - 'title': 'talos-linux64-ix-020', 11:20:27 INFO - 'tooltool_cache': '/builds/tooltool_cache', 11:20:27 INFO - 'use_talos_json': True, 11:20:27 INFO - 'verify': 'False', 11:20:27 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 11:20:27 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 11:20:27 INFO - 'work_dir': 'build'} 11:20:27 INFO - [mozharness: 2017-09-19 18:20:27.549637Z] Running clobber step. 11:20:27 INFO - Running pre-action listener: _resource_record_pre_action 11:20:27 INFO - Running main action method: clobber 11:20:27 INFO - rmtree: /builds/slave/test/build 11:20:27 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 11:20:28 INFO - Running post-action listener: _resource_record_post_action 11:20:28 INFO - [mozharness: 2017-09-19 18:20:28.505709Z] Finished clobber step (success) 11:20:28 INFO - [mozharness: 2017-09-19 18:20:28.505807Z] Running read-buildbot-config step. 11:20:28 INFO - Running pre-action listener: _resource_record_pre_action 11:20:28 INFO - Running main action method: read_buildbot_config 11:20:28 INFO - Using buildbot properties: 11:20:28 INFO - { 11:20:28 INFO - "project": "", 11:20:28 INFO - "product": "firefox", 11:20:28 INFO - "who": "ffxbld@noreply.mozilla.org", 11:20:28 INFO - "installer_path": "public/build/target.tar.bz2", 11:20:28 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-stylo-disabled-e10s", 11:20:28 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 11:20:28 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-stylo-disabled-e10s", 11:20:28 INFO - "stage_platform": "linux64", 11:20:28 INFO - "basedir": "/builds/slave/test", 11:20:28 INFO - "buildnumber": 43, 11:20:28 INFO - "platform": "ubuntu64_hw", 11:20:28 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 11:20:28 INFO - "slavebuilddir": "test", 11:20:28 INFO - "taskId": "SkAcvY7oQyGJ5gOGkTgnZg", 11:20:28 INFO - "branch": "mozilla-central", 11:20:28 INFO - "script_repo_revision": "production", 11:20:28 INFO - "revision": "ba69e294fc80f23d54fc68050f1b7d63d341aa9c", 11:20:28 INFO - "slavename": "talos-linux64-ix-020", 11:20:28 INFO - "repo_path": "mozilla-central" 11:20:28 INFO - } 11:20:28 INFO - Finding installer, test and symbols from parent task. 11:20:28 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/SkAcvY7oQyGJ5gOGkTgnZg'}, attempt #1 11:20:28 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/SkAcvY7oQyGJ5gOGkTgnZg'}, attempt #1 11:20:29 INFO - Task dependencies: L7l39DLCQeO5S_9KbepNFA 11:20:29 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/L7l39DLCQeO5S_9KbepNFA'}, attempt #1 11:20:29 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/L7l39DLCQeO5S_9KbepNFA/artifacts/public/build/target.tar.bz2 11:20:29 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/L7l39DLCQeO5S_9KbepNFA/artifacts/public/build/target.test_packages.json 11:20:29 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/L7l39DLCQeO5S_9KbepNFA/artifacts/public/build/target.crashreporter-symbols.zip 11:20:29 INFO - Running post-action listener: _resource_record_post_action 11:20:29 INFO - [mozharness: 2017-09-19 18:20:29.834147Z] Finished read-buildbot-config step (success) 11:20:29 INFO - [mozharness: 2017-09-19 18:20:29.834365Z] Running download-and-extract step. 11:20:29 INFO - Running pre-action listener: _resource_record_pre_action 11:20:29 INFO - Running main action method: download_and_extract 11:20:29 INFO - mkdir: /builds/slave/test/build/tests 11:20:29 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')]} 11:20:29 INFO - trying https://queue.taskcluster.net/v1/task/L7l39DLCQeO5S_9KbepNFA/artifacts/public/build/target.test_packages.json 11:20:29 INFO - Downloading https://queue.taskcluster.net/v1/task/L7l39DLCQeO5S_9KbepNFA/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 11:20:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/L7l39DLCQeO5S_9KbepNFA/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 11:20:30 INFO - Downloaded 989 bytes. 11:20:30 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 11:20:30 INFO - Using the following test package requirements: 11:20:30 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 11:20:30 INFO - u'common': [u'target.common.tests.zip'], 11:20:30 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 11:20:30 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 11:20:30 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 11:20:30 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 11:20:30 INFO - u'mozbase': [u'target.common.tests.zip'], 11:20:30 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 11:20:30 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 11:20:30 INFO - u'web-platform': [u'target.common.tests.zip', 11:20:30 INFO - u'target.web-platform.tests.tar.gz'], 11:20:30 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 11:20:30 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite categories: ['common', 'talos'] 11:20:30 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/L7l39DLCQeO5S_9KbepNFA/artifacts/public/build/target.common.tests.zip 11:20:30 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/L7l39DLCQeO5S_9KbepNFA/artifacts/public/build/target.common.tests.zip'}, attempt #1 11:20:30 INFO - Fetch https://queue.taskcluster.net/v1/task/L7l39DLCQeO5S_9KbepNFA/artifacts/public/build/target.common.tests.zip into memory 11:20:31 INFO - Content-Length response header: 54731465 11:20:31 INFO - Bytes received: 54731465 11:20:45 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/L7l39DLCQeO5S_9KbepNFA/artifacts/public/build/target.talos.tests.zip 11:20:45 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/L7l39DLCQeO5S_9KbepNFA/artifacts/public/build/target.talos.tests.zip'}, attempt #1 11:20:45 INFO - Fetch https://queue.taskcluster.net/v1/task/L7l39DLCQeO5S_9KbepNFA/artifacts/public/build/target.talos.tests.zip into memory 11:20:45 INFO - Content-Length response header: 14508787 11:20:45 INFO - Bytes received: 14508787 11:20: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')]} 11:20:46 INFO - trying https://queue.taskcluster.net/v1/task/L7l39DLCQeO5S_9KbepNFA/artifacts/public/build/target.tar.bz2 11:20:46 INFO - Downloading https://queue.taskcluster.net/v1/task/L7l39DLCQeO5S_9KbepNFA/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 11:20:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/L7l39DLCQeO5S_9KbepNFA/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 11:20:47 INFO - Downloaded 61613416 bytes. 11:20:48 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/L7l39DLCQeO5S_9KbepNFA/artifacts/public/build/target.tar.bz2 11:20:48 INFO - mkdir: /builds/slave/test/properties 11:20:48 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 11:20:48 INFO - Writing to file /builds/slave/test/properties/build_url 11:20:48 INFO - Contents: 11:20:48 INFO - build_url:https://queue.taskcluster.net/v1/task/L7l39DLCQeO5S_9KbepNFA/artifacts/public/build/target.tar.bz2 11:20:48 INFO - Running post-action listener: _resource_record_post_action 11:20:48 INFO - Running post-action listener: find_tests_for_verification 11:20:48 INFO - Running post-action listener: set_extra_try_arguments 11:20:48 INFO - [mozharness: 2017-09-19 18:20:48.191519Z] Finished download-and-extract step (success) 11:20:48 INFO - [mozharness: 2017-09-19 18:20:48.191709Z] Running populate-webroot step. 11:20:48 INFO - Running pre-action listener: _resource_record_pre_action 11:20:48 INFO - Running main action method: populate_webroot 11:20:48 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 11:20:48 INFO - 'chromez-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 11:20:48 INFO - 'tests': ['tresize', 11:20:48 INFO - 'tcanvasmark']}, 11:20:48 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 11:20:48 INFO - 'dromaeojs-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 11:20:48 INFO - 'tests': ['dromaeo_css', 11:20:48 INFO - 'kraken']}, 11:20:48 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 11:20:48 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:20:48 INFO - 'g1-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 11:20:48 INFO - 'talos_options': ['--disable-stylo'], 11:20:48 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:20:48 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 11:20:48 INFO - 'tests': ['damp', 'tps']}, 11:20:48 INFO - 'g2-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 11:20:48 INFO - 'talos_options': ['--disable-stylo'], 11:20:48 INFO - 'tests': ['damp', 'tps']}, 11:20:48 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 11:20:48 INFO - 'g3-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 11:20:48 INFO - 'tests': ['dromaeo_dom']}, 11:20:48 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 11:20:48 INFO - 'g4-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 11:20:48 INFO - 'tests': ['basic_compositor_video', 11:20:48 INFO - 'glvideo']}, 11:20:48 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 11:20:48 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 11:20:48 INFO - 'g5-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 11:20:48 INFO - 'talos_options': ['--disable-stylo'], 11:20:48 INFO - 'tests': ['ts_paint_webext', 11:20:48 INFO - 'tp5o_webext']}, 11:20:48 INFO - 'other-e10s': {'tests': ['a11yr', 11:20:48 INFO - 'ts_paint', 11:20:48 INFO - 'tpaint', 11:20:48 INFO - 'sessionrestore', 11:20:48 INFO - 'sessionrestore_many_windows', 11:20:48 INFO - 'sessionrestore_no_auto_restore', 11:20:48 INFO - 'tabpaint']}, 11:20:48 INFO - 'other-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 11:20:48 INFO - 'tests': ['a11yr', 11:20:48 INFO - 'ts_paint', 11:20:48 INFO - 'tpaint', 11:20:48 INFO - 'sessionrestore', 11:20:48 INFO - 'sessionrestore_many_windows', 11:20:48 INFO - 'sessionrestore_no_auto_restore', 11:20:48 INFO - 'tabpaint']}, 11:20:48 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 11:20:48 INFO - 'perf-reftest-singletons-e10s': {'tests': ['perf_reftest_singletons']}, 11:20:48 INFO - 'perf-reftest-singletons-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 11:20:48 INFO - 'tests': ['perf_reftest_singletons']}, 11:20:48 INFO - 'perf-reftest-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 11:20:48 INFO - 'tests': ['bloom_basic']}, 11:20:48 INFO - 'svgr-e10s': {'tests': ['tsvgx', 11:20:48 INFO - 'tsvgr_opacity', 11:20:48 INFO - 'tart', 11:20:48 INFO - 'tscrollx', 11:20:48 INFO - 'tsvg_static']}, 11:20:48 INFO - 'svgr-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 11:20:48 INFO - 'tests': ['tsvgx', 11:20:50 INFO - 'tsvgr_opacity', 11:20:50 INFO - 'tart', 11:20:50 INFO - 'tscrollx', 11:20:50 INFO - 'tsvg_static']}, 11:20:50 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 11:20:50 INFO - 'tp5o-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 11:20:50 INFO - 'talos_options': ['--disable-stylo'], 11:20:50 INFO - 'tests': ['tp5o']}, 11:20:50 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 11:20:50 INFO - 'talos_options': ['--mitmproxy', 11:20:50 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 11:20:50 INFO - '--firstNonBlankPaint'], 11:20:50 INFO - 'tests': ['tp6_google', 11:20:50 INFO - 'tp6_youtube', 11:20:50 INFO - 'tp6_amazon', 11:20:50 INFO - 'tp6_facebook']}, 11:20:50 INFO - 'tp6-stylo-disabled-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 11:20:50 INFO - 'talos_options': ['--disable-stylo', 11:20:50 INFO - '--mitmproxy', 11:20:50 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 11:20:50 INFO - '--firstNonBlankPaint'], 11:20:50 INFO - 'tests': ['tp6_google', 11:20:50 INFO - 'tp6_youtube', 11:20:50 INFO - 'tp6_amazon', 11:20:50 INFO - 'tp6_facebook']}, 11:20:50 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 11:20:50 INFO - 'talos_options': ['--stylo-threads=1', 11:20:50 INFO - '--mitmproxy', 11:20:50 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 11:20:50 INFO - '--firstNonBlankPaint'], 11:20:50 INFO - 'tests': ['tp6_google', 11:20:50 INFO - 'tp6_youtube', 11:20:50 INFO - 'tp6_amazon', 11:20:50 INFO - 'tp6_facebook']}, 11:20:50 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 11:20:50 INFO - 'talos_options': ['--xperf_path', 11:20:50 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:20:50 INFO - 'tests': ['tp5n']}, 11:20:50 INFO - 'xperf-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 11:20:50 INFO - 'talos_options': ['--disable-stylo', 11:20:50 INFO - '--xperf_path', 11:20:50 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:20:50 INFO - 'tests': ['tp5n']}}} 11:20:50 INFO - Running post-action listener: _resource_record_post_action 11:20:50 INFO - [mozharness: 2017-09-19 18:20:50.165290Z] Finished populate-webroot step (success) 11:20:50 INFO - [mozharness: 2017-09-19 18:20:50.165512Z] Running create-virtualenv step. 11:20:50 INFO - Running pre-action listener: _resource_record_pre_action 11:20:50 INFO - Running main action method: create_virtualenv 11:20:50 INFO - Creating virtualenv /builds/slave/test/build/venv 11:20:50 INFO - Running command: ['virtualenv', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 11:20:50 INFO - Copy/paste: virtualenv --no-site-packages --distribute /builds/slave/test/build/venv 11:20:50 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 11:20:50 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 11:20:50 INFO - New python executable in /builds/slave/test/build/venv/bin/python 11:20:51 INFO - Installing distribute.............................................................................................................................................................................................done. 11:20:52 INFO - Installing pip...............done. 11:20:52 INFO - Return code: 0 11:20:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 11:20:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 11:20:52 INFO - Reading from file tmpfile_stdout 11:20:52 INFO - Output received: 11:20:52 INFO - pip 1.1 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.1-py2.7.egg (python 2.7) 11:20:52 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 11:20:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:20:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:20:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:20:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:20:52 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xa701f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc39a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xddca60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xde0090>, '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 0xde0d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xddaf90>, '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': 'af724c981e2a0f424dbabf99000001e7-1505839810.393748-2053307589', '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 11:20:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 11:20:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 11:20:52 INFO - Using env: {'DISPLAY': ':0', 11:20:52 INFO - 'HOME': '/home/cltbld', 11:20:52 INFO - 'LANG': 'en_US.UTF-8', 11:20:52 INFO - 'LANGUAGE': 'en_US:en', 11:20:52 INFO - 'LOGNAME': 'cltbld', 11:20:52 INFO - 'MAIL': '/var/mail/cltbld', 11:20:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:20:52 INFO - 'MOZ_NO_REMOTE': '1', 11:20:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:20:52 INFO - 'NO_EM_RESTART': '1', 11:20:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:20:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:20:52 INFO - 'PWD': '/builds/slave/test', 11:20:52 INFO - 'SHELL': '/bin/bash', 11:20:52 INFO - 'SHLVL': '1', 11:20:52 INFO - 'TERM': 'linux', 11:20:52 INFO - 'TMOUT': '86400', 11:20:52 INFO - 'USER': 'cltbld', 11:20:52 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1505839810.393748-2053307589', 11:20:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:20:52 INFO - '_': '/tools/buildbot/bin/python'} 11:20:53 INFO - Ignoring indexes: http://pypi.python.org/simple/ 11:20:53 INFO - Downloading/unpacking pip>=1.5 11:20:53 INFO - Running setup.py egg_info for package pip 11:20:53 INFO - warning: no files found matching 'pip/cacert.pem' 11:20:53 INFO - warning: no files found matching '*.html' under directory 'docs' 11:20:53 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 11:20:53 INFO - no previously-included directories found matching 'docs/_build/_sources' 11:20:53 INFO - Installing collected packages: pip 11:20:53 INFO - Found existing installation: pip 1.1 11:20:53 INFO - Uninstalling pip: 11:20:53 INFO - Successfully uninstalled pip 11:20:53 INFO - Running setup.py install for pip 11:20:53 INFO - warning: no files found matching 'pip/cacert.pem' 11:20:53 INFO - warning: no files found matching '*.html' under directory 'docs' 11:20:53 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 11:20:53 INFO - no previously-included directories found matching 'docs/_build/_sources' 11:20:53 INFO - Installing pip script to /builds/slave/test/build/venv/bin 11:20:53 INFO - Installing pip2.7 script to /builds/slave/test/build/venv/bin 11:20:53 INFO - Installing pip2 script to /builds/slave/test/build/venv/bin 11:20:53 INFO - Successfully installed pip 11:20:53 INFO - Cleaning up... 11:20:53 INFO - Return code: 0 11:20:53 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 11:20:53 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')]} 11:20:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:20:53 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')]} 11:20:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:20:53 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 0xa701f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc39a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xddca60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xde0090>, '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 0xde0d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xddaf90>, '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': 'af724c981e2a0f424dbabf99000001e7-1505839810.393748-2053307589', '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 11:20:53 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 11:20:53 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 11:20:53 INFO - Using env: {'DISPLAY': ':0', 11:20:53 INFO - 'HOME': '/home/cltbld', 11:20:53 INFO - 'LANG': 'en_US.UTF-8', 11:20:53 INFO - 'LANGUAGE': 'en_US:en', 11:20:53 INFO - 'LOGNAME': 'cltbld', 11:20:53 INFO - 'MAIL': '/var/mail/cltbld', 11:20:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:20:53 INFO - 'MOZ_NO_REMOTE': '1', 11:20:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:20:53 INFO - 'NO_EM_RESTART': '1', 11:20:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:20:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:20:53 INFO - 'PWD': '/builds/slave/test', 11:20:53 INFO - 'SHELL': '/bin/bash', 11:20:53 INFO - 'SHLVL': '1', 11:20:53 INFO - 'TERM': 'linux', 11:20:53 INFO - 'TMOUT': '86400', 11:20:53 INFO - 'USER': 'cltbld', 11:20:53 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1505839810.393748-2053307589', 11:20:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:20:53 INFO - '_': '/tools/buildbot/bin/python'} 11:20:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:20:53 INFO - Downloading/unpacking psutil>=3.1.1 11:20: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 11:20: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 11:20: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 11:20: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 11:20:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 11:20:54 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:20:54 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:20:55 INFO - Installing collected packages: psutil 11:20:55 INFO - Running setup.py install for psutil 11:20:55 INFO - building 'psutil._psutil_linux' extension 11:20:55 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 11:20:56 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 11:20:56 INFO - building 'psutil._psutil_posix' extension 11:20:56 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 11:20:56 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 11:20:56 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:20:56 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:20:56 INFO - Successfully installed psutil 11:20:56 INFO - Cleaning up... 11:20:56 INFO - Return code: 0 11:20:56 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 11:20:56 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')]} 11:20:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:20:56 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')]} 11:20:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:20:56 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 0xa701f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc39a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xddca60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xde0090>, '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 0xde0d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xddaf90>, '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': 'af724c981e2a0f424dbabf99000001e7-1505839810.393748-2053307589', '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 11:20:56 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 11:20:56 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 11:20:56 INFO - Using env: {'DISPLAY': ':0', 11:20:56 INFO - 'HOME': '/home/cltbld', 11:20:56 INFO - 'LANG': 'en_US.UTF-8', 11:20:56 INFO - 'LANGUAGE': 'en_US:en', 11:20:56 INFO - 'LOGNAME': 'cltbld', 11:20:56 INFO - 'MAIL': '/var/mail/cltbld', 11:20:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:20:56 INFO - 'MOZ_NO_REMOTE': '1', 11:20:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:20:56 INFO - 'NO_EM_RESTART': '1', 11:20:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:20:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:20:56 INFO - 'PWD': '/builds/slave/test', 11:20:56 INFO - 'SHELL': '/bin/bash', 11:20:56 INFO - 'SHLVL': '1', 11:20:56 INFO - 'TERM': 'linux', 11:20:56 INFO - 'TMOUT': '86400', 11:20:56 INFO - 'USER': 'cltbld', 11:20:56 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1505839810.393748-2053307589', 11:20:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:20:56 INFO - '_': '/tools/buildbot/bin/python'} 11:20:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:20:56 INFO - Downloading/unpacking mozsystemmonitor==0.3 11:20:56 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 11:20:56 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 11:20:56 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 11:20:56 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 11:20:57 INFO - Downloading mozsystemmonitor-0.3.tar.gz 11:20:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 11:20:57 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 11:20:57 INFO - Installing collected packages: mozsystemmonitor 11:20:57 INFO - Running setup.py install for mozsystemmonitor 11:20:57 INFO - Successfully installed mozsystemmonitor 11:20:57 INFO - Cleaning up... 11:20:58 INFO - Return code: 0 11:20:58 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 11:20:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:20:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:20:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:20:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:20:58 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 0xa701f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc39a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xddca60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xde0090>, '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 0xde0d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xddaf90>, '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': 'af724c981e2a0f424dbabf99000001e7-1505839810.393748-2053307589', '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 11:20:58 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 11:20:58 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 11:20:58 INFO - Using env: {'DISPLAY': ':0', 11:20:58 INFO - 'HOME': '/home/cltbld', 11:20:58 INFO - 'LANG': 'en_US.UTF-8', 11:20:58 INFO - 'LANGUAGE': 'en_US:en', 11:20:58 INFO - 'LOGNAME': 'cltbld', 11:20:58 INFO - 'MAIL': '/var/mail/cltbld', 11:20:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:20:58 INFO - 'MOZ_NO_REMOTE': '1', 11:20:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:20:58 INFO - 'NO_EM_RESTART': '1', 11:20:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:20:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:20:58 INFO - 'PWD': '/builds/slave/test', 11:20:58 INFO - 'SHELL': '/bin/bash', 11:20:58 INFO - 'SHLVL': '1', 11:20:58 INFO - 'TERM': 'linux', 11:20:58 INFO - 'TMOUT': '86400', 11:20:58 INFO - 'USER': 'cltbld', 11:20:58 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1505839810.393748-2053307589', 11:20:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:20:58 INFO - '_': '/tools/buildbot/bin/python'} 11:20:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:20:58 INFO - Downloading/unpacking jsonschema==2.5.1 11:20:58 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 11:20:58 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 11:20:58 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 11:20:58 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 11:20:59 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 11:20:59 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 11:20:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:20:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:20:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:20:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:20:59 INFO - Downloading functools32-3.2.3-2.tar.gz 11:20:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 11:20:59 INFO - warning: no files found matching '*.txt' 11:20:59 INFO - no previously-included directories found matching 'build' 11:20:59 INFO - no previously-included directories found matching 'dist' 11:20:59 INFO - no previously-included directories found matching '.git*' 11:20:59 INFO - Installing collected packages: jsonschema, functools32 11:20:59 INFO - Running setup.py install for functools32 11:20:59 INFO - warning: no files found matching '*.txt' 11:20:59 INFO - no previously-included directories found matching 'build' 11:20:59 INFO - no previously-included directories found matching 'dist' 11:20:59 INFO - no previously-included directories found matching '.git*' 11:20:59 INFO - Successfully installed jsonschema functools32 11:20:59 INFO - Cleaning up... 11:20:59 INFO - Return code: 0 11:20:59 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 11:20:59 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')]} 11:20:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:20:59 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')]} 11:20:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:20:59 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 0xa701f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc39a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xddca60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xde0090>, '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 0xde0d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xddaf90>, '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': 'af724c981e2a0f424dbabf99000001e7-1505839810.393748-2053307589', '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 11:20:59 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 11:20:59 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 11:20:59 INFO - Using env: {'DISPLAY': ':0', 11:20:59 INFO - 'HOME': '/home/cltbld', 11:20:59 INFO - 'LANG': 'en_US.UTF-8', 11:20:59 INFO - 'LANGUAGE': 'en_US:en', 11:20:59 INFO - 'LOGNAME': 'cltbld', 11:20:59 INFO - 'MAIL': '/var/mail/cltbld', 11:20:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:20:59 INFO - 'MOZ_NO_REMOTE': '1', 11:20:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:20:59 INFO - 'NO_EM_RESTART': '1', 11:20:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:20:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:20:59 INFO - 'PWD': '/builds/slave/test', 11:20:59 INFO - 'SHELL': '/bin/bash', 11:20:59 INFO - 'SHLVL': '1', 11:20:59 INFO - 'TERM': 'linux', 11:20:59 INFO - 'TMOUT': '86400', 11:20:59 INFO - 'USER': 'cltbld', 11:20:59 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1505839810.393748-2053307589', 11:20:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:20:59 INFO - '_': '/tools/buildbot/bin/python'} 11:20:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:20:59 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 11:20:59 INFO - Cleaning up... 11:20:59 INFO - Return code: 0 11:20:59 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 11:20:59 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')]} 11:20:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:20:59 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')]} 11:20:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:20:59 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 0xa701f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc39a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xddca60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xde0090>, '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 0xde0d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xddaf90>, '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': 'af724c981e2a0f424dbabf99000001e7-1505839810.393748-2053307589', '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 11:20:59 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 11:20:59 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 11:20:59 INFO - Using env: {'DISPLAY': ':0', 11:20:59 INFO - 'HOME': '/home/cltbld', 11:20:59 INFO - 'LANG': 'en_US.UTF-8', 11:20:59 INFO - 'LANGUAGE': 'en_US:en', 11:20:59 INFO - 'LOGNAME': 'cltbld', 11:20:59 INFO - 'MAIL': '/var/mail/cltbld', 11:20:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:20:59 INFO - 'MOZ_NO_REMOTE': '1', 11:20:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:20:59 INFO - 'NO_EM_RESTART': '1', 11:20:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:20:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:20:59 INFO - 'PWD': '/builds/slave/test', 11:20:59 INFO - 'SHELL': '/bin/bash', 11:20:59 INFO - 'SHLVL': '1', 11:20:59 INFO - 'TERM': 'linux', 11:20:59 INFO - 'TMOUT': '86400', 11:20:59 INFO - 'USER': 'cltbld', 11:20:59 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1505839810.393748-2053307589', 11:20:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:20:59 INFO - '_': '/tools/buildbot/bin/python'} 11:21:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:21:00 INFO - Downloading/unpacking blobuploader==1.2.4 11:21:00 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 11:21:00 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 11:21:00 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 11:21:00 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 11:21:01 INFO - Downloading blobuploader-1.2.4.tar.gz 11:21:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 11:21:01 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 11:21:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:21:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:21:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:21:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:21:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 11:21:01 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 11:21:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:21:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:21:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:21:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:21:01 INFO - Downloading docopt-0.6.1.tar.gz 11:21:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 11:21:01 INFO - Installing collected packages: blobuploader, requests, docopt 11:21:01 INFO - Running setup.py install for blobuploader 11:21:01 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 11:21:01 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 11:21:01 INFO - Running setup.py install for requests 11:21:02 INFO - Running setup.py install for docopt 11:21:02 INFO - Successfully installed blobuploader requests docopt 11:21:02 INFO - Cleaning up... 11:21:02 INFO - Return code: 0 11:21:02 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:21:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:21:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:21:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:21:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:21:02 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 0xa701f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc39a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xddca60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xde0090>, '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 0xde0d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xddaf90>, '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': 'af724c981e2a0f424dbabf99000001e7-1505839810.393748-2053307589', '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 11:21:02 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 11:21:02 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 11:21:02 INFO - Using env: {'DISPLAY': ':0', 11:21:02 INFO - 'HOME': '/home/cltbld', 11:21:02 INFO - 'LANG': 'en_US.UTF-8', 11:21:02 INFO - 'LANGUAGE': 'en_US:en', 11:21:02 INFO - 'LOGNAME': 'cltbld', 11:21:02 INFO - 'MAIL': '/var/mail/cltbld', 11:21:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:21:02 INFO - 'MOZ_NO_REMOTE': '1', 11:21:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:21:02 INFO - 'NO_EM_RESTART': '1', 11:21:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:21:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:21:02 INFO - 'PWD': '/builds/slave/test', 11:21:02 INFO - 'SHELL': '/bin/bash', 11:21:02 INFO - 'SHLVL': '1', 11:21:02 INFO - 'TERM': 'linux', 11:21:02 INFO - 'TMOUT': '86400', 11:21:02 INFO - 'USER': 'cltbld', 11:21:02 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1505839810.393748-2053307589', 11:21:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:21:02 INFO - '_': '/tools/buildbot/bin/python'} 11:21:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:21:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:21:02 INFO - Running setup.py (path:/tmp/pip-GGvDUj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:21:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:21:02 INFO - Running setup.py (path:/tmp/pip-5ytfL1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:21:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:21:02 INFO - Running setup.py (path:/tmp/pip-hr812K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:21:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:21:02 INFO - Running setup.py (path:/tmp/pip-gymDC_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:21:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:21:02 INFO - Running setup.py (path:/tmp/pip-Yr0272-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:21:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:21:03 INFO - Running setup.py (path:/tmp/pip-5ed8LX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:21:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:21:03 INFO - Running setup.py (path:/tmp/pip-76m32s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:21:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:21:03 INFO - Running setup.py (path:/tmp/pip-WhCPTo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:21:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:21:03 INFO - Running setup.py (path:/tmp/pip-lKd0lp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:21:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:21:03 INFO - Running setup.py (path:/tmp/pip-vtcmvX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:21:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:21:03 INFO - Running setup.py (path:/tmp/pip-ZikySK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:21:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:21:03 INFO - Running setup.py (path:/tmp/pip-VwSi1M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:21:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:21:03 INFO - Running setup.py (path:/tmp/pip-IavcoW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:21:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:21:03 INFO - Running setup.py (path:/tmp/pip-_qF3tP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:21:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:21:03 INFO - Running setup.py (path:/tmp/pip-KQFcl8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:21:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:21:03 INFO - Running setup.py (path:/tmp/pip-PUyfIP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:21:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:21:03 INFO - Running setup.py (path:/tmp/pip-317hHI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:21:03 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 11:21:03 INFO - Running setup.py install for manifestparser 11:21:03 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 11:21:03 INFO - Running setup.py install for mozcrash 11:21:04 INFO - Running setup.py install for mozdebug 11:21:04 INFO - Running setup.py install for mozdevice 11:21:04 INFO - Installing dm script to /builds/slave/test/build/venv/bin 11:21:04 INFO - Running setup.py install for mozfile 11:21:04 INFO - Running setup.py install for mozhttpd 11:21:04 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 11:21:04 INFO - Running setup.py install for mozinfo 11:21:04 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 11:21:04 INFO - Running setup.py install for mozInstall 11:21:04 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 11:21:04 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 11:21:04 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 11:21:04 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 11:21:04 INFO - Running setup.py install for mozleak 11:21:04 INFO - Running setup.py install for mozlog 11:21:04 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 11:21:04 INFO - Running setup.py install for moznetwork 11:21:04 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 11:21:04 INFO - Running setup.py install for mozprocess 11:21:05 INFO - Running setup.py install for mozprofile 11:21:05 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 11:21:05 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 11:21:05 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 11:21:05 INFO - Running setup.py install for mozrunner 11:21:05 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 11:21:05 INFO - Running setup.py install for mozscreenshot 11:21:05 INFO - Running setup.py install for moztest 11:21:05 INFO - Running setup.py install for mozversion 11:21:05 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 11:21:05 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 11:21:05 INFO - Cleaning up... 11:21:05 INFO - Return code: 0 11:21:05 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:21:05 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')]} 11:21:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:21:05 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')]} 11:21:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:21:05 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 0xa701f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc39a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xddca60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xde0090>, '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 0xde0d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xddaf90>, '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': 'af724c981e2a0f424dbabf99000001e7-1505839810.393748-2053307589', '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 11:21:05 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 11:21:05 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 11:21:05 INFO - Using env: {'DISPLAY': ':0', 11:21:05 INFO - 'HOME': '/home/cltbld', 11:21:05 INFO - 'LANG': 'en_US.UTF-8', 11:21:05 INFO - 'LANGUAGE': 'en_US:en', 11:21:05 INFO - 'LOGNAME': 'cltbld', 11:21:05 INFO - 'MAIL': '/var/mail/cltbld', 11:21:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:21:05 INFO - 'MOZ_NO_REMOTE': '1', 11:21:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:21:05 INFO - 'NO_EM_RESTART': '1', 11:21:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:21:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:21:05 INFO - 'PWD': '/builds/slave/test', 11:21:05 INFO - 'SHELL': '/bin/bash', 11:21:05 INFO - 'SHLVL': '1', 11:21:05 INFO - 'TERM': 'linux', 11:21:05 INFO - 'TMOUT': '86400', 11:21:05 INFO - 'USER': 'cltbld', 11:21:05 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1505839810.393748-2053307589', 11:21:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:21:05 INFO - '_': '/tools/buildbot/bin/python'} 11:21:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:21:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:21:05 INFO - Running setup.py (path:/tmp/pip-zizu5X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:21:05 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)) 11:21:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:21:05 INFO - Running setup.py (path:/tmp/pip-rrgJjQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:21:05 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)) 11:21:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:21:05 INFO - Running setup.py (path:/tmp/pip-EkyFbc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:21:06 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)) 11:21:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:21:06 INFO - Running setup.py (path:/tmp/pip-jtXNqE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:21:06 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)) 11:21:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:21:06 INFO - Running setup.py (path:/tmp/pip-393LSb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:21:06 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)) 11:21:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:21:06 INFO - Running setup.py (path:/tmp/pip-lY7sLS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:21:06 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)) 11:21:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:21:06 INFO - Running setup.py (path:/tmp/pip-gEy68T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:21:06 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)) 11:21:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:21:06 INFO - Running setup.py (path:/tmp/pip-RUgpB4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:21:06 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)) 11:21:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:21:06 INFO - Running setup.py (path:/tmp/pip-DZZARb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:21:06 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)) 11:21:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:21:06 INFO - Running setup.py (path:/tmp/pip-TFYe4k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:21:06 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)) 11:21:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:21:06 INFO - Running setup.py (path:/tmp/pip-5wsHVC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:21:06 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)) 11:21:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:21:06 INFO - Running setup.py (path:/tmp/pip-GQ9KQo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:21:06 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)) 11:21:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:21:06 INFO - Running setup.py (path:/tmp/pip-mUnZ7V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:21:06 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)) 11:21:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:21:06 INFO - Running setup.py (path:/tmp/pip-utnxN9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:21:06 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)) 11:21:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:21:06 INFO - Running setup.py (path:/tmp/pip-H36ZTi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:21:06 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)) 11:21:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:21:06 INFO - Running setup.py (path:/tmp/pip-Of1B_u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:21:06 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)) 11:21:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:21:06 INFO - Running setup.py (path:/tmp/pip-lOHlE4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:21:07 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)) 11:21:07 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)) 11:21:07 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)) 11:21:07 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)) 11:21:07 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)) 11:21:07 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)) 11:21:07 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)) 11:21:07 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:21:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:21:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:21:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:21:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:21:08 INFO - Downloading blessings-1.6.tar.gz 11:21:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 11:21:08 INFO - Installing collected packages: blessings 11:21:08 INFO - Running setup.py install for blessings 11:21:08 INFO - Successfully installed blessings 11:21:08 INFO - Cleaning up... 11:21:08 INFO - Return code: 0 11:21:08 INFO - Done creating virtualenv /builds/slave/test/build/venv. 11:21:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:21:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:21:08 INFO - Reading from file tmpfile_stdout 11:21:08 INFO - Current package versions: 11:21:08 INFO - argparse == 1.2.1 11:21:08 INFO - blessings == 1.6 11:21:08 INFO - blobuploader == 1.2.4 11:21:08 INFO - docopt == 0.6.1 11:21:08 INFO - functools32 == 3.2.3-2 11:21:08 INFO - jsonschema == 2.5.1 11:21:08 INFO - manifestparser == 1.1 11:21:08 INFO - mozInstall == 1.13 11:21:08 INFO - mozcrash == 1.0 11:21:08 INFO - mozdebug == 0.1 11:21:08 INFO - mozdevice == 0.51 11:21:08 INFO - mozfile == 1.2 11:21:08 INFO - mozhttpd == 0.7 11:21:08 INFO - mozinfo == 0.10 11:21:08 INFO - mozleak == 0.1 11:21:08 INFO - mozlog == 3.5 11:21:08 INFO - moznetwork == 0.27 11:21:08 INFO - mozprocess == 0.25 11:21:08 INFO - mozprofile == 0.28 11:21:08 INFO - mozrunner == 6.13 11:21:08 INFO - mozscreenshot == 0.1 11:21:08 INFO - mozsystemmonitor == 0.3 11:21:08 INFO - moztest == 0.8 11:21:08 INFO - mozversion == 1.4 11:21:08 INFO - psutil == 3.1.1 11:21:08 INFO - requests == 1.2.3 11:21:08 INFO - wsgiref == 0.1.2 11:21:08 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:21:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:21:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:21:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:21:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:21:08 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 0xa701f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc39a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xddca60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xde0090>, '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 0xde0d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xddaf90>, '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': 'af724c981e2a0f424dbabf99000001e7-1505839810.393748-2053307589', '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 11:21:08 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 11:21:08 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 11:21:08 INFO - Using env: {'DISPLAY': ':0', 11:21:08 INFO - 'HOME': '/home/cltbld', 11:21:08 INFO - 'LANG': 'en_US.UTF-8', 11:21:08 INFO - 'LANGUAGE': 'en_US:en', 11:21:08 INFO - 'LOGNAME': 'cltbld', 11:21:08 INFO - 'MAIL': '/var/mail/cltbld', 11:21:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:21:08 INFO - 'MOZ_NO_REMOTE': '1', 11:21:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:21:08 INFO - 'NO_EM_RESTART': '1', 11:21:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:21:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:21:08 INFO - 'PWD': '/builds/slave/test', 11:21:08 INFO - 'SHELL': '/bin/bash', 11:21:08 INFO - 'SHLVL': '1', 11:21:08 INFO - 'TERM': 'linux', 11:21:08 INFO - 'TMOUT': '86400', 11:21:08 INFO - 'USER': 'cltbld', 11:21:08 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1505839810.393748-2053307589', 11:21:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:21:08 INFO - '_': '/tools/buildbot/bin/python'} 11:21:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:21:08 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)) 11:21:08 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)) 11:21:08 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)) 11:21:08 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)) 11:21:08 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)) 11:21:08 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)) 11:21:08 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)) 11:21:08 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)) 11:21:08 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)) 11:21:08 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 11:21:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:21:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:21:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:21:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:21:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 11:21:10 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)) 11:21:10 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)) 11:21:10 INFO - Installing collected packages: simplejson 11:21:10 INFO - Running setup.py install for simplejson 11:21:10 INFO - building 'simplejson._speedups' extension 11:21:10 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 11:21:10 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 11:21:11 INFO - Successfully installed simplejson 11:21:11 INFO - Cleaning up... 11:21:11 INFO - Return code: 0 11:21:11 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 11:21:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:21:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:21:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:21:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:21:11 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 0xa701f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc39a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xddca60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xde0090>, '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 0xde0d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xddaf90>, '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': 'af724c981e2a0f424dbabf99000001e7-1505839810.393748-2053307589', '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 11:21:11 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 11:21:11 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 11:21:11 INFO - Using env: {'DISPLAY': ':0', 11:21:11 INFO - 'HOME': '/home/cltbld', 11:21:11 INFO - 'LANG': 'en_US.UTF-8', 11:21:11 INFO - 'LANGUAGE': 'en_US:en', 11:21:11 INFO - 'LOGNAME': 'cltbld', 11:21:11 INFO - 'MAIL': '/var/mail/cltbld', 11:21:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:21:11 INFO - 'MOZ_NO_REMOTE': '1', 11:21:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:21:11 INFO - 'NO_EM_RESTART': '1', 11:21:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:21:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:21:11 INFO - 'PWD': '/builds/slave/test', 11:21:11 INFO - 'SHELL': '/bin/bash', 11:21:11 INFO - 'SHLVL': '1', 11:21:11 INFO - 'TERM': 'linux', 11:21:11 INFO - 'TMOUT': '86400', 11:21:11 INFO - 'USER': 'cltbld', 11:21:11 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1505839810.393748-2053307589', 11:21:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:21:11 INFO - '_': '/tools/buildbot/bin/python'} 11:21:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:21:11 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 11:21:11 INFO - Cleaning up... 11:21:11 INFO - Return code: 0 11:21:11 INFO - Running post-action listener: _resource_record_post_action 11:21:11 INFO - Running post-action listener: _start_resource_monitoring 11:21:11 INFO - Starting resource monitoring. 11:21:11 INFO - [mozharness: 2017-09-19 18:21:11.392298Z] Finished create-virtualenv step (success) 11:21:11 INFO - [mozharness: 2017-09-19 18:21:11.393388Z] Running install step. 11:21:11 INFO - Running pre-action listener: _resource_record_pre_action 11:21:11 INFO - Running main action method: install 11:21:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:21:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:21:11 INFO - Reading from file tmpfile_stdout 11:21:11 INFO - Detecting whether we're running mozinstall >=1.0... 11:21:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 11:21:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 11:21:11 INFO - Reading from file tmpfile_stdout 11:21:11 INFO - Output received: 11:21:11 INFO - Usage: mozinstall [options] installer 11:21:11 INFO - Options: 11:21:11 INFO - -h, --help show this help message and exit 11:21:11 INFO - -d DEST, --destination=DEST 11:21:11 INFO - Directory to install application into. [default: 11:21:11 INFO - "/builds/slave/test"] 11:21:11 INFO - --app=APP Application being installed. [default: firefox] 11:21:11 INFO - mkdir: /builds/slave/test/build/application 11:21:11 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'] 11:21:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 11:21:29 INFO - Reading from file tmpfile_stdout 11:21:29 INFO - Output received: 11:21:29 INFO - /builds/slave/test/build/application/firefox/firefox 11:21:29 INFO - Running post-action listener: _resource_record_post_action 11:21:29 INFO - [mozharness: 2017-09-19 18:21:29.514012Z] Finished install step (success) 11:21:29 INFO - [mozharness: 2017-09-19 18:21:29.514262Z] Running setup-mitmproxy step. 11:21:29 INFO - Running pre-action listener: _resource_record_pre_action 11:21:29 INFO - Running main action method: setup_mitmproxy 11:21:29 INFO - Skipping: mitmproxy is not required 11:21:29 INFO - Running post-action listener: _resource_record_post_action 11:21:29 INFO - [mozharness: 2017-09-19 18:21:29.515382Z] Finished setup-mitmproxy step (success) 11:21:29 INFO - [mozharness: 2017-09-19 18:21:29.515602Z] Running run-tests step. 11:21:29 INFO - Running pre-action listener: _resource_record_pre_action 11:21:29 INFO - Running pre-action listener: _set_gcov_prefix 11:21:29 INFO - Running main action method: run_tests 11:21:29 WARNING - Try message not found. 11:21:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 11:21:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 11:21:29 INFO - Python 2.7.3 11:21:29 INFO - Return code: 0 11:21:29 INFO - grabbing minidump binary from tooltool 11:21:29 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')]} 11:21:29 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 0xde0090>, '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 0xde0d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xddaf90>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 11:21:29 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 11:21:29 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 11:21:29 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 11:21:29 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 11:21:29 INFO - Return code: 0 11:21:29 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 11:21:29 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 11:21:29 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 11:21:29 INFO - ENV: RUST_BACKTRACE is now full 11:21:29 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 11:21:29 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 11:21:29 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/L7l39DLCQeO5S_9KbepNFA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-020', '--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 11:21:29 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/L7l39DLCQeO5S_9KbepNFA/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-020 --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 11:21:29 INFO - Using env: {'DISPLAY': ':0', 11:21:29 INFO - 'HOME': '/home/cltbld', 11:21:29 INFO - 'LANG': 'en_US.UTF-8', 11:21:29 INFO - 'LANGUAGE': 'en_US:en', 11:21:29 INFO - 'LOGNAME': 'cltbld', 11:21:29 INFO - 'MAIL': '/var/mail/cltbld', 11:21:29 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:21:29 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 11:21:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:21:29 INFO - 'MOZ_NO_REMOTE': '1', 11:21:29 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:21:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:21:29 INFO - 'NO_EM_RESTART': '1', 11:21:29 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:21:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:21:29 INFO - 'PWD': '/builds/slave/test', 11:21:29 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:21:29 INFO - 'RUST_BACKTRACE': 'full', 11:21:29 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 11:21:29 INFO - 'SHELL': '/bin/bash', 11:21:29 INFO - 'SHLVL': '1', 11:21:29 INFO - 'TERM': 'linux', 11:21:29 INFO - 'TMOUT': '86400', 11:21:29 INFO - 'USER': 'cltbld', 11:21:29 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1505839810.393748-2053307589', 11:21:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:21:29 INFO - '_': '/tools/buildbot/bin/python'} 11:21:29 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/L7l39DLCQeO5S_9KbepNFA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-020', '--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 11:21:30 INFO - mozversion application_buildid: 20170919173329 11:21:30 INFO - mozversion application_changeset: ba69e294fc80f23d54fc68050f1b7d63d341aa9c 11:21:30 INFO - mozversion application_display_name: Nightly 11:21:30 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 11:21:30 INFO - mozversion application_name: Firefox 11:21:30 INFO - mozversion application_remotingname: firefox 11:21:30 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 11:21:30 INFO - mozversion application_vendor: Mozilla 11:21:30 INFO - mozversion application_version: 57.0a1 11:21:30 INFO - mozversion platform_buildid: 20170919173329 11:21:30 INFO - mozversion platform_changeset: ba69e294fc80f23d54fc68050f1b7d63d341aa9c 11:21:30 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 11:21:30 INFO - mozversion platform_version: 57.0a1 11:21:30 INFO - using testdate: 1505845290 11:21:30 INFO - actual date: 1505845290 11:21:30 INFO - starting webserver on 'localhost:51243' 11:21:30 INFO - SUITE-START | Running 2 tests 11:21:30 INFO - TEST-START | dromaeo_css 11:21:30 INFO - Initialising browser for dromaeo_css test... 11:21:30 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:51243/getInfo.html -profile /tmp/tmp3UY4wh/profile 11:21:30 INFO - TEST-INFO | started process 3536 (/builds/slave/test/build/application/firefox/firefox http://localhost:51243/getInfo.html) 11:21:39 INFO - TEST-INFO | 3536: exit 0 11:21:39 INFO - Browser initialized. 11:21:39 INFO - Running cycle 1/1 for dromaeo_css test... 11:21:39 INFO - Using env: {'DISPLAY': ':0', 11:21:39 INFO - 'HOME': '/home/cltbld', 11:21:39 INFO - 'JSGC_DISABLE_POISONING': '1', 11:21:39 INFO - 'LANG': 'en_US.UTF-8', 11:21:39 INFO - 'LANGUAGE': 'en_US:en', 11:21:39 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 11:21:39 INFO - 'LOGNAME': 'cltbld', 11:21:39 INFO - 'MAIL': '/var/mail/cltbld', 11:21:39 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:21:39 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 11:21:39 INFO - 'MOZ_CRASHREPORTER': '1', 11:21:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:21:39 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 11:21:39 INFO - 'MOZ_NO_REMOTE': '1', 11:21:39 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:21:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:21:39 INFO - 'NO_EM_RESTART': '1', 11:21:39 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:21:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:21:39 INFO - 'PWD': '/builds/slave/test', 11:21:39 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:21:39 INFO - 'RUST_BACKTRACE': 'full', 11:21:39 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 11:21:39 INFO - 'SHELL': '/bin/bash', 11:21:39 INFO - 'SHLVL': '1', 11:21:39 INFO - 'STYLO_FORCE_DISABLED': '1', 11:21:39 INFO - 'TERM': 'linux', 11:21:39 INFO - 'TMOUT': '86400', 11:21:39 INFO - 'USER': 'cltbld', 11:21:39 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1505839810.393748-2053307589', 11:21:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:21:39 INFO - '_': '/tools/buildbot/bin/python'} 11:21:39 INFO - TEST-INFO | started process 3774 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp3UY4wh/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 11:21:40 INFO - PID 3774 | 11:21:40 INFO - PID 3774 | (/builds/slave/test/build/application/firefox/firefox:3823): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 11:21:40 INFO - PID 3774 | 11:21:50 INFO - PID 3774 | RSS: Main: 154263552 11:21:50 INFO - PID 3774 | 11:24:47 INFO - PID 3774 | Cycle 1(1): loaded http://localhost:51243/tests/dromaeo/cssquery-dojo.html (next: http://localhost:51243/tests/dromaeo/cssquery-ext.html) 11:24:48 INFO - PID 3774 | RSS: Main: 155365376 11:24:48 INFO - PID 3774 | 11:27:50 INFO - PID 3774 | Cycle 1(1): loaded http://localhost:51243/tests/dromaeo/cssquery-ext.html (next: http://localhost:51243/tests/dromaeo/cssquery-jquery.html) 11:27:51 INFO - PID 3774 | RSS: Main: 154673152 11:27:51 INFO - PID 3774 | 11:30:52 INFO - PID 3774 | Cycle 1(1): loaded http://localhost:51243/tests/dromaeo/cssquery-jquery.html (next: http://localhost:51243/tests/dromaeo/cssquery-mootools.html) 11:30:53 INFO - PID 3774 | RSS: Main: 156631040 11:30:53 INFO - PID 3774 | 11:33:55 INFO - PID 3774 | Cycle 1(1): loaded http://localhost:51243/tests/dromaeo/cssquery-mootools.html (next: http://localhost:51243/tests/dromaeo/cssquery-prototype.html) 11:33:55 INFO - PID 3774 | RSS: Main: 155799552 11:33:55 INFO - PID 3774 | 11:36:58 INFO - PID 3774 | Cycle 1(1): loaded http://localhost:51243/tests/dromaeo/cssquery-prototype.html (next: http://localhost:51243/tests/dromaeo/cssquery-yui.html) 11:36:59 INFO - PID 3774 | RSS: Main: 154718208 11:36:59 INFO - PID 3774 | 11:40:01 INFO - PID 3774 | Cycle 1(1): loaded http://localhost:51243/tests/dromaeo/cssquery-yui.html (next: http://localhost:51243/tests/dromaeo/cssquery-dojo.html) 11:40:01 INFO - PID 3774 | RSS: Main: 158830592 11:40:01 INFO - PID 3774 | 11:40:01 INFO - PID 3774 | __start_tp_report 11:40:01 INFO - PID 3774 | _x_x_mozilla_page_load 11:40:01 INFO - PID 3774 | _x_x_mozilla_page_load_details 11:40:01 INFO - PID 3774 | |i|pagename|runs| 11:40:01 INFO - PID 3774 | |0;dojo.html;3089.8146111233327;3107.658157602662;3127.687231276871;3130.639976402713;3155.1796532901453;6090.116933044706;6306.495480361566;6307.621542707435;6331.873362532747;6337.049442583615;6123.785667501638;6234.127222188886;6354.078658594501;6367.554271201017;6408.102865598808;5786.103154011135;5835.241418615574;5845.415458454163;5858.7949421770245;5873.177755114288;5700.287464066992;5752.511036561877;5847.415258474161;5879.176915231871;5893.440123188312;5740.1102829061565;5813.854653633651;5818.243628328311;5844.766209351621;5905.911411328833;5675.51758100562;5763.279590051244;5772.797952071657;5774.566907481913;5792.82621521355;5680.943190568083;5739.655620662774;5753;5770.509506691937;5800.332961709415;6260.280067792217;6272.090546870678;6281.057841323793;6283.968580157116;6396.168498095264;6497.057926600616;6630.966845165792;6634.336566343375;6639.9044157713915;6644.402003819631;6650.334966503359;6656.267810540837;6662.766803161866;6662.967240077795;6758.12144421227;6291.402316779899;6291.653959032252;6301.243850737895;6337.33457986914;6370.90443643341;6885.827854303682;6915.723371065202;6929.480288978347;7026.051483049825;7031.472639552054;6403.839904002344;6627.801165965029;6639.668016599151;6640.335966403321;6732.192136943598;6619.536632435684;6691.26396096429;6750.32496750321;6757.391834734897;6762.83092922671;6758.324167583202;6773.254941956381;6780.491463140284;6781.6609169541325;6783.728650853911;6722.529422940347;6728.327167283331;6729.8654026919185;6807.897881531781;6827.214870289881;5162.97418512905;5225.007248622749;5290.894182116336;5324.361076670824;5353.009693206769;4532.614727748179;4553.021100463417;4600.309953506934;4611.469680986663;4689.320048592935;5736.713164341766;5792.768289268466;5809.390014048548;5812.3025236971835;5813.680247586339;6656.201255849232;6727.091842601186;6758.459323254128;6838.452923766087;6856.074429951893;5550.361708403505;5657.377688454267;5721.141828725725;5801.100829371369;5824.970875145597;5791.884162316815;5837.241158649434;5850.297964244318;5860.853478663067;5861.062230043172;6285.622862628257;6377.617342959437;6385.201849768779;6442.613443193423;6521.315261897527;6539.738410463528;6583.341665833378;6600.075989361397;6608.768693095719;6615.702293396905;6365.904511432424;6378.712957916812;6378.90431643535;6379.266384365857;6381.8085457436355;6564.179477565304;6567.2447668518735;6571.901421478778;6629.966850165718;6741.865162696817;6823.215330236888;6838.247792742694;6908.827279318058;6918.5502942308585;6928.896066559107;6567.507436942153;6587.604743715392;6652.401283884474;6652.933470665232;6663.966680166568;6300.495960323255;6485.448736857231;6508.869822603616;6543.149390579194;6584.407403333723;6425.325340839145;6477.157969464128;6571.868562628816;6578.473722102316;6596.901046484402;6498.967505162633;6692.531522793358;6706.826305396438;6719.227288861648;6725.39471447572;6403.135576697086;6406.487481001415;6406.7431070132025;6503.674816259263;6509.283978762238 11:40:01 INFO - PID 3774 | |1;ext.html;857.0529564830858;875.098648392156;879.3385156211323;906.8503696890014;913.7258822353294;41133;41777.373339399936;41790.791046044804;41801;41958;38436;38555.807220963856;38580.228395432074;38601.42097868527;38663.22673546527;7244.348008679218;7296.087989001375;7324.230955749649;7325.560466372035;7363.631818409085;7228;7273.963630181842;7287.744928927488;7297;7302.087239095114;7190.173130090028;7866.724664636738;8083.757487275391;8123.390745694067;8127.512349259034;7996.800079997988;8057.395695322845;8072.757817265433;8079.717209897654;8085.231902969209;7865.370770338359;7889;7907.644156012936;7913.683452661887;7944.841103177904;37934.241315173545;38054.80972595119;38274.425883611766;38388.808055959824;38407.61592384068;3525.94711079334;3560.893173204782;3569.821508924543;3572.017695133833;3574.696150827183;32010.839945800355;32520.21138837363;32521.674783252336;32528.512072318936;32542.349153017043;5125.923111153335;5198;5207.401148867891;5224.9738751306;5256.474352564751;188840;189013;189368;189464.99999999863;189668;48100.75949620229;48112;48115;48349.274760878616;48452.27321590179;50061.74969125131;50151.24773128406;50393.24410133851;50431.243531347056;50447.74776126096;15779.368825247091;16052.839471605135;16053.919730401274;16060.357585696442;16072.11603361803;12989.350532473338;13152.21086734799;13175.341232938315;13205;13226.933865330611;13293.468261269634;13458.327083645778;13534.729305414034;13587.52443664467;13749.106308089942;5694.4659626466655;5751.728067413348;5763.481286684135;5782.624129431573;5798.82603521895;986.5412583148727;998.4558415663481;1008.8284991551307;1015.6546774096843;1029.8455231715302;22327.330180094625;22595.661065084038;22850;22957.196498122485;23402.64896026561;1091.8362245663054;1102.3220719257758;1110.5224753356135;1111.3276467737064;1127.4137448526885;12141.575044873387;12149.149559530924;12178.634640960785;12295.877041229653;12388.690282743004;218618;218749;220013;220846;221160;45783.5421645786;46961.76519117383;52295.47704522982;52340.47659523356;52841.207381889304;1461.3423959218394;1464.3337281536876;1471.3378979459071;1492.0749135536037;1494.215536843166;26995.05517306885;27203.7758300873;27262.591061134495;27567.724322756516;27813.582796258477;37204.813975929945;37368.81315593405;37433.25133497369;37451.81274093612;37458.6254137466;193561;193567;194222;194866;194988;32914.67085329212;33098.17254568655;33406.83296583501;33525.83237083799;33585.83207083949;41686;42705.57294427016;42986;43374.78312608417;43410.78294608507;31684.841575791972;31737.523937141425;31822.204444889063;32024.19939501438;32507.34985300328;31068.844655776575;31808.522872156474;31896.681033189372;32373.19067023343;32492.675073248964;36688.449673255454;36727.26545469129;36743;37065;37071.81464092662;31512.36975260528;31691.366172676877;31917.882874099294;32219;32497.187570310933;23480.530389391773;23627.763722363245;23655;23735.52528949446;24118.758812411652 11:40:01 INFO - PID 3774 | |2;jquery.html;566.4958187213381;574.8476653686771;576.167438052015;581.9214406055181;590.5541316306188;21872.343829685116;22724.091036358568;22733.77266227337;22744.43138921528;22763;24139;24218.75781242187;24538.509229815394;24567.262982110522;24730.134445294418;6598.571092878971;6787.4570034397375;6787.966060169692;6788.049673045753;6794.524383293171;6686.7993960181275;6732.057511948331;6764.154480689914;6777.76277830276;6791.252962174157;6332.841678958017;6614.603123812587;6621.867562648768;6622;6632.734690612394;6564.835879103037;6608.570442921219;6614;6614.404703576653;6616.603003819786;5915.260592425947;6115.082737589352;6133.1413602095745;6150.415710507495;6157.969210153965;27632.861835690896;27972.16083517498;27995.580066299022;28049.43901121966;28093.71906280952;2036.2364113457454;2041.2855500574829;2058.475088852333;2065.235862730799;2066.4110728442474;19086.904565477085;19439.902800485906;19637.80362196388;19709;19788.70316945247;2463.051725085837;2504.0109156883113;2520.4455019895595;2528.3173543143434;2543.923682289534;119670;124795.37602312022;132337.33831330878;139851.30074349564;139880;14431.134131952116;14701.750351220266;14731.116133031837;14811.555653330417;14849.70300593982;22590.774092258867;22644;22731.772682273295;22742.20402285912;22883.08467661275;9997.80004399908;10096.646617368357;10185.9490702546;10270.948645256725;10348.896511034793;9416.811663766823;9458.57436415363;9511.476868772146;9601.807963840683;9640.469774162348;8815.250703690259;8952.23905967987;9158.587863546156;9280.535973201448;9359.438433693864;2635.9604605930926;2704.851233182194;2726.209399274228;2748.395353022332;2786.512360336933;965.1024547171198;969.3505351414428;970.5195928015678;994.5027486256871;995.348047029197;18511.722324165148;18648.906755466134;18674.439766807016;18816.81183188178;19045.61908761845;1030.1810061001522;1031.9690409287734;1037.2998226197287;1053.167997282154;1053.5838343854289;10348.741281467874;10410.271281010257;10569.048785609331;10584;10680.893191068146;483119.7532037022;485745;487892;491326;493120;105133.47433262784;107728.46135769271;108017;108447.45776271226;108774.45612771885;1044.1385856668128;1086.6739978006724;1127.9379634120203;1174.8472698549133;1189.1794661683239;19373;19466.61066778685;19545.998802633978;19802.60394792125;19943.501412464804;50772.238416423046;53339.933201336535;53598.196027058846;54454;54591.72704136454;66073.66963165153;67066;67166.66416667885;67680.32319676741;68534;13805.309734513436;14159.362828672529;14242;14286.71426571442;14288.499902503363;21729.565408692055;21761;21974.560508790055;22208.333749987527;22302;17690;17743.556411089827;18130;18135.093245337943;18282.817171828112;15400;15794.526164215093;15884.285207165936;15996.040237585783;16357.26392312325;18252.81747182511;18554.721679175094;18555.628887422445;18624.534386640444;18748.531286717942;13427.731445371233;13875.306234688023;14026;14104.858951410355;14115;17870.285188592312;18037.819621804138;18063.548411289823;18075.36736214226;18116 11:40:01 INFO - PID 3774 | |3;mootools.html;1346.0913883128887;1408.1128888800058;1411.2097225553684;1415.2499175437022;1416.1007760072357;15066.171360575165;15701;15711.214439278034;15729.60675983101;15736.05583664981;15221.467248646299;15256.237188140603;15283.159426231552;15365.769513457308;15434.151121688303;2661.853598052111;2787.8048536602446;2793.3435642623967;2793.5111355512704;2793.5949287353324;2719.306576822917;2754.380264440495;2802.831830090201;2806.5228911085164;2807.368342123026;2772.3900741836765;2788.6793018802896;2800.621916041329;2800.957985630217;2801.32768135647;2591.7278685737915;2593.8443693378363;2610.7780838628646;2611.073069060494;2612.5297446459726;2581.935451613706;2687.2878687147922;2761.7514423701964;2772.7643150332246;2775.9861200694068;15402.768958465633;15435.073895566302;15449.845501544953;15463.072215667096;15488.5353439397;8046.637901294456;8223.712170074019;8273;8279.668813247463;8291.709790157316;5488.86766255378;5545.334559852803;5551.555875529948;5598.468145526209;5661.66030038199;1954.9120289587004;1956.1099699636632;1971.8619696621242;1989.293800700745;2012.4365177750253;26826.463470730476;27035.053773117845;27043.59434608463;27052.188434347;27095.1871443857;6604.702788374535;6652.933470665328;6718.529702920749;6883.793486195422;6926.688299026556;17335.393261235797;17413.3034678614;17432.825671743372;17441.30234790594;17449.38927137544;7663.118741344705;7961.323287520626;7962.402819788539;7967.083785364642;7982.762671785882;6909.136357955255;7125.144982602121;7337.119545654449;7375.778726638209;7461.328480436787;5012.122878496249;5303.231031500411;5312.176612624972;5361.705106219196;5420.078586640202;1507.7512210485365;1508.0951429142426;1522.8172619285535;1533.9463118790788;1549.6435819761518;861.4228466927174;862.66787286895;874.6632546469655;879.1647934462159;880.9471431714118;7093.397061249749;7129.7861064168155;7142.464315176382;7166.175889772639;7221.494495385377;710.6908494804776;720.200577359131;727.3926271563198;729.5330988167577;731.5500966905315;4997.475265097185;5045.192769156991;5070.112730272188;5083.110455670243;5264.105102132647;21302.573948521254;22165.22421715232;22224.666630000564;22267.443313917283;22499.55000899973;21200.25799097055;21510.677339839916;22162.445938851335;22253.44366390821;22303.330900073022;10867.29362591429;11304.15218858589;11329.886701132884;11335.546578136948;11400.885991139983;7940.205979402013;8028.678852845821;8150.75547733569;8183.222593853575;8183.3862460316905;17961.640767184843;18606;18642.906785465984;18651.813481865007;19097.331593394163;18979;19051.23795048238;19351.4194574163;19367.903160484108;19394;11066.170037247399;11118.444077796239;11172.944135279271;11197.104231661611;11317.773644526898;13327.133736307109;13519.662008449868;13532;13619.18284902909;13663.521776737767;11229.943850281023;11230.101591872468;11436.599719009795;11559.248648837798;11624.767504650028;10751.516181771683;11211.495482703134;11367.488463019019;11595.420228988349;11663.300201987908;10042.196624270187;10186.796264074825;10186.949065254626;10187.43969081678;10220.080192782685;6850.588964662136;6968.616726080114;7016.122984626922;7049.471289653399;7067.293270672892;6810.829729256809;6857.245702972569;6888.51780375389;6917.688704008231;7074.575525468488 11:40:01 INFO - PID 3774 | |4;prototype.html;497.52464317081166;500.3058529816937;518.8443466959911;525.5375269762608;527.1670760198887;6239.658473428212;6320.431161195492;6341;6343;6357.586756860806;6317.77887773928;6334.714937827797;6335.714892829822;6355.887719649066;6398.584092034026;5253.686578355401;5260.605454590902;5280.524752772269;5280.788768449257;5322.33470816148;4888.853334399973;5213.218017297398;5224.969517679737;5294.470552944713;5308.734563271841;4974.850754477371;4984.152694042022;5000.47495013022;5005.599552035828;5006.749662516878;4958.776855041532;5012.974935125338;5021.974890125544;5029.321041659366;5063.696178229281;4375.474943006828;4488.079943611552;4511.390962220124;4512.864614061584;4531.297648864432;6132.172156758825;6168.753249870045;6177.96911015442;6191.944276498901;6201.658908760016;5715.685637289947;5719.25649665545;5730.77076916927;5754.625949313323;5771.797987070432;6639.269680335159;6648;6660.333966603349;6667.699953502104;6677.432418244455;4680.765961701935;4906.1168989581865;4921.532454416824;4931.988942266863;4943.678660887067;6746.797596072126;6846.691898864563;6876.553024053421;6880.591792872505;6913.619750913697;4976.601871850244;4996.5003499650475;5011.298418221452;5017.874553136127;5043.344365232496;5041.470645582234;5077.796888124433;5096.286519887219;5100.5409513143995;5105.846824595268;5645.379008309083;5647.463490968352;5685.60200785941;5695.7152142392715;5704.971475142681;6584.144061272004;6645.06969024337;6648.966755166193;6668.633225172565;6701.631410272482;1752.835248468141;1761.6036391811997;1763.897564022486;1775.7869055713138;1779.9911000444915;1153.4809335798925;1208.6253261488966;1215.4651953140767;1219.737756382382;1221.975560488803;5670.149477578396;5694.658320500783;5716.914246286309;5730.169125476783;5749.88500229993;6700.195976482853;6703.22912865017;6717;6740.393364597112;6746.763863264762;5574.219609254707;5601.7759289628775;5624.775008999594;5711.858053230038;5714.542836573064;3458.325626502858;3464.9653503465147;3568.57177138745;3583.6595523425235;3586.8923932282073;6325.240971083407;6460.644664543495;6498.837529061717;6507.006776882592;6527.673616319165;6615.801525954229;6653.236892223565;6767.375829800812;6773.8645227095185;6850.862982740317;5996.910046349309;6347.365843175123;6390.360963903759;6482.254540727782;6500;6503.739850405931;6565.883799754149;6575.638339891352;6590.308017658077;6629.171353580802;6533.346665333619;6553;6586.538942274186;6719.42093607992;6720.361565651256;6399.456046236122;6401.64790936503;6403.455706265019;6456.322086181071;6459;4960;4997.225430058346;5025.271335656236;5052.332730198952;5055.772490238021;6486.740530378732;6551.967240163769;6730.259671436236;6732.932670673231;6795.762148324785;6303.747850085945;6338.619682819046;6408.628807341313;6489.059086432535;6505.739770409131;6382.585131966407;6441.3880681335195;6470.38531339522;6473.417392434703;6515.771947981798;6396.42432181106;6416.197975253093;6426.325235850169;6444.581102228341;6485.487335764751;6461.353864613501;6474.1907261592305;6568.8357791053695;6590.5716128451495;6600.108985287116;6313.936860631518;6415.166028416276;6418.358164183544;6421.454176394872;6452.257990331172 11:40:01 INFO - PID 3774 | |5;yui.html;891.1534042659475;914.0722167000494;918.5223683684483;922.3589605224372;926.1895841139;17945.82054179458;18671.626567468644;18826.905865470653;18839.434816955498;22570.322890313277;21873.781262187375;22140.778592214072;22163.445913852163;22171.778282217172;22218.444538886535;987.2398253344938;996.7757254617726;1001.4191768774093;1001.8346972749488;1002.7994401119769;954.8233576788316;975.9853602195973;985.866907967426;995.069609914732;997.0627610046533;1039.5581877701984;1047.4082143588848;1048.35002298575;1048.4024106259435;1049.8110340138771;1037.6731329631143;1041.2190856857358;1041.817681905671;1045.675840489443;1046.691226088302;763.6678045050365;768.4851149729694;769.8845173224005;770.1220608506308;772.0927909706073;18968.715469267972;20291.594168116702;20547.48631284215;20593;20681.172753089857;21753;21823.236186733546;22400.32799016016;22416.88791556048;22437.55124897493;16329.428470003611;16408.09755463449;16434.096124713134;16545.586360340967;16572;3662.7069834413182;3697.186618943828;3697.334479793636;3697.352963231424;3701.8889433317045;143539.28230358887;144534;144923;145764;147891;16436.671266574842;16578.088205148833;16789.832101679072;16877.15614219284;16975.405860794814;31634;31645.52531712026;31688.841555792536;31729.206769830478;31795.84102079475;8617;8680.30557555394;8822.51476168817;8851.69019084329;8878.712586675025;3834.2523207974737;3914.412838074312;3916.118873253495;3917.8824635260416;3930.272899513599;4953.6037117030555;5214.582833373321;5228.163493840967;5958.582899197015;6127.693615319216;1156.8843115688533;1173.2198088271375;1176.206060908883;1191.5174354386488;1192.66605350502;618.6133666458463;636.926753423353;639.3829954094322;640.8301800022998;648.3419329380682;12307.323097229559;12526.373681315898;12767.170133941265;13285.535006274735;13389.19664820114;628.9182406287154;631.4727202785633;641.1120597971842;646.4279112985042;648.3484098480997;5796.188533605298;5870.853228669317;5910.290765108214;5926.081457374114;5999.520038397005;126180.36909815576;126200.36899815442;126390.36804815917;127398.45203096072;132200;107942;108948.19466248076;109045;109105.45447272713;113762.43118784353;96298.51850740702;97475;97679.51160244153;98373.50813246031;99648;10617.89382106169;10838.187135964992;10973.670789876316;11047.944760276469;11061.889381106086;44190.779046104566;45818.770906145255;45836.54163458323;46471.07057858756;47450.52549474461;56464;57641;58142.4185758137;59585.702071489366;60499;16210.756838647194;16252.837471625133;16369.42707005249;16394.83605163933;16537.83462165363;17239.3966211182;17586.472405827844;17601.911990439967;17621.735673964646;17821.910890445466;17033.40383086586;17216.827831721523;17236.310547578458;17453.214605343044;17462.650746985244;16246.512604621881;16308.26612802403;16315.265813038679;16495;16627.75058374101;16115.838841611903;16477.91761041187;16490.587735306235;16518.917405412896;16693.499195024167;11333.206675532634;11498.82751758741;11630.244034137753;11671.299722016705;11672.941635291769;12409.441575129322;12565.623031309075;12665.240085594525;12712.745745084861;12769.74460510766 11:40:01 INFO - PID 3774 | __end_tp_report 11:40:01 INFO - PID 3774 | __start_cc_report 11:40:01 INFO - PID 3774 | _x_x_mozilla_cycle_collect,294 11:40:01 INFO - PID 3774 | __end_cc_report 11:40:01 INFO - PID 3774 | __startTimestamp1505846401509__endTimestamp 11:40:01 INFO - PID 3774 | 11:40:01 INFO - PID 3774 | ------- Summary: start ------- 11:40:01 INFO - PID 3774 | Number of tests: 6 11:40:01 INFO - PID 3774 | 11:40:01 INFO - PID 3774 | [#0] dojo.html Cycles:165 Average:6181.98 Median:6396.17 stddev:746.93 (11.7%) stddev-sans-first:708.74 11:40:01 INFO - PID 3774 | Values: 3089.8 3107.7 3127.7 3130.6 3155.2 6090.1 6306.5 6307.6 6331.9 6337.0 6123.8 6234.1 6354.1 6367.6 6408.1 5786.1 5835.2 5845.4 5858.8 5873.2 5700.3 5752.5 5847.4 5879.2 5893.4 5740.1 5813.9 5818.2 5844.8 5905.9 5675.5 5763.3 5772.8 5774.6 5792.8 5680.9 5739.7 5753.0 5770.5 5800.3 6260.3 6272.1 6281.1 6284.0 6396.2 6497.1 6631.0 6634.3 6639.9 6644.4 6650.3 6656.3 6662.8 6663.0 6758.1 6291.4 6291.7 6301.2 6337.3 6370.9 6885.8 6915.7 6929.5 7026.1 7031.5 6403.8 6627.8 6639.7 6640.3 6732.2 6619.5 6691.3 6750.3 6757.4 6762.8 6758.3 6773.3 6780.5 6781.7 6783.7 6722.5 6728.3 6729.9 6807.9 6827.2 5163.0 5225.0 5290.9 5324.4 5353.0 4532.6 4553.0 4600.3 4611.5 4689.3 5736.7 5792.8 5809.4 5812.3 5813.7 6656.2 6727.1 6758.5 6838.5 6856.1 5550.4 5657.4 5721.1 5801.1 5825.0 5791.9 5837.2 5850.3 5860.9 5861.1 6285.6 6377.6 6385.2 6442.6 6521.3 6539.7 6583.3 6600.1 6608.8 6615.7 6365.9 6378.7 6378.9 6379.3 6381.8 6564.2 6567.2 6571.9 6630.0 6741.9 6823.2 6838.2 6908.8 6918.6 6928.9 6567.5 6587.6 6652.4 6652.9 6664.0 6300.5 6485.4 6508.9 6543.1 6584.4 6425.3 6477.2 6571.9 6578.5 6596.9 6499.0 6692.5 6706.8 6719.2 6725.4 6403.1 6406.5 6406.7 6503.7 6509.3 11:40:01 INFO - PID 3774 | 11:40:01 INFO - PID 3774 | [#1] ext.html Cycles:180 Average:37092.85 Median:3570.92 stddev:52108.54 (1459.2%) stddev-sans-first:52183.68 11:40:01 INFO - PID 3774 | Values: 857.1 875.1 879.3 906.9 913.7 41133.0 41777.4 41790.8 41801.0 41958.0 38436.0 38555.8 38580.2 38601.4 38663.2 7244.3 7296.1 7324.2 7325.6 7363.6 7228.0 7274.0 7287.7 7297.0 7302.1 7190.2 7866.7 8083.8 8123.4 8127.5 7996.8 8057.4 8072.8 8079.7 8085.2 7865.4 7889.0 7907.6 7913.7 7944.8 37934.2 38054.8 38274.4 38388.8 38407.6 3525.9 3560.9 3569.8 3572.0 3574.7 32010.8 32520.2 32521.7 32528.5 32542.3 5125.9 5198.0 5207.4 5225.0 5256.5 188840.0 189013.0 189368.0 189465.0 189668.0 48100.8 48112.0 48115.0 48349.3 48452.3 50061.7 50151.2 50393.2 50431.2 50447.7 15779.4 16052.8 16053.9 16060.4 16072.1 12989.4 13152.2 13175.3 13205.0 13226.9 13293.5 13458.3 13534.7 13587.5 13749.1 5694.5 5751.7 5763.5 5782.6 5798.8 986.5 998.5 1008.8 1015.7 1029.8 22327.3 22595.7 22850.0 22957.2 23402.6 1091.8 1102.3 1110.5 1111.3 1127.4 12141.6 12149.1 12178.6 12295.9 12388.7 218618.0 218749.0 220013.0 220846.0 221160.0 45783.5 46961.8 52295.5 52340.5 52841.2 1461.3 1464.3 1471.3 1492.1 1494.2 26995.1 27203.8 27262.6 27567.7 27813.6 37204.8 37368.8 37433.3 37451.8 37458.6 193561.0 193567.0 194222.0 194866.0 194988.0 32914.7 33098.2 33406.8 33525.8 33585.8 41686.0 42705.6 42986.0 43374.8 43410.8 31684.8 31737.5 31822.2 32024.2 32507.3 31068.8 31808.5 31896.7 32373.2 32492.7 36688.4 36727.3 36743.0 37065.0 37071.8 31512.4 31691.4 31917.9 32219.0 32497.2 23480.5 23627.8 23655.0 23735.5 24118.8 11:40:01 INFO - PID 3774 | 11:40:01 INFO - PID 3774 | [#2] jquery.html Cycles:180 Average:33937.06 Median:22617.39 stddev:81823.74 (361.8%) stddev-sans-first:82014.92 11:40:01 INFO - PID 3774 | Values: 566.5 574.8 576.2 581.9 590.6 21872.3 22724.1 22733.8 22744.4 22763.0 24139.0 24218.8 24538.5 24567.3 24730.1 6598.6 6787.5 6788.0 6788.0 6794.5 6686.8 6732.1 6764.2 6777.8 6791.3 6332.8 6614.6 6621.9 6622.0 6632.7 6564.8 6608.6 6614.0 6614.4 6616.6 5915.3 6115.1 6133.1 6150.4 6158.0 27632.9 27972.2 27995.6 28049.4 28093.7 2036.2 2041.3 2058.5 2065.2 2066.4 19086.9 19439.9 19637.8 19709.0 19788.7 2463.1 2504.0 2520.4 2528.3 2543.9 119670.0 124795.4 132337.3 139851.3 139880.0 14431.1 14701.8 14731.1 14811.6 14849.7 22590.8 22644.0 22731.8 22742.2 22883.1 9997.8 10096.6 10185.9 10270.9 10348.9 9416.8 9458.6 9511.5 9601.8 9640.5 8815.3 8952.2 9158.6 9280.5 9359.4 2636.0 2704.9 2726.2 2748.4 2786.5 965.1 969.4 970.5 994.5 995.3 18511.7 18648.9 18674.4 18816.8 19045.6 1030.2 1032.0 1037.3 1053.2 1053.6 10348.7 10410.3 10569.0 10584.0 10680.9 483119.8 485745.0 487892.0 491326.0 493120.0 105133.5 107728.5 108017.0 108447.5 108774.5 1044.1 1086.7 1127.9 1174.8 1189.2 19373.0 19466.6 19546.0 19802.6 19943.5 50772.2 53339.9 53598.2 54454.0 54591.7 66073.7 67066.0 67166.7 67680.3 68534.0 13805.3 14159.4 14242.0 14286.7 14288.5 21729.6 21761.0 21974.6 22208.3 22302.0 17690.0 17743.6 18130.0 18135.1 18282.8 15400.0 15794.5 15884.3 15996.0 16357.3 18252.8 18554.7 18555.6 18624.5 18748.5 13427.7 13875.3 14026.0 14104.9 14115.0 17870.3 18037.8 18063.5 18075.4 18116.0 11:40:01 INFO - PID 3774 | 11:40:01 INFO - PID 3774 | [#3] mootools.html Cycles:180 Average:9355.53 Median:2637.19 stddev:6790.68 (257.5%) stddev-sans-first:6783.07 11:40:01 INFO - PID 3774 | Values: 1346.1 1408.1 1411.2 1415.2 1416.1 15066.2 15701.0 15711.2 15729.6 15736.1 15221.5 15256.2 15283.2 15365.8 15434.2 2661.9 2787.8 2793.3 2793.5 2793.6 2719.3 2754.4 2802.8 2806.5 2807.4 2772.4 2788.7 2800.6 2801.0 2801.3 2591.7 2593.8 2610.8 2611.1 2612.5 2581.9 2687.3 2761.8 2772.8 2776.0 15402.8 15435.1 15449.8 15463.1 15488.5 8046.6 8223.7 8273.0 8279.7 8291.7 5488.9 5545.3 5551.6 5598.5 5661.7 1954.9 1956.1 1971.9 1989.3 2012.4 26826.5 27035.1 27043.6 27052.2 27095.2 6604.7 6652.9 6718.5 6883.8 6926.7 17335.4 17413.3 17432.8 17441.3 17449.4 7663.1 7961.3 7962.4 7967.1 7982.8 6909.1 7125.1 7337.1 7375.8 7461.3 5012.1 5303.2 5312.2 5361.7 5420.1 1507.8 1508.1 1522.8 1533.9 1549.6 861.4 862.7 874.7 879.2 880.9 7093.4 7129.8 7142.5 7166.2 7221.5 710.7 720.2 727.4 729.5 731.6 4997.5 5045.2 5070.1 5083.1 5264.1 21302.6 22165.2 22224.7 22267.4 22499.6 21200.3 21510.7 22162.4 22253.4 22303.3 10867.3 11304.2 11329.9 11335.5 11400.9 7940.2 8028.7 8150.8 8183.2 8183.4 17961.6 18606.0 18642.9 18651.8 19097.3 18979.0 19051.2 19351.4 19367.9 19394.0 11066.2 11118.4 11172.9 11197.1 11317.8 13327.1 13519.7 13532.0 13619.2 13663.5 11229.9 11230.1 11436.6 11559.2 11624.8 10751.5 11211.5 11367.5 11595.4 11663.3 10042.2 10186.8 10186.9 10187.4 10220.1 6850.6 6968.6 7016.1 7049.5 7067.3 6810.8 6857.2 6888.5 6917.7 7074.6 11:40:01 INFO - PID 3774 | 11:40:01 INFO - PID 3774 | [#4] prototype.html Cycles:180 Average:5514.61 Median:6220.66 stddev:1533.89 (24.7%) stddev-sans-first:1491.25 11:40:01 INFO - PID 3774 | Values: 497.5 500.3 518.8 525.5 527.2 6239.7 6320.4 6341.0 6343.0 6357.6 6317.8 6334.7 6335.7 6355.9 6398.6 5253.7 5260.6 5280.5 5280.8 5322.3 4888.9 5213.2 5225.0 5294.5 5308.7 4974.9 4984.2 5000.5 5005.6 5006.7 4958.8 5013.0 5022.0 5029.3 5063.7 4375.5 4488.1 4511.4 4512.9 4531.3 6132.2 6168.8 6178.0 6191.9 6201.7 5715.7 5719.3 5730.8 5754.6 5771.8 6639.3 6648.0 6660.3 6667.7 6677.4 4680.8 4906.1 4921.5 4932.0 4943.7 6746.8 6846.7 6876.6 6880.6 6913.6 4976.6 4996.5 5011.3 5017.9 5043.3 5041.5 5077.8 5096.3 5100.5 5105.8 5645.4 5647.5 5685.6 5695.7 5705.0 6584.1 6645.1 6649.0 6668.6 6701.6 1752.8 1761.6 1763.9 1775.8 1780.0 1153.5 1208.6 1215.5 1219.7 1222.0 5670.1 5694.7 5716.9 5730.2 5749.9 6700.2 6703.2 6717.0 6740.4 6746.8 5574.2 5601.8 5624.8 5711.9 5714.5 3458.3 3465.0 3568.6 3583.7 3586.9 6325.2 6460.6 6498.8 6507.0 6527.7 6615.8 6653.2 6767.4 6773.9 6850.9 5996.9 6347.4 6390.4 6482.3 6500.0 6503.7 6565.9 6575.6 6590.3 6629.2 6533.3 6553.0 6586.5 6719.4 6720.4 6399.5 6401.6 6403.5 6456.3 6459.0 4960.0 4997.2 5025.3 5052.3 5055.8 6486.7 6552.0 6730.3 6732.9 6795.8 6303.7 6338.6 6408.6 6489.1 6505.7 6382.6 6441.4 6470.4 6473.4 6515.8 6396.4 6416.2 6426.3 6444.6 6485.5 6461.4 6474.2 6568.8 6590.6 6600.1 6313.9 6415.2 6418.4 6421.5 6452.3 11:40:01 INFO - PID 3774 | 11:40:01 INFO - PID 3774 | [#5] yui.html Cycles:180 Average:25050.47 Median:18833.17 stddev:36426.15 (193.4%) stddev-sans-first:36483.17 11:40:01 INFO - PID 3774 | Values: 891.2 914.1 918.5 922.4 926.2 17945.8 18671.6 18826.9 18839.4 22570.3 21873.8 22140.8 22163.4 22171.8 22218.4 987.2 996.8 1001.4 1001.8 1002.8 954.8 976.0 985.9 995.1 997.1 1039.6 1047.4 1048.4 1048.4 1049.8 1037.7 1041.2 1041.8 1045.7 1046.7 763.7 768.5 769.9 770.1 772.1 18968.7 20291.6 20547.5 20593.0 20681.2 21753.0 21823.2 22400.3 22416.9 22437.6 16329.4 16408.1 16434.1 16545.6 16572.0 3662.7 3697.2 3697.3 3697.4 3701.9 143539.3 144534.0 144923.0 145764.0 147891.0 16436.7 16578.1 16789.8 16877.2 16975.4 31634.0 31645.5 31688.8 31729.2 31795.8 8617.0 8680.3 8822.5 8851.7 8878.7 3834.3 3914.4 3916.1 3917.9 3930.3 4953.6 5214.6 5228.2 5958.6 6127.7 1156.9 1173.2 1176.2 1191.5 1192.7 618.6 636.9 639.4 640.8 648.3 12307.3 12526.4 12767.2 13285.5 13389.2 628.9 631.5 641.1 646.4 648.3 5796.2 5870.9 5910.3 5926.1 5999.5 126180.4 126200.4 126390.4 127398.5 132200.0 107942.0 108948.2 109045.0 109105.5 113762.4 96298.5 97475.0 97679.5 98373.5 99648.0 10617.9 10838.2 10973.7 11047.9 11061.9 44190.8 45818.8 45836.5 46471.1 47450.5 56464.0 57641.0 58142.4 59585.7 60499.0 16210.8 16252.8 16369.4 16394.8 16537.8 17239.4 17586.5 17601.9 17621.7 17821.9 17033.4 17216.8 17236.3 17453.2 17462.7 16246.5 16308.3 16315.3 16495.0 16627.8 16115.8 16477.9 16490.6 16518.9 16693.5 11333.2 11498.8 11630.2 11671.3 11672.9 12409.4 12565.6 12665.2 12712.7 12769.7 11:40:01 INFO - PID 3774 | -------- Summary: end -------- 11:40:01 INFO - PID 3774 | 11:40:02 INFO - TEST-INFO | 3774: exit 0 11:40:02 INFO - TEST-OK | dromaeo_css | took 1111864ms 11:40:02 INFO - TEST-START | kraken 11:40:02 INFO - Initialising browser for kraken test... 11:40:02 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:51243/getInfo.html -profile /tmp/tmpPcvVVw/profile 11:40:02 INFO - TEST-INFO | started process 4143 (/builds/slave/test/build/application/firefox/firefox http://localhost:51243/getInfo.html) 11:40:08 INFO - TEST-INFO | 4143: exit 0 11:40:08 INFO - Browser initialized. 11:40:08 INFO - Running cycle 1/1 for kraken test... 11:40:08 INFO - Using env: {'DISPLAY': ':0', 11:40:08 INFO - 'HOME': '/home/cltbld', 11:40:08 INFO - 'JSGC_DISABLE_POISONING': '1', 11:40:08 INFO - 'LANG': 'en_US.UTF-8', 11:40:08 INFO - 'LANGUAGE': 'en_US:en', 11:40:08 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 11:40:08 INFO - 'LOGNAME': 'cltbld', 11:40:08 INFO - 'MAIL': '/var/mail/cltbld', 11:40:08 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:40:08 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 11:40:08 INFO - 'MOZ_CRASHREPORTER': '1', 11:40:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:40:08 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 11:40:08 INFO - 'MOZ_NO_REMOTE': '1', 11:40:08 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:40:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:40:08 INFO - 'NO_EM_RESTART': '1', 11:40:08 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:40:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:40:08 INFO - 'PWD': '/builds/slave/test', 11:40:08 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:40:08 INFO - 'RUST_BACKTRACE': 'full', 11:40:08 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 11:40:08 INFO - 'SHELL': '/bin/bash', 11:40:08 INFO - 'SHLVL': '1', 11:40:08 INFO - 'STYLO_FORCE_DISABLED': '1', 11:40:08 INFO - 'TERM': 'linux', 11:40:08 INFO - 'TMOUT': '86400', 11:40:08 INFO - 'USER': 'cltbld', 11:40:08 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1505839810.393748-2053307589', 11:40:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:40:08 INFO - '_': '/tools/buildbot/bin/python'} 11:40:08 INFO - TEST-INFO | started process 4379 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpPcvVVw/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 11:40:08 INFO - PID 4379 | 11:40:08 INFO - PID 4379 | (/builds/slave/test/build/application/firefox/firefox:4428): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 11:40:08 INFO - PID 4379 | 11:40:19 INFO - PID 4379 | RSS: Main: 153354240 11:40:19 INFO - PID 4379 | 11:40:21 INFO - PID 4379 | Cycle 1(1): loaded http://localhost:51243/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:51243/tests/kraken/driver.html?testName=audio-beat-detection) 11:40:22 INFO - PID 4379 | RSS: Main: 158683136 11:40:22 INFO - PID 4379 | 11:40:25 INFO - PID 4379 | Cycle 1(1): loaded http://localhost:51243/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:51243/tests/kraken/driver.html?testName=audio-dft) 11:40:26 INFO - PID 4379 | RSS: Main: 158863360 11:40:26 INFO - PID 4379 | 11:40:29 INFO - PID 4379 | Cycle 1(1): loaded http://localhost:51243/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:51243/tests/kraken/driver.html?testName=audio-fft) 11:40:29 INFO - PID 4379 | RSS: Main: 155795456 11:40:29 INFO - PID 4379 | 11:40:31 INFO - PID 4379 | Cycle 1(1): loaded http://localhost:51243/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:51243/tests/kraken/driver.html?testName=audio-oscillator) 11:40:32 INFO - PID 4379 | RSS: Main: 156512256 11:40:32 INFO - PID 4379 | 11:40:34 INFO - PID 4379 | Cycle 1(1): loaded http://localhost:51243/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:51243/tests/kraken/driver.html?testName=imaging-gaussian-blur) 11:40:35 INFO - PID 4379 | RSS: Main: 156512256 11:40:35 INFO - PID 4379 | 11:40:38 INFO - PID 4379 | Cycle 1(1): loaded http://localhost:51243/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:51243/tests/kraken/driver.html?testName=imaging-darkroom) 11:40:38 INFO - PID 4379 | RSS: Main: 159936512 11:40:38 INFO - PID 4379 | 11:40:42 INFO - PID 4379 | Cycle 1(1): loaded http://localhost:51243/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:51243/tests/kraken/driver.html?testName=imaging-desaturate) 11:40:43 INFO - PID 4379 | RSS: Main: 159694848 11:40:43 INFO - PID 4379 | 11:40:46 INFO - PID 4379 | Cycle 1(1): loaded http://localhost:51243/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:51243/tests/kraken/driver.html?testName=json-parse-financial) 11:40:46 INFO - PID 4379 | RSS: Main: 159072256 11:40:46 INFO - PID 4379 | 11:40:48 INFO - PID 4379 | Cycle 1(1): loaded http://localhost:51243/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:51243/tests/kraken/driver.html?testName=json-stringify-tinderbox) 11:40:48 INFO - PID 4379 | RSS: Main: 159141888 11:40:48 INFO - PID 4379 | 11:40:50 INFO - PID 4379 | Cycle 1(1): loaded http://localhost:51243/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:51243/tests/kraken/driver.html?testName=stanford-crypto-aes) 11:40:51 INFO - PID 4379 | RSS: Main: 159379456 11:40:51 INFO - PID 4379 | 11:40:53 INFO - PID 4379 | Cycle 1(1): loaded http://localhost:51243/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:51243/tests/kraken/driver.html?testName=stanford-crypto-ccm) 11:40:53 INFO - PID 4379 | RSS: Main: 155848704 11:40:53 INFO - PID 4379 | 11:40:56 INFO - PID 4379 | Cycle 1(1): loaded http://localhost:51243/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:51243/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 11:40:57 INFO - PID 4379 | RSS: Main: 156385280 11:40:57 INFO - PID 4379 | 11:40:59 INFO - PID 4379 | Cycle 1(1): loaded http://localhost:51243/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:51243/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 11:41:00 INFO - PID 4379 | RSS: Main: 156794880 11:41:00 INFO - PID 4379 | 11:41:02 INFO - PID 4379 | Cycle 1(1): loaded http://localhost:51243/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:51243/tests/kraken/driver.html?testName=ai-astar) 11:41:02 INFO - PID 4379 | RSS: Main: 158285824 11:41:02 INFO - PID 4379 | 11:41:02 INFO - PID 4379 | __start_tp_report 11:41:02 INFO - PID 4379 | _x_x_mozilla_page_load 11:41:02 INFO - PID 4379 | _x_x_mozilla_page_load_details 11:41:02 INFO - PID 4379 | |i|pagename|runs| 11:41:02 INFO - PID 4379 | |0;ai-astar;108;106;106;108;107;106;109;106;107;108 11:41:02 INFO - PID 4379 | |1;audio-beat-detection;116;120;119;116;118;115;142;115;115;116 11:41:02 INFO - PID 4379 | |2;audio-dft;162;162;161;163;162;162;162;170;164;164 11:41:02 INFO - PID 4379 | |3;audio-fft;74;75;76;76;78;73;73;74;74;75 11:41:02 INFO - PID 4379 | |4;audio-oscillator;79;78;78;78;79;79;79;80;79;79 11:41:02 INFO - PID 4379 | |5;imaging-gaussian-blur;114;114;114;114;114;114;112;115;116;113 11:41:02 INFO - PID 4379 | |6;imaging-darkroom;153;149;150;147;148;147;147;149;149;151 11:41:02 INFO - PID 4379 | |7;imaging-desaturate;93;94;94;93;94;94;94;94;94;95 11:41:02 INFO - PID 4379 | |8;json-parse-financial;55;53;54;53;54;54;53;53;54;50 11:41:02 INFO - PID 4379 | |9;json-stringify-tinderbox;38;38;39;38;38;38;38;39;39;38 11:41:02 INFO - PID 4379 | |10;stanford-crypto-aes;80;75;74;77;79;76;75;74;75;74 11:41:02 INFO - PID 4379 | |11;stanford-crypto-ccm;115;112;111;115;113;113;113;121;125;117 11:41:02 INFO - PID 4379 | |12;stanford-crypto-pbkdf2;171;168;168;166;172;168;170;170;170;167 11:41:02 INFO - PID 4379 | |13;stanford-crypto-sha256-iterative;72;67;71;65;66;67;66;67;66;72 11:41:02 INFO - PID 4379 | __end_tp_report 11:41:02 INFO - PID 4379 | __start_cc_report 11:41:02 INFO - PID 4379 | _x_x_mozilla_cycle_collect,712 11:41:02 INFO - PID 4379 | __end_cc_report 11:41:02 INFO - PID 4379 | __startTimestamp1505846462644__endTimestamp 11:41:02 INFO - PID 4379 | 11:41:02 INFO - PID 4379 | ------- Summary: start ------- 11:41:02 INFO - PID 4379 | Number of tests: 14 11:41:02 INFO - PID 4379 | 11:41:02 INFO - PID 4379 | [#0] ai-astar Cycles:10 Average:107.10 Median:107.50 stddev:1.10 (1.0%) stddev-sans-first:1.12 11:41:02 INFO - PID 4379 | Values: 108.0 106.0 106.0 108.0 107.0 106.0 109.0 106.0 107.0 108.0 11:41:02 INFO - PID 4379 | 11:41:02 INFO - PID 4379 | [#1] audio-beat-detection Cycles:10 Average:119.20 Median:117.00 stddev:8.20 (7.0%) stddev-sans-first:8.62 11:41:02 INFO - PID 4379 | Values: 116.0 120.0 119.0 116.0 118.0 115.0 142.0 115.0 115.0 116.0 11:41:02 INFO - PID 4379 | 11:41:02 INFO - PID 4379 | [#2] audio-dft Cycles:10 Average:163.20 Median:162.50 stddev:2.57 (1.6%) stddev-sans-first:2.69 11:41:02 INFO - PID 4379 | Values: 162.0 162.0 161.0 163.0 162.0 162.0 162.0 170.0 164.0 164.0 11:41:02 INFO - PID 4379 | 11:41:02 INFO - PID 4379 | [#3] audio-fft Cycles:10 Average:74.80 Median:75.00 stddev:1.55 (2.1%) stddev-sans-first:1.62 11:41:02 INFO - PID 4379 | Values: 74.0 75.0 76.0 76.0 78.0 73.0 73.0 74.0 74.0 75.0 11:41:02 INFO - PID 4379 | 11:41:02 INFO - PID 4379 | [#4] audio-oscillator Cycles:10 Average:78.80 Median:79.00 stddev:0.63 (0.8%) stddev-sans-first:0.67 11:41:02 INFO - PID 4379 | Values: 79.0 78.0 78.0 78.0 79.0 79.0 79.0 80.0 79.0 79.0 11:41:02 INFO - PID 4379 | 11:41:02 INFO - PID 4379 | [#5] imaging-gaussian-blur Cycles:10 Average:114.00 Median:114.00 stddev:1.05 (0.9%) stddev-sans-first:1.12 11:41:02 INFO - PID 4379 | Values: 114.0 114.0 114.0 114.0 114.0 114.0 112.0 115.0 116.0 113.0 11:41:02 INFO - PID 4379 | 11:41:02 INFO - PID 4379 | [#6] imaging-darkroom Cycles:10 Average:149.00 Median:149.00 stddev:1.94 (1.3%) stddev-sans-first:1.42 11:41:02 INFO - PID 4379 | Values: 153.0 149.0 150.0 147.0 148.0 147.0 147.0 149.0 149.0 151.0 11:41:02 INFO - PID 4379 | 11:41:02 INFO - PID 4379 | [#7] imaging-desaturate Cycles:10 Average:93.90 Median:94.00 stddev:0.57 (0.6%) stddev-sans-first:0.50 11:41:02 INFO - PID 4379 | Values: 93.0 94.0 94.0 93.0 94.0 94.0 94.0 94.0 94.0 95.0 11:41:02 INFO - PID 4379 | 11:41:02 INFO - PID 4379 | [#8] json-parse-financial Cycles:10 Average:53.30 Median:54.00 stddev:1.34 (2.5%) stddev-sans-first:1.27 11:41:02 INFO - PID 4379 | Values: 55.0 53.0 54.0 53.0 54.0 54.0 53.0 53.0 54.0 50.0 11:41:02 INFO - PID 4379 | 11:41:02 INFO - PID 4379 | [#9] json-stringify-tinderbox Cycles:10 Average:38.30 Median:38.00 stddev:0.48 (1.3%) stddev-sans-first:0.50 11:41:02 INFO - PID 4379 | Values: 38.0 38.0 39.0 38.0 38.0 38.0 38.0 39.0 39.0 38.0 11:41:02 INFO - PID 4379 | 11:41:02 INFO - PID 4379 | [#10] stanford-crypto-aes Cycles:10 Average:75.90 Median:75.50 stddev:2.13 (2.8%) stddev-sans-first:1.67 11:41:02 INFO - PID 4379 | Values: 80.0 75.0 74.0 77.0 79.0 76.0 75.0 74.0 75.0 74.0 11:41:02 INFO - PID 4379 | 11:41:02 INFO - PID 4379 | [#11] stanford-crypto-ccm Cycles:10 Average:115.50 Median:115.00 stddev:4.40 (3.8%) stddev-sans-first:4.67 11:41:02 INFO - PID 4379 | Values: 115.0 112.0 111.0 115.0 113.0 113.0 113.0 121.0 125.0 117.0 11:41:02 INFO - PID 4379 | 11:41:02 INFO - PID 4379 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:169.00 Median:170.00 stddev:1.89 (1.1%) stddev-sans-first:1.86 11:41:02 INFO - PID 4379 | Values: 171.0 168.0 168.0 166.0 172.0 168.0 170.0 170.0 170.0 167.0 11:41:02 INFO - PID 4379 | 11:41:02 INFO - PID 4379 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.90 Median:67.00 stddev:2.69 (4.0%) stddev-sans-first:2.40 11:41:02 INFO - PID 4379 | Values: 72.0 67.0 71.0 65.0 66.0 67.0 66.0 67.0 66.0 72.0 11:41:02 INFO - PID 4379 | -------- Summary: end -------- 11:41:02 INFO - PID 4379 | 11:41:03 INFO - PID 4379 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 11:41:03 INFO - TEST-INFO | 4379: exit 0 11:41:03 INFO - TEST-OK | kraken | took 61441ms 11:41:03 INFO - SUITE-END | took 1173s 11:41:03 INFO - Completed test suite (00:19:33) 11:41:03 INFO - javascript benchmark 11:41:03 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s", "stylo_disabled"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8507.928218672825, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3089.8146111233327, 3107.658157602662, 3127.687231276871, 3130.639976402713, 3155.1796532901453, 6090.116933044706, 6306.495480361566, 6307.621542707435, 6331.873362532747, 6337.049442583615, 6123.785667501638, 6234.127222188886, 6354.078658594501, 6367.554271201017, 6408.102865598808, 5786.103154011135, 5835.241418615574, 5845.415458454163, 5858.7949421770245, 5873.177755114288, 5700.287464066992, 5752.511036561877, 5847.415258474161, 5879.176915231871, 5893.440123188312, 5740.1102829061565, 5813.854653633651, 5818.243628328311, 5844.766209351621, 5905.911411328833, 5675.51758100562, 5763.279590051244, 5772.797952071657, 5774.566907481913, 5792.82621521355, 5680.943190568083, 5739.655620662774, 5753.0, 5770.509506691937, 5800.332961709415, 6260.280067792217, 6272.090546870678, 6281.057841323793, 6283.968580157116, 6396.168498095264, 6497.057926600616, 6630.966845165792, 6634.336566343375, 6639.9044157713915, 6644.402003819631, 6650.334966503359, 6656.267810540837, 6662.766803161866, 6662.967240077795, 6758.12144421227, 6291.402316779899, 6291.653959032252, 6301.243850737895, 6337.33457986914, 6370.90443643341, 6885.827854303682, 6915.723371065202, 6929.480288978347, 7026.051483049825, 7031.472639552054, 6403.839904002344, 6627.801165965029, 6639.668016599151, 6640.335966403321, 6732.192136943598, 6619.536632435684, 6691.26396096429, 6750.32496750321, 6757.391834734897, 6762.83092922671, 6758.324167583202, 6773.254941956381, 6780.491463140284, 6781.6609169541325, 6783.728650853911, 6722.529422940347, 6728.327167283331, 6729.8654026919185, 6807.897881531781, 6827.214870289881, 5162.97418512905, 5225.007248622749, 5290.894182116336, 5324.361076670824, 5353.009693206769, 4532.614727748179, 4553.021100463417, 4600.309953506934, 4611.469680986663, 4689.320048592935, 5736.713164341766, 5792.768289268466, 5809.390014048548, 5812.3025236971835, 5813.680247586339, 6656.201255849232, 6727.091842601186, 6758.459323254128, 6838.452923766087, 6856.074429951893, 5550.361708403505, 5657.377688454267, 5721.141828725725, 5801.100829371369, 5824.970875145597, 5791.884162316815, 5837.241158649434, 5850.297964244318, 5860.853478663067, 5861.062230043172, 6285.622862628257, 6377.617342959437, 6385.201849768779, 6442.613443193423, 6521.315261897527, 6539.738410463528, 6583.341665833378, 6600.075989361397, 6608.768693095719, 6615.702293396905, 6365.904511432424, 6378.712957916812, 6378.90431643535, 6379.266384365857, 6381.8085457436355, 6564.179477565304, 6567.2447668518735, 6571.901421478778, 6629.966850165718, 6741.865162696817, 6823.215330236888, 6838.247792742694, 6908.827279318058, 6918.5502942308585, 6928.896066559107, 6567.507436942153, 6587.604743715392, 6652.401283884474, 6652.933470665232, 6663.966680166568, 6300.495960323255, 6485.448736857231, 6508.869822603616, 6543.149390579194, 6584.407403333723, 6425.325340839145, 6477.157969464128, 6571.868562628816, 6578.473722102316, 6596.901046484402, 6498.967505162633, 6692.531522793358, 6706.826305396438, 6719.227288861648, 6725.39471447572, 6403.135576697086, 6406.487481001415, 6406.7431070132025, 6503.674816259263, 6509.283978762238], "value": 6124.319917595292, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [857.0529564830858, 875.098648392156, 879.3385156211323, 906.8503696890014, 913.7258822353294, 41133.0, 41777.373339399936, 41790.791046044804, 41801.0, 41958.0, 38436.0, 38555.807220963856, 38580.228395432074, 38601.42097868527, 38663.22673546527, 7244.348008679218, 7296.087989001375, 7324.230955749649, 7325.560466372035, 7363.631818409085, 7228.0, 7273.963630181842, 7287.744928927488, 7297.0, 7302.087239095114, 7190.173130090028, 7866.724664636738, 8083.757487275391, 8123.390745694067, 8127.512349259034, 7996.800079997988, 8057.395695322845, 8072.757817265433, 8079.717209897654, 8085.231902969209, 7865.370770338359, 7889.0, 7907.644156012936, 7913.683452661887, 7944.841103177904, 37934.241315173545, 38054.80972595119, 38274.425883611766, 38388.808055959824, 38407.61592384068, 3525.94711079334, 3560.893173204782, 3569.821508924543, 3572.017695133833, 3574.696150827183, 32010.839945800355, 32520.21138837363, 32521.674783252336, 32528.512072318936, 32542.349153017043, 5125.923111153335, 5198.0, 5207.401148867891, 5224.9738751306, 5256.474352564751, 188840.0, 189013.0, 189368.0, 189464.99999999863, 189668.0, 48100.75949620229, 48112.0, 48115.0, 48349.274760878616, 48452.27321590179, 50061.74969125131, 50151.24773128406, 50393.24410133851, 50431.243531347056, 50447.74776126096, 15779.368825247091, 16052.839471605135, 16053.919730401274, 16060.357585696442, 16072.11603361803, 12989.350532473338, 13152.21086734799, 13175.341232938315, 13205.0, 13226.933865330611, 13293.468261269634, 13458.327083645778, 13534.729305414034, 13587.52443664467, 13749.106308089942, 5694.4659626466655, 5751.728067413348, 5763.481286684135, 5782.624129431573, 5798.82603521895, 986.5412583148727, 998.4558415663481, 1008.8284991551307, 1015.6546774096843, 1029.8455231715302, 22327.330180094625, 22595.661065084038, 22850.0, 22957.196498122485, 23402.64896026561, 1091.8362245663054, 1102.3220719257758, 1110.5224753356135, 1111.3276467737064, 1127.4137448526885, 12141.575044873387, 12149.149559530924, 12178.634640960785, 12295.877041229653, 12388.690282743004, 218618.0, 218749.0, 220013.0, 220846.0, 221160.0, 45783.5421645786, 46961.76519117383, 52295.47704522982, 52340.47659523356, 52841.207381889304, 1461.3423959218394, 1464.3337281536876, 1471.3378979459071, 1492.0749135536037, 1494.215536843166, 26995.05517306885, 27203.7758300873, 27262.591061134495, 27567.724322756516, 27813.582796258477, 37204.813975929945, 37368.81315593405, 37433.25133497369, 37451.81274093612, 37458.6254137466, 193561.0, 193567.0, 194222.0, 194866.0, 194988.0, 32914.67085329212, 33098.17254568655, 33406.83296583501, 33525.83237083799, 33585.83207083949, 41686.0, 42705.57294427016, 42986.0, 43374.78312608417, 43410.78294608507, 31684.841575791972, 31737.523937141425, 31822.204444889063, 32024.19939501438, 32507.34985300328, 31068.844655776575, 31808.522872156474, 31896.681033189372, 32373.19067023343, 32492.675073248964, 36688.449673255454, 36727.26545469129, 36743.0, 37065.0, 37071.81464092662, 31512.36975260528, 31691.366172676877, 31917.882874099294, 32219.0, 32497.187570310933, 23480.530389391773, 23627.763722363245, 23655.0, 23735.52528949446, 24118.758812411652], "value": 17148.274055654787, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [566.4958187213381, 574.8476653686771, 576.167438052015, 581.9214406055181, 590.5541316306188, 21872.343829685116, 22724.091036358568, 22733.77266227337, 22744.43138921528, 22763.0, 24139.0, 24218.75781242187, 24538.509229815394, 24567.262982110522, 24730.134445294418, 6598.571092878971, 6787.4570034397375, 6787.966060169692, 6788.049673045753, 6794.524383293171, 6686.7993960181275, 6732.057511948331, 6764.154480689914, 6777.76277830276, 6791.252962174157, 6332.841678958017, 6614.603123812587, 6621.867562648768, 6622.0, 6632.734690612394, 6564.835879103037, 6608.570442921219, 6614.0, 6614.404703576653, 6616.603003819786, 5915.260592425947, 6115.082737589352, 6133.1413602095745, 6150.415710507495, 6157.969210153965, 27632.861835690896, 27972.16083517498, 27995.580066299022, 28049.43901121966, 28093.71906280952, 2036.2364113457454, 2041.2855500574829, 2058.475088852333, 2065.235862730799, 2066.4110728442474, 19086.904565477085, 19439.902800485906, 19637.80362196388, 19709.0, 19788.70316945247, 2463.051725085837, 2504.0109156883113, 2520.4455019895595, 2528.3173543143434, 2543.923682289534, 119670.0, 124795.37602312022, 132337.33831330878, 139851.30074349564, 139880.0, 14431.134131952116, 14701.750351220266, 14731.116133031837, 14811.555653330417, 14849.70300593982, 22590.774092258867, 22644.0, 22731.772682273295, 22742.20402285912, 22883.08467661275, 9997.80004399908, 10096.646617368357, 10185.9490702546, 10270.948645256725, 10348.896511034793, 9416.811663766823, 9458.57436415363, 9511.476868772146, 9601.807963840683, 9640.469774162348, 8815.250703690259, 8952.23905967987, 9158.587863546156, 9280.535973201448, 9359.438433693864, 2635.9604605930926, 2704.851233182194, 2726.209399274228, 2748.395353022332, 2786.512360336933, 965.1024547171198, 969.3505351414428, 970.5195928015678, 994.5027486256871, 995.348047029197, 18511.722324165148, 18648.906755466134, 18674.439766807016, 18816.81183188178, 19045.61908761845, 1030.1810061001522, 1031.9690409287734, 1037.2998226197287, 1053.167997282154, 1053.5838343854289, 10348.741281467874, 10410.271281010257, 10569.048785609331, 10584.0, 10680.893191068146, 483119.7532037022, 485745.0, 487892.0, 491326.0, 493120.0, 105133.47433262784, 107728.46135769271, 108017.0, 108447.45776271226, 108774.45612771885, 1044.1385856668128, 1086.6739978006724, 1127.9379634120203, 1174.8472698549133, 1189.1794661683239, 19373.0, 19466.61066778685, 19545.998802633978, 19802.60394792125, 19943.501412464804, 50772.238416423046, 53339.933201336535, 53598.196027058846, 54454.0, 54591.72704136454, 66073.66963165153, 67066.0, 67166.66416667885, 67680.32319676741, 68534.0, 13805.309734513436, 14159.362828672529, 14242.0, 14286.71426571442, 14288.499902503363, 21729.565408692055, 21761.0, 21974.560508790055, 22208.333749987527, 22302.0, 17690.0, 17743.556411089827, 18130.0, 18135.093245337943, 18282.817171828112, 15400.0, 15794.526164215093, 15884.285207165936, 15996.040237585783, 16357.26392312325, 18252.81747182511, 18554.721679175094, 18555.628887422445, 18624.534386640444, 18748.531286717942, 13427.731445371233, 13875.306234688023, 14026.0, 14104.858951410355, 14115.0, 17870.285188592312, 18037.819621804138, 18063.548411289823, 18075.36736214226, 18116.0], "value": 11808.24394971294, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1346.0913883128887, 1408.1128888800058, 1411.2097225553684, 1415.2499175437022, 1416.1007760072357, 15066.171360575165, 15701.0, 15711.214439278034, 15729.60675983101, 15736.05583664981, 15221.467248646299, 15256.237188140603, 15283.159426231552, 15365.769513457308, 15434.151121688303, 2661.853598052111, 2787.8048536602446, 2793.3435642623967, 2793.5111355512704, 2793.5949287353324, 2719.306576822917, 2754.380264440495, 2802.831830090201, 2806.5228911085164, 2807.368342123026, 2772.3900741836765, 2788.6793018802896, 2800.621916041329, 2800.957985630217, 2801.32768135647, 2591.7278685737915, 2593.8443693378363, 2610.7780838628646, 2611.073069060494, 2612.5297446459726, 2581.935451613706, 2687.2878687147922, 2761.7514423701964, 2772.7643150332246, 2775.9861200694068, 15402.768958465633, 15435.073895566302, 15449.845501544953, 15463.072215667096, 15488.5353439397, 8046.637901294456, 8223.712170074019, 8273.0, 8279.668813247463, 8291.709790157316, 5488.86766255378, 5545.334559852803, 5551.555875529948, 5598.468145526209, 5661.66030038199, 1954.9120289587004, 1956.1099699636632, 1971.8619696621242, 1989.293800700745, 2012.4365177750253, 26826.463470730476, 27035.053773117845, 27043.59434608463, 27052.188434347, 27095.1871443857, 6604.702788374535, 6652.933470665328, 6718.529702920749, 6883.793486195422, 6926.688299026556, 17335.393261235797, 17413.3034678614, 17432.825671743372, 17441.30234790594, 17449.38927137544, 7663.118741344705, 7961.323287520626, 7962.402819788539, 7967.083785364642, 7982.762671785882, 6909.136357955255, 7125.144982602121, 7337.119545654449, 7375.778726638209, 7461.328480436787, 5012.122878496249, 5303.231031500411, 5312.176612624972, 5361.705106219196, 5420.078586640202, 1507.7512210485365, 1508.0951429142426, 1522.8172619285535, 1533.9463118790788, 1549.6435819761518, 861.4228466927174, 862.66787286895, 874.6632546469655, 879.1647934462159, 880.9471431714118, 7093.397061249749, 7129.7861064168155, 7142.464315176382, 7166.175889772639, 7221.494495385377, 710.6908494804776, 720.200577359131, 727.3926271563198, 729.5330988167577, 731.5500966905315, 4997.475265097185, 5045.192769156991, 5070.112730272188, 5083.110455670243, 5264.105102132647, 21302.573948521254, 22165.22421715232, 22224.666630000564, 22267.443313917283, 22499.55000899973, 21200.25799097055, 21510.677339839916, 22162.445938851335, 22253.44366390821, 22303.330900073022, 10867.29362591429, 11304.15218858589, 11329.886701132884, 11335.546578136948, 11400.885991139983, 7940.205979402013, 8028.678852845821, 8150.75547733569, 8183.222593853575, 8183.3862460316905, 17961.640767184843, 18606.0, 18642.906785465984, 18651.813481865007, 19097.331593394163, 18979.0, 19051.23795048238, 19351.4194574163, 19367.903160484108, 19394.0, 11066.170037247399, 11118.444077796239, 11172.944135279271, 11197.104231661611, 11317.773644526898, 13327.133736307109, 13519.662008449868, 13532.0, 13619.18284902909, 13663.521776737767, 11229.943850281023, 11230.101591872468, 11436.599719009795, 11559.248648837798, 11624.767504650028, 10751.516181771683, 11211.495482703134, 11367.488463019019, 11595.420228988349, 11663.300201987908, 10042.196624270187, 10186.796264074825, 10186.949065254626, 10187.43969081678, 10220.080192782685, 6850.588964662136, 6968.616726080114, 7016.122984626922, 7049.471289653399, 7067.293270672892, 6810.829729256809, 6857.245702972569, 6888.51780375389, 6917.688704008231, 7074.575525468488], "value": 6623.206869887296, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [497.52464317081166, 500.3058529816937, 518.8443466959911, 525.5375269762608, 527.1670760198887, 6239.658473428212, 6320.431161195492, 6341.0, 6343.0, 6357.586756860806, 6317.77887773928, 6334.714937827797, 6335.714892829822, 6355.887719649066, 6398.584092034026, 5253.686578355401, 5260.605454590902, 5280.524752772269, 5280.788768449257, 5322.33470816148, 4888.853334399973, 5213.218017297398, 5224.969517679737, 5294.470552944713, 5308.734563271841, 4974.850754477371, 4984.152694042022, 5000.47495013022, 5005.599552035828, 5006.749662516878, 4958.776855041532, 5012.974935125338, 5021.974890125544, 5029.321041659366, 5063.696178229281, 4375.474943006828, 4488.079943611552, 4511.390962220124, 4512.864614061584, 4531.297648864432, 6132.172156758825, 6168.753249870045, 6177.96911015442, 6191.944276498901, 6201.658908760016, 5715.685637289947, 5719.25649665545, 5730.77076916927, 5754.625949313323, 5771.797987070432, 6639.269680335159, 6648.0, 6660.333966603349, 6667.699953502104, 6677.432418244455, 4680.765961701935, 4906.1168989581865, 4921.532454416824, 4931.988942266863, 4943.678660887067, 6746.797596072126, 6846.691898864563, 6876.553024053421, 6880.591792872505, 6913.619750913697, 4976.601871850244, 4996.5003499650475, 5011.298418221452, 5017.874553136127, 5043.344365232496, 5041.470645582234, 5077.796888124433, 5096.286519887219, 5100.5409513143995, 5105.846824595268, 5645.379008309083, 5647.463490968352, 5685.60200785941, 5695.7152142392715, 5704.971475142681, 6584.144061272004, 6645.06969024337, 6648.966755166193, 6668.633225172565, 6701.631410272482, 1752.835248468141, 1761.6036391811997, 1763.897564022486, 1775.7869055713138, 1779.9911000444915, 1153.4809335798925, 1208.6253261488966, 1215.4651953140767, 1219.737756382382, 1221.975560488803, 5670.149477578396, 5694.658320500783, 5716.914246286309, 5730.169125476783, 5749.88500229993, 6700.195976482853, 6703.22912865017, 6717.0, 6740.393364597112, 6746.763863264762, 5574.219609254707, 5601.7759289628775, 5624.775008999594, 5711.858053230038, 5714.542836573064, 3458.325626502858, 3464.9653503465147, 3568.57177138745, 3583.6595523425235, 3586.8923932282073, 6325.240971083407, 6460.644664543495, 6498.837529061717, 6507.006776882592, 6527.673616319165, 6615.801525954229, 6653.236892223565, 6767.375829800812, 6773.8645227095185, 6850.862982740317, 5996.910046349309, 6347.365843175123, 6390.360963903759, 6482.254540727782, 6500.0, 6503.739850405931, 6565.883799754149, 6575.638339891352, 6590.308017658077, 6629.171353580802, 6533.346665333619, 6553.0, 6586.538942274186, 6719.42093607992, 6720.361565651256, 6399.456046236122, 6401.64790936503, 6403.455706265019, 6456.322086181071, 6459.0, 4960.0, 4997.225430058346, 5025.271335656236, 5052.332730198952, 5055.772490238021, 6486.740530378732, 6551.967240163769, 6730.259671436236, 6732.932670673231, 6795.762148324785, 6303.747850085945, 6338.619682819046, 6408.628807341313, 6489.059086432535, 6505.739770409131, 6382.585131966407, 6441.3880681335195, 6470.38531339522, 6473.417392434703, 6515.771947981798, 6396.42432181106, 6416.197975253093, 6426.325235850169, 6444.581102228341, 6485.487335764751, 6461.353864613501, 6474.1907261592305, 6568.8357791053695, 6590.5716128451495, 6600.108985287116, 6313.936860631518, 6415.166028416276, 6418.358164183544, 6421.454176394872, 6452.257990331172], "value": 5061.288297795132, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [891.1534042659475, 914.0722167000494, 918.5223683684483, 922.3589605224372, 926.1895841139, 17945.82054179458, 18671.626567468644, 18826.905865470653, 18839.434816955498, 22570.322890313277, 21873.781262187375, 22140.778592214072, 22163.445913852163, 22171.778282217172, 22218.444538886535, 987.2398253344938, 996.7757254617726, 1001.4191768774093, 1001.8346972749488, 1002.7994401119769, 954.8233576788316, 975.9853602195973, 985.866907967426, 995.069609914732, 997.0627610046533, 1039.5581877701984, 1047.4082143588848, 1048.35002298575, 1048.4024106259435, 1049.8110340138771, 1037.6731329631143, 1041.2190856857358, 1041.817681905671, 1045.675840489443, 1046.691226088302, 763.6678045050365, 768.4851149729694, 769.8845173224005, 770.1220608506308, 772.0927909706073, 18968.715469267972, 20291.594168116702, 20547.48631284215, 20593.0, 20681.172753089857, 21753.0, 21823.236186733546, 22400.32799016016, 22416.88791556048, 22437.55124897493, 16329.428470003611, 16408.09755463449, 16434.096124713134, 16545.586360340967, 16572.0, 3662.7069834413182, 3697.186618943828, 3697.334479793636, 3697.352963231424, 3701.8889433317045, 143539.28230358887, 144534.0, 144923.0, 145764.0, 147891.0, 16436.671266574842, 16578.088205148833, 16789.832101679072, 16877.15614219284, 16975.405860794814, 31634.0, 31645.52531712026, 31688.841555792536, 31729.206769830478, 31795.84102079475, 8617.0, 8680.30557555394, 8822.51476168817, 8851.69019084329, 8878.712586675025, 3834.2523207974737, 3914.412838074312, 3916.118873253495, 3917.8824635260416, 3930.272899513599, 4953.6037117030555, 5214.582833373321, 5228.163493840967, 5958.582899197015, 6127.693615319216, 1156.8843115688533, 1173.2198088271375, 1176.206060908883, 1191.5174354386488, 1192.66605350502, 618.6133666458463, 636.926753423353, 639.3829954094322, 640.8301800022998, 648.3419329380682, 12307.323097229559, 12526.373681315898, 12767.170133941265, 13285.535006274735, 13389.19664820114, 628.9182406287154, 631.4727202785633, 641.1120597971842, 646.4279112985042, 648.3484098480997, 5796.188533605298, 5870.853228669317, 5910.290765108214, 5926.081457374114, 5999.520038397005, 126180.36909815576, 126200.36899815442, 126390.36804815917, 127398.45203096072, 132200.0, 107942.0, 108948.19466248076, 109045.0, 109105.45447272713, 113762.43118784353, 96298.51850740702, 97475.0, 97679.51160244153, 98373.50813246031, 99648.0, 10617.89382106169, 10838.187135964992, 10973.670789876316, 11047.944760276469, 11061.889381106086, 44190.779046104566, 45818.770906145255, 45836.54163458323, 46471.07057858756, 47450.52549474461, 56464.0, 57641.0, 58142.4185758137, 59585.702071489366, 60499.0, 16210.756838647194, 16252.837471625133, 16369.42707005249, 16394.83605163933, 16537.83462165363, 17239.3966211182, 17586.472405827844, 17601.911990439967, 17621.735673964646, 17821.910890445466, 17033.40383086586, 17216.827831721523, 17236.310547578458, 17453.214605343044, 17462.650746985244, 16246.512604621881, 16308.26612802403, 16315.265813038679, 16495.0, 16627.75058374101, 16115.838841611903, 16477.91761041187, 16490.587735306235, 16518.917405412896, 16693.499195024167, 11333.206675532634, 11498.82751758741, 11630.244034137753, 11671.299722016705, 11672.941635291769, 12409.441575129322, 12565.623031309075, 12665.240085594525, 12712.745745084861, 12769.74460510766], "value": 9122.71661052908, "unit": "score"}]}, {"extraOptions": ["e10s", "stylo_disabled"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1419.9, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [108.0, 106.0, 106.0, 108.0, 107.0, 106.0, 109.0, 106.0, 107.0, 108.0], "value": 107.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 120.0, 119.0, 116.0, 118.0, 115.0, 142.0, 115.0, 115.0, 116.0], "value": 119.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 162.0, 161.0, 163.0, 162.0, 162.0, 162.0, 170.0, 164.0, 164.0], "value": 163.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 75.0, 76.0, 76.0, 78.0, 73.0, 73.0, 74.0, 74.0, 75.0], "value": 74.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 78.0, 78.0, 78.0, 79.0, 79.0, 79.0, 80.0, 79.0, 79.0], "value": 78.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 114.0, 114.0, 114.0, 114.0, 114.0, 112.0, 115.0, 116.0, 113.0], "value": 114.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 149.0, 150.0, 147.0, 148.0, 147.0, 147.0, 149.0, 149.0, 151.0], "value": 149.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 94.0, 94.0, 93.0, 94.0, 94.0, 94.0, 94.0, 94.0, 95.0], "value": 93.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 53.0, 54.0, 53.0, 54.0, 54.0, 53.0, 53.0, 54.0, 50.0], "value": 53.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [38.0, 38.0, 39.0, 38.0, 38.0, 38.0, 38.0, 39.0, 39.0, 38.0], "value": 38.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 75.0, 74.0, 77.0, 79.0, 76.0, 75.0, 74.0, 75.0, 74.0], "value": 75.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 112.0, 111.0, 115.0, 113.0, 113.0, 113.0, 121.0, 125.0, 117.0], "value": 115.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [171.0, 168.0, 168.0, 166.0, 172.0, 168.0, 170.0, 170.0, 170.0, 167.0], "value": 169.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 67.0, 71.0, 65.0, 66.0, 67.0, 66.0, 67.0, 66.0, 72.0], "value": 67.9, "unit": "score"}]}]} 11:41:03 INFO - Return code: 0 11:41:03 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 11:41:03 INFO - # TBPL SUCCESS # 11:41:03 INFO - Running post-action listener: _package_coverage_data 11:41:03 INFO - Running post-action listener: _resource_record_post_action 11:41:03 INFO - [mozharness: 2017-09-19 18:41:03.897626Z] Finished run-tests step (success) 11:41:03 INFO - Running post-run listener: _resource_record_post_run 11:41:03 INFO - Total resource usage - Wall time: 1192s; CPU: 13.0%; Read bytes: 8892416; Write bytes: 529948672; Read time: 3228; Write time: 773960 11:41:03 INFO - TinderboxPrint: CPU usage
13.1% 11:41:03 INFO - TinderboxPrint: I/O read bytes / time
8,892,416 / 3,228 11:41:03 INFO - TinderboxPrint: I/O write bytes / time
529,948,672 / 773,960 11:41:03 INFO - TinderboxPrint: CPU idle
8,253.2 (86.8%) 11:41:03 INFO - TinderboxPrint: CPU user
1,192.1 (12.5%) 11:41:03 INFO - TinderboxPrint: Swap in / out
0 / 0 11:41:03 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 87609344; Read time: 0; Write time: 95608 11:41:03 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 11:41:03 INFO - run-tests - Wall time: 1174s; CPU: 13.0%; Read bytes: 6701056; Write bytes: 385466368; Read time: 2716; Write time: 599732 11:41:04 INFO - Running post-run listener: _upload_blobber_files 11:41:04 INFO - Blob upload gear active. 11:41:04 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 11:41:04 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 11:41:04 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'] 11:41:04 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 11:41:04 INFO - (blobuploader) - INFO - Open directory for files ... 11:41:04 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 11:41:04 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:41:04 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:41:11 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 11:41:11 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:41:11 INFO - (blobuploader) - INFO - Done attempting. 11:41:11 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_errorsummary.log ... 11:41:11 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:41:11 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:41:12 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-stylo-disabled-e10s_errorsummary.log: uploaded 11:41:12 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:41:12 INFO - (blobuploader) - INFO - Done attempting. 11:41:12 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 11:41:12 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:41:12 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:41:13 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 11:41:13 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:41:13 INFO - (blobuploader) - INFO - Done attempting. 11:41:13 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_raw.log ... 11:41:13 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:41:13 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:41:14 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-stylo-disabled-e10s_raw.log: uploaded 11:41:14 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:41:14 INFO - (blobuploader) - INFO - Done attempting. 11:41:14 INFO - (blobuploader) - INFO - Iteration through files over. 11:41:14 INFO - Return code: 0 11:41:14 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 11:41:14 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 11:41:14 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/6a78421316624f040b046aa8b14a34f04c21f1d669a9373d751551cad0a87f7b6b4e6400ddcd959a47399a9bdf148ef9762d1d2ac8e95c716fd630e704e8a8a4", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/b1575ebfcf1391e0466c870441f9b88201d03a3a0748fd090f67db9498ffa6a0c5f7d5018a12035b377c5a55ea1d738224a42305c48e4846bed99f969d954207", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/09497ff15dbc7c398f4702dfe1dc0755c75a63478065417570d000a6f21c51a1da748a44bba9d643924d594fc9ca3e6348f39caf2b4a7d228cf49ac337dc5fd1", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/23f5793a651278234bf5fc5cdd45485776b085854b56111b06baa36a2489b23c5c714a3d9b1e961588dae3fff696c628d085aad2ac33d70af2035bdb6cee131f"} 11:41:14 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 11:41:14 INFO - Writing to file /builds/slave/test/properties/blobber_files 11:41:14 INFO - Contents: 11:41:14 INFO - blobber_files:{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/6a78421316624f040b046aa8b14a34f04c21f1d669a9373d751551cad0a87f7b6b4e6400ddcd959a47399a9bdf148ef9762d1d2ac8e95c716fd630e704e8a8a4", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/b1575ebfcf1391e0466c870441f9b88201d03a3a0748fd090f67db9498ffa6a0c5f7d5018a12035b377c5a55ea1d738224a42305c48e4846bed99f969d954207", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/09497ff15dbc7c398f4702dfe1dc0755c75a63478065417570d000a6f21c51a1da748a44bba9d643924d594fc9ca3e6348f39caf2b4a7d228cf49ac337dc5fd1", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/23f5793a651278234bf5fc5cdd45485776b085854b56111b06baa36a2489b23c5c714a3d9b1e961588dae3fff696c628d085aad2ac33d70af2035bdb6cee131f"} 11:41:14 INFO - Running post-run listener: copy_logs_to_upload_dir 11:41:14 INFO - Copying logs to upload dir... 11:41:14 INFO - mkdir: /builds/slave/test/build/upload/logs 11:41:14 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1247.723823 ========= master_lag: 0.06 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 47 secs) (at 2017-09-19 11:41:15.052286) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-19 11:41:15.060205) ========= 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=af724c981e2a0f424dbabf99000001e7-1505839810.393748-2053307589 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/6a78421316624f040b046aa8b14a34f04c21f1d669a9373d751551cad0a87f7b6b4e6400ddcd959a47399a9bdf148ef9762d1d2ac8e95c716fd630e704e8a8a4", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/b1575ebfcf1391e0466c870441f9b88201d03a3a0748fd090f67db9498ffa6a0c5f7d5018a12035b377c5a55ea1d738224a42305c48e4846bed99f969d954207", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/09497ff15dbc7c398f4702dfe1dc0755c75a63478065417570d000a6f21c51a1da748a44bba9d643924d594fc9ca3e6348f39caf2b4a7d228cf49ac337dc5fd1", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/23f5793a651278234bf5fc5cdd45485776b085854b56111b06baa36a2489b23c5c714a3d9b1e961588dae3fff696c628d085aad2ac33d70af2035bdb6cee131f"} build_url:https://queue.taskcluster.net/v1/task/L7l39DLCQeO5S_9KbepNFA/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011314 build_url: 'https://queue.taskcluster.net/v1/task/L7l39DLCQeO5S_9KbepNFA/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/6a78421316624f040b046aa8b14a34f04c21f1d669a9373d751551cad0a87f7b6b4e6400ddcd959a47399a9bdf148ef9762d1d2ac8e95c716fd630e704e8a8a4", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/b1575ebfcf1391e0466c870441f9b88201d03a3a0748fd090f67db9498ffa6a0c5f7d5018a12035b377c5a55ea1d738224a42305c48e4846bed99f969d954207", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/09497ff15dbc7c398f4702dfe1dc0755c75a63478065417570d000a6f21c51a1da748a44bba9d643924d594fc9ca3e6348f39caf2b4a7d228cf49ac337dc5fd1", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/23f5793a651278234bf5fc5cdd45485776b085854b56111b06baa36a2489b23c5c714a3d9b1e961588dae3fff696c628d085aad2ac33d70af2035bdb6cee131f"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-19 11:41:15.091356) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-19 11:41:15.091674) ========= 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=af724c981e2a0f424dbabf99000001e7-1505839810.393748-2053307589 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004431 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-19 11:41:15.176944) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-19 11:41:15.177249) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-19 11:41:15.177609) ========= ========= Total master_lag: 0.31 =========