builder: mozilla-central_ubuntu64_hw_qr_test-dromaeojs-e10s slave: talos-linux64-ix-049 starttime: 1504980998.99 results: success (0) revision: 21699515e84bc218b3a963f4af426a9ed7c7f8a4 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-09-09 11:16:38.987951) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-09-09 11:16:38.988410) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-09 11:16:38.988683) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-09 11:16:39.006624) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-09 11:16:39.006995) ========= 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=db7e7c15f3ca076d53731445000001ba-1504980998.160841-336240873 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-09-09 11:16:39-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 46.9M=0s 2017-09-09 11:16:39 (46.9 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.089212 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-09 11:16:39.112865) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-09 11:16:39.113197) ========= 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=db7e7c15f3ca076d53731445000001ba-1504980998.160841-336240873 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019298 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-09 11:16:39.163037) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-09-09 11:16:39.163367) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 21699515e84bc218b3a963f4af426a9ed7c7f8a4 --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 21699515e84bc218b3a963f4af426a9ed7c7f8a4 --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=db7e7c15f3ca076d53731445000001ba-1504980998.160841-336240873 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-09-09 11:16:39,214 truncating revision to first 12 chars 2017-09-09 11:16:39,214 Setting DEBUG logging. 2017-09-09 11:16:39,214 attempt 1/10 2017-09-09 11:16:39,214 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/21699515e84b?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-09-09 11:16:40,408 unpacking tar archive at: mozilla-central-21699515e84b/testing/mozharness/ program finished with exit code 0 elapsedTime=1.518191 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-09-09 11:16:40.697809) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-09 11:16:40.698126) ========= script_repo_revision: 21699515e84bc218b3a963f4af426a9ed7c7f8a4 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-09 11:16:40.698503) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-09 11:16:40.698790) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-09 11:16:40.711448) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 42 secs) (at 2017-09-09 11:16:40.711810) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=db7e7c15f3ca076d53731445000001ba-1504980998.160841-336240873 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 11:16:40 INFO - MultiFileLogger online at 20170909 11:16:40 in /builds/slave/test 11:16:40 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 11:16:40 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 11:16:40 INFO - {'append_to_log': False, 11:16:40 INFO - 'base_work_dir': '/builds/slave/test', 11:16:40 INFO - 'blob_upload_branch': 'Firefox', 11:16:40 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 11:16:40 INFO - 'branch': 'Firefox', 11:16:40 INFO - 'buildbot_json_path': 'buildprops.json', 11:16:40 INFO - 'code_coverage': False, 11:16:40 INFO - 'config_files': ('talos/linux_config.py',), 11:16:40 INFO - 'default_actions': ('clobber', 11:16:40 INFO - 'read-buildbot-config', 11:16:40 INFO - 'download-and-extract', 11:16:40 INFO - 'populate-webroot', 11:16:40 INFO - 'create-virtualenv', 11:16:40 INFO - 'install', 11:16:40 INFO - 'setup-mitmproxy', 11:16:40 INFO - 'run-tests'), 11:16:40 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 11:16:40 INFO - 'disable_ccov_upload': False, 11:16:40 INFO - 'disable_stylo': False, 11:16:40 INFO - 'download_minidump_stackwalk': True, 11:16:40 INFO - 'download_symbols': 'ondemand', 11:16:40 INFO - 'enable_stylo': False, 11:16:40 INFO - 'enable_webrender': False, 11:16:40 INFO - 'exes': {'tooltool.py': '/tools/tooltool.py'}, 11:16:40 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 11:16:40 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 11:16:40 INFO - 'gecko_profile': False, 11:16:40 INFO - 'gecko_profile_interval': 0, 11:16:40 INFO - 'installer_path': 'installer.exe', 11:16:40 INFO - 'log_level': 'info', 11:16:40 INFO - 'log_name': 'talos', 11:16:40 INFO - 'log_to_console': True, 11:16:40 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 11:16:40 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 11:16:40 INFO - 'opt_config_files': (), 11:16:40 INFO - 'pip_index': False, 11:16:40 INFO - 'suite': 'dromaeojs-e10s', 11:16:40 INFO - 'system_bits': '32', 11:16:40 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 11:16:40 INFO - 'title': 'talos-linux64-ix-049', 11:16:40 INFO - 'tooltool_cache': '/builds/tooltool_cache', 11:16:40 INFO - 'use_talos_json': True, 11:16:40 INFO - 'verify': 'False', 11:16:40 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 11:16:40 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 11:16:40 INFO - 'work_dir': 'build'} 11:16:40 INFO - [mozharness: 2017-09-09 18:16:40.907551Z] Running clobber step. 11:16:40 INFO - Running pre-action listener: _resource_record_pre_action 11:16:40 INFO - Running main action method: clobber 11:16:40 INFO - rmtree: /builds/slave/test/build 11:16:40 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 11:16:41 INFO - Running post-action listener: _resource_record_post_action 11:16:41 INFO - [mozharness: 2017-09-09 18:16:41.979064Z] Finished clobber step (success) 11:16:41 INFO - [mozharness: 2017-09-09 18:16:41.979161Z] Running read-buildbot-config step. 11:16:41 INFO - Running pre-action listener: _resource_record_pre_action 11:16:41 INFO - Running main action method: read_buildbot_config 11:16:41 INFO - Using buildbot properties: 11:16:41 INFO - { 11:16:41 INFO - "project": "", 11:16:41 INFO - "product": "firefox", 11:16:41 INFO - "who": "ffxbld@noreply.mozilla.org", 11:16:41 INFO - "installer_path": "public/build/target.tar.bz2", 11:16:41 INFO - "builddir": "mozilla-central_ubuntu64_hw_qr_test-dromaeojs-e10s", 11:16:41 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 11:16:41 INFO - "buildername": "Ubuntu HW 12.04 x64 qr mozilla-central talos dromaeojs-e10s", 11:16:41 INFO - "stage_platform": "linux64-qr", 11:16:41 INFO - "basedir": "/builds/slave/test", 11:16:41 INFO - "buildnumber": 41, 11:16:41 INFO - "platform": "ubuntu64_hw_qr", 11:16:41 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 11:16:41 INFO - "slavebuilddir": "test", 11:16:41 INFO - "taskId": "DKtYf9poRnuQGFJN48ub7w", 11:16:41 INFO - "branch": "mozilla-central", 11:16:41 INFO - "script_repo_revision": "production", 11:16:41 INFO - "revision": "21699515e84bc218b3a963f4af426a9ed7c7f8a4", 11:16:41 INFO - "slavename": "talos-linux64-ix-049", 11:16:41 INFO - "repo_path": "mozilla-central" 11:16:41 INFO - } 11:16:41 INFO - Finding installer, test and symbols from parent task. 11:16:41 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/DKtYf9poRnuQGFJN48ub7w'}, attempt #1 11:16:42 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/DKtYf9poRnuQGFJN48ub7w'}, attempt #1 11:16:42 INFO - Task dependencies: TzHGlhiiRQCEEVlLYRX_gg 11:16:42 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/TzHGlhiiRQCEEVlLYRX_gg'}, attempt #1 11:16:43 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/TzHGlhiiRQCEEVlLYRX_gg/artifacts/public/build/target.tar.bz2 11:16:43 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/TzHGlhiiRQCEEVlLYRX_gg/artifacts/public/build/target.test_packages.json 11:16:43 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/TzHGlhiiRQCEEVlLYRX_gg/artifacts/public/build/target.crashreporter-symbols.zip 11:16:43 INFO - Running post-action listener: _resource_record_post_action 11:16:43 INFO - [mozharness: 2017-09-09 18:16:43.364729Z] Finished read-buildbot-config step (success) 11:16:43 INFO - [mozharness: 2017-09-09 18:16:43.364947Z] Running download-and-extract step. 11:16:43 INFO - Running pre-action listener: _resource_record_pre_action 11:16:43 INFO - Running main action method: download_and_extract 11:16:43 INFO - mkdir: /builds/slave/test/build/tests 11:16:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:16:43 INFO - trying https://queue.taskcluster.net/v1/task/TzHGlhiiRQCEEVlLYRX_gg/artifacts/public/build/target.test_packages.json 11:16:43 INFO - Downloading https://queue.taskcluster.net/v1/task/TzHGlhiiRQCEEVlLYRX_gg/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 11:16:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/TzHGlhiiRQCEEVlLYRX_gg/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 11:16:43 INFO - Downloaded 989 bytes. 11:16:43 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 11:16:43 INFO - Using the following test package requirements: 11:16:43 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 11:16:43 INFO - u'common': [u'target.common.tests.zip'], 11:16:43 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 11:16:43 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 11:16:43 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 11:16:43 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 11:16:43 INFO - u'mozbase': [u'target.common.tests.zip'], 11:16:43 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 11:16:43 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 11:16:43 INFO - u'web-platform': [u'target.common.tests.zip', 11:16:43 INFO - u'target.web-platform.tests.tar.gz'], 11:16:43 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 11:16:43 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite categories: ['common', 'talos'] 11:16:43 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/TzHGlhiiRQCEEVlLYRX_gg/artifacts/public/build/target.common.tests.zip 11:16:43 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/TzHGlhiiRQCEEVlLYRX_gg/artifacts/public/build/target.common.tests.zip'}, attempt #1 11:16:43 INFO - Fetch https://queue.taskcluster.net/v1/task/TzHGlhiiRQCEEVlLYRX_gg/artifacts/public/build/target.common.tests.zip into memory 11:16:45 INFO - Content-Length response header: 55024757 11:16:45 INFO - Bytes received: 55024757 11:16:56 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/TzHGlhiiRQCEEVlLYRX_gg/artifacts/public/build/target.talos.tests.zip 11:16:56 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/TzHGlhiiRQCEEVlLYRX_gg/artifacts/public/build/target.talos.tests.zip'}, attempt #1 11:16:56 INFO - Fetch https://queue.taskcluster.net/v1/task/TzHGlhiiRQCEEVlLYRX_gg/artifacts/public/build/target.talos.tests.zip into memory 11:16:56 INFO - Content-Length response header: 14497963 11:16:56 INFO - Bytes received: 14497963 11:16:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:16:57 INFO - trying https://queue.taskcluster.net/v1/task/TzHGlhiiRQCEEVlLYRX_gg/artifacts/public/build/target.tar.bz2 11:16:57 INFO - Downloading https://queue.taskcluster.net/v1/task/TzHGlhiiRQCEEVlLYRX_gg/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 11:16:57 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/TzHGlhiiRQCEEVlLYRX_gg/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 11:16:58 INFO - Downloaded 62922539 bytes. 11:16:58 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/TzHGlhiiRQCEEVlLYRX_gg/artifacts/public/build/target.tar.bz2 11:16:58 INFO - mkdir: /builds/slave/test/properties 11:16:58 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 11:16:58 INFO - Writing to file /builds/slave/test/properties/build_url 11:16:58 INFO - Contents: 11:16:58 INFO - build_url:https://queue.taskcluster.net/v1/task/TzHGlhiiRQCEEVlLYRX_gg/artifacts/public/build/target.tar.bz2 11:16:58 INFO - Running post-action listener: _resource_record_post_action 11:16:58 INFO - Running post-action listener: find_tests_for_verification 11:16:58 INFO - Running post-action listener: set_extra_try_arguments 11:16:58 INFO - [mozharness: 2017-09-09 18:16:58.315752Z] Finished download-and-extract step (success) 11:16:58 INFO - [mozharness: 2017-09-09 18:16:58.315850Z] Running populate-webroot step. 11:16:58 INFO - Running pre-action listener: _resource_record_pre_action 11:16:58 INFO - Running main action method: populate_webroot 11:16:58 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 11:16:58 INFO - 'chromez-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 11:16:58 INFO - 'tests': ['tresize', 11:16:58 INFO - 'tcanvasmark']}, 11:16:58 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 11:16:58 INFO - 'dromaeojs-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 11:16:58 INFO - 'tests': ['dromaeo_css', 11:16:58 INFO - 'kraken']}, 11:16:58 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 11:16:58 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:16:58 INFO - 'g1-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 11:16:58 INFO - 'talos_options': ['--disable-stylo'], 11:16:58 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:16:58 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 11:16:58 INFO - 'tests': ['damp', 'tps']}, 11:16:58 INFO - 'g2-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 11:16:58 INFO - 'talos_options': ['--disable-stylo'], 11:16:58 INFO - 'tests': ['damp', 'tps']}, 11:16:58 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 11:16:58 INFO - 'g3-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 11:16:58 INFO - 'tests': ['dromaeo_dom']}, 11:16:58 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 11:16:58 INFO - 'g4-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 11:16:58 INFO - 'tests': ['basic_compositor_video', 11:16:58 INFO - 'glvideo']}, 11:16:58 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 11:16:58 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 11:16:58 INFO - 'g5-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 11:16:58 INFO - 'talos_options': ['--disable-stylo'], 11:16:58 INFO - 'tests': ['ts_paint_webext', 11:16:58 INFO - 'tp5o_webext']}, 11:16:58 INFO - 'other-e10s': {'tests': ['a11yr', 11:16:58 INFO - 'ts_paint', 11:16:58 INFO - 'tpaint', 11:16:58 INFO - 'sessionrestore', 11:16:58 INFO - 'sessionrestore_many_windows', 11:16:58 INFO - 'sessionrestore_no_auto_restore', 11:16:58 INFO - 'tabpaint']}, 11:16:58 INFO - 'other-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 11:16:58 INFO - 'tests': ['a11yr', 11:16:58 INFO - 'ts_paint', 11:16:58 INFO - 'tpaint', 11:16:58 INFO - 'sessionrestore', 11:16:58 INFO - 'sessionrestore_many_windows', 11:16:58 INFO - 'sessionrestore_no_auto_restore', 11:16:58 INFO - 'tabpaint']}, 11:16:58 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 11:16:58 INFO - 'perf-reftest-singletons-e10s': {'tests': ['bloom_basic_singleton']}, 11:16:58 INFO - 'perf-reftest-singletons-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 11:16:58 INFO - 'tests': ['bloom_basic_singleton']}, 11:16:58 INFO - 'perf-reftest-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 11:16:58 INFO - 'tests': ['bloom_basic']}, 11:16:58 INFO - 'svgr-e10s': {'tests': ['tsvgx', 11:16:58 INFO - 'tsvgr_opacity', 11:16:58 INFO - 'tart', 11:16:58 INFO - 'tscrollx', 11:16:58 INFO - 'tsvg_static']}, 11:16:58 INFO - 'svgr-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 11:16:58 INFO - 'tests': ['tsvgx', 11:16:58 INFO - 'tsvgr_opacity', 11:16:58 INFO - 'tart', 11:16:58 INFO - 'tscrollx', 11:16:58 INFO - 'tsvg_static']}, 11:16:58 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 11:16:58 INFO - 'tp5o-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 11:16:58 INFO - 'talos_options': ['--disable-stylo'], 11:16:58 INFO - 'tests': ['tp5o']}, 11:16:58 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 11:16:58 INFO - 'talos_options': ['--mitmproxy', 11:16:58 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 11:16:58 INFO - '--firstNonBlankPaint'], 11:16:58 INFO - 'tests': ['tp6_google', 11:16:58 INFO - 'tp6_youtube', 11:16:58 INFO - 'tp6_amazon', 11:16:58 INFO - 'tp6_facebook']}, 11:16:58 INFO - 'tp6-stylo-disabled-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 11:16:58 INFO - 'talos_options': ['--disable-stylo', 11:16:58 INFO - '--mitmproxy', 11:16:58 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 11:16:58 INFO - '--firstNonBlankPaint'], 11:16:58 INFO - 'tests': ['tp6_google', 11:16:58 INFO - 'tp6_youtube', 11:16:58 INFO - 'tp6_amazon', 11:16:58 INFO - 'tp6_facebook']}, 11:16:58 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 11:16:58 INFO - 'talos_options': ['--stylo-threads=1', 11:16:58 INFO - '--mitmproxy', 11:16:58 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 11:16:58 INFO - '--firstNonBlankPaint'], 11:16:58 INFO - 'tests': ['tp6_google', 11:16:58 INFO - 'tp6_youtube', 11:16:58 INFO - 'tp6_amazon', 11:16:58 INFO - 'tp6_facebook']}, 11:16:58 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 11:16:58 INFO - 'talos_options': ['--xperf_path', 11:16:58 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:16:58 INFO - 'tests': ['tp5n']}, 11:16:58 INFO - 'xperf-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 11:16:58 INFO - 'talos_options': ['--disable-stylo', 11:16:58 INFO - '--xperf_path', 11:16:58 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:16:58 INFO - 'tests': ['tp5n']}}} 11:16:58 INFO - Running post-action listener: _resource_record_post_action 11:16:58 INFO - [mozharness: 2017-09-09 18:16:58.330669Z] Finished populate-webroot step (success) 11:16:58 INFO - [mozharness: 2017-09-09 18:16:58.330759Z] Running create-virtualenv step. 11:16:58 INFO - Running pre-action listener: _resource_record_pre_action 11:16:58 INFO - Running main action method: create_virtualenv 11:16:58 INFO - Creating virtualenv /builds/slave/test/build/venv 11:16:58 INFO - Running command: ['virtualenv', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 11:16:58 INFO - Copy/paste: virtualenv --no-site-packages --distribute /builds/slave/test/build/venv 11:16:58 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 11:16:58 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 11:16:58 INFO - New python executable in /builds/slave/test/build/venv/bin/python 11:16:58 INFO - Installing distribute.............................................................................................................................................................................................done. 11:16:59 INFO - Installing pip...............done. 11:16:59 INFO - Return code: 0 11:16:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 11:16:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 11:16:59 INFO - Reading from file tmpfile_stdout 11:16:59 INFO - Output received: 11:16:59 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:16:59 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 11:16: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:16:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:16: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:16:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:16: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22941f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x245da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2600a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2604090>, '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 0x2604d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25fef90>, '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': 'db7e7c15f3ca076d53731445000001ba-1504980998.160841-336240873', '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:16: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', 'pip>=1.5'] in /builds/slave/test/build 11:16: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 pip>=1.5 11:16:59 INFO - Using env: {'DISPLAY': ':0', 11:16:59 INFO - 'HOME': '/home/cltbld', 11:16:59 INFO - 'LANG': 'en_US.UTF-8', 11:16:59 INFO - 'LANGUAGE': 'en_US:en', 11:16:59 INFO - 'LOGNAME': 'cltbld', 11:16:59 INFO - 'MAIL': '/var/mail/cltbld', 11:16:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:16:59 INFO - 'MOZ_NO_REMOTE': '1', 11:16:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:16:59 INFO - 'NO_EM_RESTART': '1', 11:16:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:16:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:16:59 INFO - 'PWD': '/builds/slave/test', 11:16:59 INFO - 'SHELL': '/bin/bash', 11:16:59 INFO - 'SHLVL': '1', 11:16:59 INFO - 'TERM': 'linux', 11:16:59 INFO - 'TMOUT': '86400', 11:16:59 INFO - 'USER': 'cltbld', 11:16:59 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1504980998.160841-336240873', 11:16:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:16:59 INFO - '_': '/tools/buildbot/bin/python'} 11:17:00 INFO - Ignoring indexes: http://pypi.python.org/simple/ 11:17:00 INFO - Downloading/unpacking pip>=1.5 11:17:00 INFO - Running setup.py egg_info for package pip 11:17:00 INFO - warning: no files found matching 'pip/cacert.pem' 11:17:00 INFO - warning: no files found matching '*.html' under directory 'docs' 11:17:00 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 11:17:00 INFO - no previously-included directories found matching 'docs/_build/_sources' 11:17:00 INFO - Installing collected packages: pip 11:17:00 INFO - Found existing installation: pip 1.1 11:17:00 INFO - Uninstalling pip: 11:17:00 INFO - Successfully uninstalled pip 11:17:00 INFO - Running setup.py install for pip 11:17:00 INFO - warning: no files found matching 'pip/cacert.pem' 11:17:00 INFO - warning: no files found matching '*.html' under directory 'docs' 11:17:00 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 11:17:00 INFO - no previously-included directories found matching 'docs/_build/_sources' 11:17:00 INFO - Installing pip script to /builds/slave/test/build/venv/bin 11:17:00 INFO - Installing pip2.7 script to /builds/slave/test/build/venv/bin 11:17:00 INFO - Installing pip2 script to /builds/slave/test/build/venv/bin 11:17:00 INFO - Successfully installed pip 11:17:00 INFO - Cleaning up... 11:17:00 INFO - Return code: 0 11:17:00 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 11:17:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:17:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:17:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:17:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:17:00 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x22941f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x245da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2600a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2604090>, '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 0x2604d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25fef90>, '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': 'db7e7c15f3ca076d53731445000001ba-1504980998.160841-336240873', '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:17:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 11:17:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 11:17:00 INFO - Using env: {'DISPLAY': ':0', 11:17:00 INFO - 'HOME': '/home/cltbld', 11:17:00 INFO - 'LANG': 'en_US.UTF-8', 11:17:00 INFO - 'LANGUAGE': 'en_US:en', 11:17:00 INFO - 'LOGNAME': 'cltbld', 11:17:00 INFO - 'MAIL': '/var/mail/cltbld', 11:17:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:17:00 INFO - 'MOZ_NO_REMOTE': '1', 11:17:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:17:00 INFO - 'NO_EM_RESTART': '1', 11:17:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:17:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:17:00 INFO - 'PWD': '/builds/slave/test', 11:17:00 INFO - 'SHELL': '/bin/bash', 11:17:00 INFO - 'SHLVL': '1', 11:17:00 INFO - 'TERM': 'linux', 11:17:00 INFO - 'TMOUT': '86400', 11:17:00 INFO - 'USER': 'cltbld', 11:17:00 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1504980998.160841-336240873', 11:17:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:17:00 INFO - '_': '/tools/buildbot/bin/python'} 11:17:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:17:01 INFO - Downloading/unpacking psutil>=3.1.1 11:17: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:17: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:17: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:17: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:17:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 11:17:02 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:17:02 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:17:02 INFO - Installing collected packages: psutil 11:17:02 INFO - Running setup.py install for psutil 11:17:02 INFO - building 'psutil._psutil_linux' extension 11:17:02 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:17:02 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:17:02 INFO - building 'psutil._psutil_posix' extension 11:17:02 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:17:02 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:17:02 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:17:02 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:17:02 INFO - Successfully installed psutil 11:17:02 INFO - Cleaning up... 11:17:02 INFO - Return code: 0 11:17:02 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 11:17: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:17:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:17: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:17:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:17:02 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22941f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x245da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2600a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2604090>, '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 0x2604d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25fef90>, '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': 'db7e7c15f3ca076d53731445000001ba-1504980998.160841-336240873', '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:17:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 11:17:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 11:17:02 INFO - Using env: {'DISPLAY': ':0', 11:17:02 INFO - 'HOME': '/home/cltbld', 11:17:02 INFO - 'LANG': 'en_US.UTF-8', 11:17:02 INFO - 'LANGUAGE': 'en_US:en', 11:17:02 INFO - 'LOGNAME': 'cltbld', 11:17:02 INFO - 'MAIL': '/var/mail/cltbld', 11:17:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:17:02 INFO - 'MOZ_NO_REMOTE': '1', 11:17:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:17:02 INFO - 'NO_EM_RESTART': '1', 11:17:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:17:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:17:02 INFO - 'PWD': '/builds/slave/test', 11:17:02 INFO - 'SHELL': '/bin/bash', 11:17:02 INFO - 'SHLVL': '1', 11:17:02 INFO - 'TERM': 'linux', 11:17:02 INFO - 'TMOUT': '86400', 11:17:02 INFO - 'USER': 'cltbld', 11:17:02 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1504980998.160841-336240873', 11:17:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:17:02 INFO - '_': '/tools/buildbot/bin/python'} 11:17:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:17:03 INFO - Downloading/unpacking mozsystemmonitor==0.3 11:17:03 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:17:03 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:17:03 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:17:03 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:17:04 INFO - Downloading mozsystemmonitor-0.3.tar.gz 11:17:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 11:17:04 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 11:17:04 INFO - Installing collected packages: mozsystemmonitor 11:17:04 INFO - Running setup.py install for mozsystemmonitor 11:17:04 INFO - Successfully installed mozsystemmonitor 11:17:04 INFO - Cleaning up... 11:17:04 INFO - Return code: 0 11:17:04 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 11:17:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:17:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:17:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:17:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:17:04 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x22941f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x245da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2600a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2604090>, '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 0x2604d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25fef90>, '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': 'db7e7c15f3ca076d53731445000001ba-1504980998.160841-336240873', '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:17:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 11:17:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 11:17:04 INFO - Using env: {'DISPLAY': ':0', 11:17:04 INFO - 'HOME': '/home/cltbld', 11:17:04 INFO - 'LANG': 'en_US.UTF-8', 11:17:04 INFO - 'LANGUAGE': 'en_US:en', 11:17:04 INFO - 'LOGNAME': 'cltbld', 11:17:04 INFO - 'MAIL': '/var/mail/cltbld', 11:17:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:17:04 INFO - 'MOZ_NO_REMOTE': '1', 11:17:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:17:04 INFO - 'NO_EM_RESTART': '1', 11:17:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:17:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:17:04 INFO - 'PWD': '/builds/slave/test', 11:17:04 INFO - 'SHELL': '/bin/bash', 11:17:04 INFO - 'SHLVL': '1', 11:17:04 INFO - 'TERM': 'linux', 11:17:04 INFO - 'TMOUT': '86400', 11:17:04 INFO - 'USER': 'cltbld', 11:17:04 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1504980998.160841-336240873', 11:17:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:17:04 INFO - '_': '/tools/buildbot/bin/python'} 11:17:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:17:04 INFO - Downloading/unpacking jsonschema==2.5.1 11:17:04 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:17:04 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:17:04 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:17:04 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:17:05 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 11:17:05 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 11:17:05 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:17:05 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:17:05 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:17:05 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:17:05 INFO - Downloading functools32-3.2.3-2.tar.gz 11:17:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 11:17:05 INFO - warning: no files found matching '*.txt' 11:17:05 INFO - no previously-included directories found matching 'build' 11:17:05 INFO - no previously-included directories found matching 'dist' 11:17:05 INFO - no previously-included directories found matching '.git*' 11:17:05 INFO - Installing collected packages: jsonschema, functools32 11:17:06 INFO - Running setup.py install for functools32 11:17:06 INFO - warning: no files found matching '*.txt' 11:17:06 INFO - no previously-included directories found matching 'build' 11:17:06 INFO - no previously-included directories found matching 'dist' 11:17:06 INFO - no previously-included directories found matching '.git*' 11:17:06 INFO - Successfully installed jsonschema functools32 11:17:06 INFO - Cleaning up... 11:17:06 INFO - Return code: 0 11:17:06 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 11:17:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:17:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:17:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:17:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:17:06 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x22941f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x245da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2600a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2604090>, '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 0x2604d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25fef90>, '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': 'db7e7c15f3ca076d53731445000001ba-1504980998.160841-336240873', '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:17:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 11:17:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 11:17:06 INFO - Using env: {'DISPLAY': ':0', 11:17:06 INFO - 'HOME': '/home/cltbld', 11:17:06 INFO - 'LANG': 'en_US.UTF-8', 11:17:06 INFO - 'LANGUAGE': 'en_US:en', 11:17:06 INFO - 'LOGNAME': 'cltbld', 11:17:06 INFO - 'MAIL': '/var/mail/cltbld', 11:17:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:17:06 INFO - 'MOZ_NO_REMOTE': '1', 11:17:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:17:06 INFO - 'NO_EM_RESTART': '1', 11:17:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:17:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:17:06 INFO - 'PWD': '/builds/slave/test', 11:17:06 INFO - 'SHELL': '/bin/bash', 11:17:06 INFO - 'SHLVL': '1', 11:17:06 INFO - 'TERM': 'linux', 11:17:06 INFO - 'TMOUT': '86400', 11:17:06 INFO - 'USER': 'cltbld', 11:17:06 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1504980998.160841-336240873', 11:17:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:17:06 INFO - '_': '/tools/buildbot/bin/python'} 11:17:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:17:06 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 11:17:06 INFO - Cleaning up... 11:17:06 INFO - Return code: 0 11:17:06 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 11:17:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:17:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:17:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:17:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:17:06 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x22941f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x245da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2600a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2604090>, '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 0x2604d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25fef90>, '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': 'db7e7c15f3ca076d53731445000001ba-1504980998.160841-336240873', '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:17:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 11:17:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 11:17:06 INFO - Using env: {'DISPLAY': ':0', 11:17:06 INFO - 'HOME': '/home/cltbld', 11:17:06 INFO - 'LANG': 'en_US.UTF-8', 11:17:06 INFO - 'LANGUAGE': 'en_US:en', 11:17:06 INFO - 'LOGNAME': 'cltbld', 11:17:06 INFO - 'MAIL': '/var/mail/cltbld', 11:17:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:17:06 INFO - 'MOZ_NO_REMOTE': '1', 11:17:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:17:06 INFO - 'NO_EM_RESTART': '1', 11:17:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:17:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:17:06 INFO - 'PWD': '/builds/slave/test', 11:17:06 INFO - 'SHELL': '/bin/bash', 11:17:06 INFO - 'SHLVL': '1', 11:17:06 INFO - 'TERM': 'linux', 11:17:06 INFO - 'TMOUT': '86400', 11:17:06 INFO - 'USER': 'cltbld', 11:17:06 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1504980998.160841-336240873', 11:17:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:17:06 INFO - '_': '/tools/buildbot/bin/python'} 11:17:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:17:06 INFO - Downloading/unpacking blobuploader==1.2.4 11:17:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:17:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:17:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:17:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:17:07 INFO - Downloading blobuploader-1.2.4.tar.gz 11:17:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 11:17:08 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 11:17: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:17: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:17: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:17: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:17:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 11:17:08 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 11:17: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:17: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:17: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:17: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:17:08 INFO - Downloading docopt-0.6.1.tar.gz 11:17:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 11:17:08 INFO - Installing collected packages: blobuploader, requests, docopt 11:17:08 INFO - Running setup.py install for blobuploader 11:17:08 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 11:17:08 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 11:17:08 INFO - Running setup.py install for requests 11:17:09 INFO - Running setup.py install for docopt 11:17:09 INFO - Successfully installed blobuploader requests docopt 11:17:09 INFO - Cleaning up... 11:17:09 INFO - Return code: 0 11:17:09 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:17:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:17:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:17:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:17:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:17:09 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 0x22941f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x245da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2600a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2604090>, '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 0x2604d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25fef90>, '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': 'db7e7c15f3ca076d53731445000001ba-1504980998.160841-336240873', '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:17:09 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:17:09 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:17:09 INFO - Using env: {'DISPLAY': ':0', 11:17:09 INFO - 'HOME': '/home/cltbld', 11:17:09 INFO - 'LANG': 'en_US.UTF-8', 11:17:09 INFO - 'LANGUAGE': 'en_US:en', 11:17:09 INFO - 'LOGNAME': 'cltbld', 11:17:09 INFO - 'MAIL': '/var/mail/cltbld', 11:17:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:17:09 INFO - 'MOZ_NO_REMOTE': '1', 11:17:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:17:09 INFO - 'NO_EM_RESTART': '1', 11:17:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:17:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:17:09 INFO - 'PWD': '/builds/slave/test', 11:17:09 INFO - 'SHELL': '/bin/bash', 11:17:09 INFO - 'SHLVL': '1', 11:17:09 INFO - 'TERM': 'linux', 11:17:09 INFO - 'TMOUT': '86400', 11:17:09 INFO - 'USER': 'cltbld', 11:17:09 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1504980998.160841-336240873', 11:17:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:17:09 INFO - '_': '/tools/buildbot/bin/python'} 11:17:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:17:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:17:09 INFO - Running setup.py (path:/tmp/pip-X30BHn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:17:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:17:09 INFO - Running setup.py (path:/tmp/pip-1INlJv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:17:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:17:09 INFO - Running setup.py (path:/tmp/pip-yL7hte-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:17:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:17:09 INFO - Running setup.py (path:/tmp/pip-GZ_yre-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:17:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:17:09 INFO - Running setup.py (path:/tmp/pip-G71Tr7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:17:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:17:09 INFO - Running setup.py (path:/tmp/pip-MscmAu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:17:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:17:10 INFO - Running setup.py (path:/tmp/pip-5DVN2l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:17:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:17:10 INFO - Running setup.py (path:/tmp/pip-mE4Z20-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:17:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:17:10 INFO - Running setup.py (path:/tmp/pip-oKJkEJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:17:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:17:10 INFO - Running setup.py (path:/tmp/pip-ykDsfz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:17:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:17:10 INFO - Running setup.py (path:/tmp/pip-u6cD5t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:17:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:17:10 INFO - Running setup.py (path:/tmp/pip-dwoBRf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:17:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:17:10 INFO - Running setup.py (path:/tmp/pip-vf3AaP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:17:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:17:10 INFO - Running setup.py (path:/tmp/pip-jbVN_x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:17:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:17:10 INFO - Running setup.py (path:/tmp/pip-Dzefjv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:17:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:17:10 INFO - Running setup.py (path:/tmp/pip-INAiL3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:17:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:17:10 INFO - Running setup.py (path:/tmp/pip-FE5Fqk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:17:10 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 11:17:10 INFO - Running setup.py install for manifestparser 11:17:10 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 11:17:10 INFO - Running setup.py install for mozcrash 11:17:10 INFO - Running setup.py install for mozdebug 11:17:11 INFO - Running setup.py install for mozdevice 11:17:11 INFO - Installing dm script to /builds/slave/test/build/venv/bin 11:17:11 INFO - Running setup.py install for mozfile 11:17:11 INFO - Running setup.py install for mozhttpd 11:17:11 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 11:17:11 INFO - Running setup.py install for mozinfo 11:17:11 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 11:17:11 INFO - Running setup.py install for mozInstall 11:17:11 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 11:17:11 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 11:17:11 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 11:17:11 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 11:17:11 INFO - Running setup.py install for mozleak 11:17:11 INFO - Running setup.py install for mozlog 11:17:11 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 11:17:11 INFO - Running setup.py install for moznetwork 11:17:11 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 11:17:11 INFO - Running setup.py install for mozprocess 11:17:11 INFO - Running setup.py install for mozprofile 11:17:12 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 11:17:12 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 11:17:12 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 11:17:12 INFO - Running setup.py install for mozrunner 11:17:12 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 11:17:12 INFO - Running setup.py install for mozscreenshot 11:17:12 INFO - Running setup.py install for moztest 11:17:12 INFO - Running setup.py install for mozversion 11:17:12 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 11:17:12 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 11:17:12 INFO - Cleaning up... 11:17:12 INFO - Return code: 0 11:17:12 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:17:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:17:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:17:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:17:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:17:12 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 0x22941f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x245da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2600a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2604090>, '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 0x2604d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25fef90>, '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': 'db7e7c15f3ca076d53731445000001ba-1504980998.160841-336240873', '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:17:12 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:17:12 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:17:12 INFO - Using env: {'DISPLAY': ':0', 11:17:12 INFO - 'HOME': '/home/cltbld', 11:17:12 INFO - 'LANG': 'en_US.UTF-8', 11:17:12 INFO - 'LANGUAGE': 'en_US:en', 11:17:12 INFO - 'LOGNAME': 'cltbld', 11:17:12 INFO - 'MAIL': '/var/mail/cltbld', 11:17:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:17:12 INFO - 'MOZ_NO_REMOTE': '1', 11:17:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:17:12 INFO - 'NO_EM_RESTART': '1', 11:17:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:17:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:17:12 INFO - 'PWD': '/builds/slave/test', 11:17:12 INFO - 'SHELL': '/bin/bash', 11:17:12 INFO - 'SHLVL': '1', 11:17:12 INFO - 'TERM': 'linux', 11:17:12 INFO - 'TMOUT': '86400', 11:17:12 INFO - 'USER': 'cltbld', 11:17:12 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1504980998.160841-336240873', 11:17:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:17:12 INFO - '_': '/tools/buildbot/bin/python'} 11:17:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:17:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:17:12 INFO - Running setup.py (path:/tmp/pip-j4Wmdp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:17:12 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:17:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:17:12 INFO - Running setup.py (path:/tmp/pip-rdbahA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:17:12 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:17:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:17:12 INFO - Running setup.py (path:/tmp/pip-qmfRh6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:17:13 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:17:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:17:13 INFO - Running setup.py (path:/tmp/pip-qB0MAX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:17:13 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:17:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:17:13 INFO - Running setup.py (path:/tmp/pip-xd6xnH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:17:13 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:17:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:17:13 INFO - Running setup.py (path:/tmp/pip-vtNkLq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:17:13 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:17:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:17:13 INFO - Running setup.py (path:/tmp/pip-oqCFzA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:17:13 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:17:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:17:13 INFO - Running setup.py (path:/tmp/pip-pZEF80-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:17:13 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:17:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:17:13 INFO - Running setup.py (path:/tmp/pip-mpJ0YB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:17:13 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:17:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:17:13 INFO - Running setup.py (path:/tmp/pip-g04gy2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:17:13 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:17:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:17:13 INFO - Running setup.py (path:/tmp/pip-NEKWZW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:17:13 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:17:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:17:13 INFO - Running setup.py (path:/tmp/pip-mj3zvK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:17:13 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:17:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:17:13 INFO - Running setup.py (path:/tmp/pip-Ls3xfX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:17:13 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:17:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:17:13 INFO - Running setup.py (path:/tmp/pip-i2YTNB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:17:13 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:17:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:17:13 INFO - Running setup.py (path:/tmp/pip-cQUOJu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:17:13 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:17:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:17:13 INFO - Running setup.py (path:/tmp/pip-F36cE1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:17:13 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:17:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:17:13 INFO - Running setup.py (path:/tmp/pip-MiyRwU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:17:14 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:17:14 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:17:14 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:17:14 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:17:14 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:17:14 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:17:14 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:17:14 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:17:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:17:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:17:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:17:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:17:15 INFO - Downloading blessings-1.6.tar.gz 11:17:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 11:17:15 INFO - Installing collected packages: blessings 11:17:15 INFO - Running setup.py install for blessings 11:17:15 INFO - Successfully installed blessings 11:17:15 INFO - Cleaning up... 11:17:15 INFO - Return code: 0 11:17:15 INFO - Done creating virtualenv /builds/slave/test/build/venv. 11:17:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:17:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:17:15 INFO - Reading from file tmpfile_stdout 11:17:15 INFO - Current package versions: 11:17:15 INFO - argparse == 1.2.1 11:17:15 INFO - blessings == 1.6 11:17:15 INFO - blobuploader == 1.2.4 11:17:15 INFO - docopt == 0.6.1 11:17:15 INFO - functools32 == 3.2.3-2 11:17:15 INFO - jsonschema == 2.5.1 11:17:15 INFO - manifestparser == 1.1 11:17:15 INFO - mozInstall == 1.13 11:17:15 INFO - mozcrash == 1.0 11:17:15 INFO - mozdebug == 0.1 11:17:15 INFO - mozdevice == 0.51 11:17:15 INFO - mozfile == 1.2 11:17:15 INFO - mozhttpd == 0.7 11:17:15 INFO - mozinfo == 0.10 11:17:15 INFO - mozleak == 0.1 11:17:15 INFO - mozlog == 3.5 11:17:15 INFO - moznetwork == 0.27 11:17:15 INFO - mozprocess == 0.25 11:17:15 INFO - mozprofile == 0.28 11:17:15 INFO - mozrunner == 6.13 11:17:15 INFO - mozscreenshot == 0.1 11:17:15 INFO - mozsystemmonitor == 0.3 11:17:15 INFO - moztest == 0.8 11:17:15 INFO - mozversion == 1.4 11:17:15 INFO - psutil == 3.1.1 11:17:15 INFO - requests == 1.2.3 11:17:15 INFO - wsgiref == 0.1.2 11:17:15 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:17:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:17:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:17:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:17:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:17:15 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 0x22941f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x245da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2600a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2604090>, '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 0x2604d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25fef90>, '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': 'db7e7c15f3ca076d53731445000001ba-1504980998.160841-336240873', '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:17:15 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:17:15 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:17:15 INFO - Using env: {'DISPLAY': ':0', 11:17:15 INFO - 'HOME': '/home/cltbld', 11:17:15 INFO - 'LANG': 'en_US.UTF-8', 11:17:15 INFO - 'LANGUAGE': 'en_US:en', 11:17:15 INFO - 'LOGNAME': 'cltbld', 11:17:15 INFO - 'MAIL': '/var/mail/cltbld', 11:17:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:17:15 INFO - 'MOZ_NO_REMOTE': '1', 11:17:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:17:15 INFO - 'NO_EM_RESTART': '1', 11:17:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:17:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:17:15 INFO - 'PWD': '/builds/slave/test', 11:17:15 INFO - 'SHELL': '/bin/bash', 11:17:15 INFO - 'SHLVL': '1', 11:17:15 INFO - 'TERM': 'linux', 11:17:15 INFO - 'TMOUT': '86400', 11:17:15 INFO - 'USER': 'cltbld', 11:17:15 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1504980998.160841-336240873', 11:17:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:17:15 INFO - '_': '/tools/buildbot/bin/python'} 11:17:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:17:15 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:17:15 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:17:15 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:17:15 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:17:15 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:17:15 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:17:15 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:17:15 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:17:15 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:17:15 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 11:17:15 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:17:15 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:17:15 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:17:15 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:17:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 11:17:16 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:17:16 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:17:16 INFO - Installing collected packages: simplejson 11:17:16 INFO - Running setup.py install for simplejson 11:17:17 INFO - building 'simplejson._speedups' extension 11:17:17 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:17:17 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:17:17 INFO - Successfully installed simplejson 11:17:17 INFO - Cleaning up... 11:17:17 INFO - Return code: 0 11:17:17 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 11:17:17 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:17:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:17:17 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:17:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:17:17 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 0x22941f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x245da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2600a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2604090>, '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 0x2604d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25fef90>, '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': 'db7e7c15f3ca076d53731445000001ba-1504980998.160841-336240873', '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:17:17 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:17:17 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:17:17 INFO - Using env: {'DISPLAY': ':0', 11:17:17 INFO - 'HOME': '/home/cltbld', 11:17:17 INFO - 'LANG': 'en_US.UTF-8', 11:17:17 INFO - 'LANGUAGE': 'en_US:en', 11:17:17 INFO - 'LOGNAME': 'cltbld', 11:17:17 INFO - 'MAIL': '/var/mail/cltbld', 11:17:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:17:17 INFO - 'MOZ_NO_REMOTE': '1', 11:17:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:17:17 INFO - 'NO_EM_RESTART': '1', 11:17:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:17:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:17:17 INFO - 'PWD': '/builds/slave/test', 11:17:17 INFO - 'SHELL': '/bin/bash', 11:17:17 INFO - 'SHLVL': '1', 11:17:17 INFO - 'TERM': 'linux', 11:17:17 INFO - 'TMOUT': '86400', 11:17:17 INFO - 'USER': 'cltbld', 11:17:17 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1504980998.160841-336240873', 11:17:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:17:17 INFO - '_': '/tools/buildbot/bin/python'} 11:17:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:17:18 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 11:17:18 INFO - Cleaning up... 11:17:18 INFO - Return code: 0 11:17:18 INFO - Running post-action listener: _resource_record_post_action 11:17:18 INFO - Running post-action listener: _start_resource_monitoring 11:17:18 INFO - Starting resource monitoring. 11:17:18 INFO - [mozharness: 2017-09-09 18:17:18.242714Z] Finished create-virtualenv step (success) 11:17:18 INFO - [mozharness: 2017-09-09 18:17:18.243222Z] Running install step. 11:17:18 INFO - Running pre-action listener: _resource_record_pre_action 11:17:18 INFO - Running main action method: install 11:17:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:17:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:17:18 INFO - Reading from file tmpfile_stdout 11:17:18 INFO - Detecting whether we're running mozinstall >=1.0... 11:17:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 11:17:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 11:17:18 INFO - Reading from file tmpfile_stdout 11:17:18 INFO - Output received: 11:17:18 INFO - Usage: mozinstall [options] installer 11:17:18 INFO - Options: 11:17:18 INFO - -h, --help show this help message and exit 11:17:18 INFO - -d DEST, --destination=DEST 11:17:18 INFO - Directory to install application into. [default: 11:17:18 INFO - "/builds/slave/test"] 11:17:18 INFO - --app=APP Application being installed. [default: firefox] 11:17:18 INFO - mkdir: /builds/slave/test/build/application 11:17:18 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:17:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 11:17:35 INFO - Reading from file tmpfile_stdout 11:17:35 INFO - Output received: 11:17:35 INFO - /builds/slave/test/build/application/firefox/firefox 11:17:35 INFO - Running post-action listener: _resource_record_post_action 11:17:35 INFO - [mozharness: 2017-09-09 18:17:35.143497Z] Finished install step (success) 11:17:35 INFO - [mozharness: 2017-09-09 18:17:35.143746Z] Running setup-mitmproxy step. 11:17:35 INFO - Running pre-action listener: _resource_record_pre_action 11:17:35 INFO - Running main action method: setup_mitmproxy 11:17:35 INFO - Skipping: mitmproxy is not required 11:17:35 INFO - Running post-action listener: _resource_record_post_action 11:17:35 INFO - [mozharness: 2017-09-09 18:17:35.144867Z] Finished setup-mitmproxy step (success) 11:17:35 INFO - [mozharness: 2017-09-09 18:17:35.145087Z] Running run-tests step. 11:17:35 INFO - Running pre-action listener: _resource_record_pre_action 11:17:35 INFO - Running pre-action listener: _set_gcov_prefix 11:17:35 INFO - Running main action method: run_tests 11:17:35 WARNING - Try message not found. 11:17:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 11:17:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 11:17:35 INFO - Python 2.7.3 11:17:35 INFO - Return code: 0 11:17:35 INFO - grabbing minidump binary from tooltool 11:17:35 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:17:35 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 0x2604090>, '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 0x2604d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25fef90>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 11:17:35 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:17:35 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:17:35 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:17:35 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 11:17:35 INFO - Return code: 0 11:17:35 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 11:17:35 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 11:17:35 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 11:17:35 INFO - ENV: RUST_BACKTRACE is now full 11:17:35 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 11:17:35 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 11:17:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/TzHGlhiiRQCEEVlLYRX_gg/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-049', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 11:17:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/TzHGlhiiRQCEEVlLYRX_gg/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-049 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 11:17:35 INFO - Using env: {'DISPLAY': ':0', 11:17:35 INFO - 'HOME': '/home/cltbld', 11:17:35 INFO - 'LANG': 'en_US.UTF-8', 11:17:35 INFO - 'LANGUAGE': 'en_US:en', 11:17:35 INFO - 'LOGNAME': 'cltbld', 11:17:35 INFO - 'MAIL': '/var/mail/cltbld', 11:17:35 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:17:35 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 11:17:35 INFO - 'MOZ_ACCELERATED': '1', 11:17:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:17:35 INFO - 'MOZ_NO_REMOTE': '1', 11:17:35 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:17:35 INFO - 'MOZ_WEBRENDER': '1', 11:17:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:17:35 INFO - 'NO_EM_RESTART': '1', 11:17:35 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:17:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:17:35 INFO - 'PWD': '/builds/slave/test', 11:17:35 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:17:35 INFO - 'RUST_BACKTRACE': 'full', 11:17:35 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 11:17:35 INFO - 'SHELL': '/bin/bash', 11:17:35 INFO - 'SHLVL': '1', 11:17:35 INFO - 'TERM': 'linux', 11:17:35 INFO - 'TMOUT': '86400', 11:17:35 INFO - 'USER': 'cltbld', 11:17:35 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1504980998.160841-336240873', 11:17:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:17:35 INFO - '_': '/tools/buildbot/bin/python'} 11:17:35 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/TzHGlhiiRQCEEVlLYRX_gg/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-049', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 11:17:35 INFO - mozversion application_buildid: 20170909172127 11:17:35 INFO - mozversion application_changeset: 21699515e84bc218b3a963f4af426a9ed7c7f8a4 11:17:35 INFO - mozversion application_display_name: Nightly 11:17:35 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 11:17:35 INFO - mozversion application_name: Firefox 11:17:35 INFO - mozversion application_remotingname: firefox 11:17:35 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 11:17:35 INFO - mozversion application_vendor: Mozilla 11:17:35 INFO - mozversion application_version: 57.0a1 11:17:35 INFO - mozversion platform_buildid: 20170909172127 11:17:35 INFO - mozversion platform_changeset: 21699515e84bc218b3a963f4af426a9ed7c7f8a4 11:17:35 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 11:17:35 INFO - mozversion platform_version: 57.0a1 11:17:35 INFO - using testdate: 1504981055 11:17:35 INFO - actual date: 1504981055 11:17:35 INFO - starting webserver on 'localhost:38793' 11:17:35 INFO - SUITE-START | Running 2 tests 11:17:35 INFO - TEST-START | dromaeo_css 11:17:35 INFO - Initialising browser for dromaeo_css test... 11:17:35 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:38793/getInfo.html -profile /tmp/tmpfQKtMt/profile 11:17:35 INFO - TEST-INFO | started process 23045 (/builds/slave/test/build/application/firefox/firefox http://localhost:38793/getInfo.html) 11:17:41 INFO - TEST-INFO | 23045: exit 0 11:17:42 INFO - Browser initialized. 11:17:42 INFO - Running cycle 1/1 for dromaeo_css test... 11:17:42 INFO - Using env: {'DISPLAY': ':0', 11:17:42 INFO - 'HOME': '/home/cltbld', 11:17:42 INFO - 'JSGC_DISABLE_POISONING': '1', 11:17:42 INFO - 'LANG': 'en_US.UTF-8', 11:17:42 INFO - 'LANGUAGE': 'en_US:en', 11:17:42 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 11:17:42 INFO - 'LOGNAME': 'cltbld', 11:17:42 INFO - 'MAIL': '/var/mail/cltbld', 11:17:42 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:17:42 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 11:17:42 INFO - 'MOZ_ACCELERATED': '1', 11:17:42 INFO - 'MOZ_CRASHREPORTER': '1', 11:17:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:17:42 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 11:17:42 INFO - 'MOZ_NO_REMOTE': '1', 11:17:42 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:17:42 INFO - 'MOZ_WEBRENDER': '1', 11:17:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:17:42 INFO - 'NO_EM_RESTART': '1', 11:17:42 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:17:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:17:42 INFO - 'PWD': '/builds/slave/test', 11:17:42 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:17:42 INFO - 'RUST_BACKTRACE': 'full', 11:17:42 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 11:17:42 INFO - 'SHELL': '/bin/bash', 11:17:42 INFO - 'SHLVL': '1', 11:17:42 INFO - 'TERM': 'linux', 11:17:42 INFO - 'TMOUT': '86400', 11:17:42 INFO - 'USER': 'cltbld', 11:17:42 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1504980998.160841-336240873', 11:17:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:17:42 INFO - '_': '/tools/buildbot/bin/python'} 11:17:42 INFO - TEST-INFO | started process 23255 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpfQKtMt/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 11:17:42 INFO - PID 23255 | WebRender - OpenGL version new 3.2.0 NVIDIA 361.42 11:17:43 INFO - PID 23255 | WebRender - OpenGL version new 3.2.0 NVIDIA 361.42 11:17:43 INFO - PID 23255 | 11:17:43 INFO - PID 23255 | (/builds/slave/test/build/application/firefox/firefox:23316): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 11:17:43 INFO - PID 23255 | 11:17:53 INFO - PID 23255 | RSS: Main: 209698816 11:17:53 INFO - PID 23255 | 11:20:51 INFO - PID 23255 | Cycle 1(1): loaded http://localhost:38793/tests/dromaeo/cssquery-dojo.html (next: http://localhost:38793/tests/dromaeo/cssquery-ext.html) 11:20:52 INFO - PID 23255 | RSS: Main: 220246016 11:20:52 INFO - PID 23255 | 11:23:55 INFO - PID 23255 | Cycle 1(1): loaded http://localhost:38793/tests/dromaeo/cssquery-ext.html (next: http://localhost:38793/tests/dromaeo/cssquery-jquery.html) 11:23:55 INFO - PID 23255 | RSS: Main: 221933568 11:23:55 INFO - PID 23255 | 11:26:57 INFO - PID 23255 | Cycle 1(1): loaded http://localhost:38793/tests/dromaeo/cssquery-jquery.html (next: http://localhost:38793/tests/dromaeo/cssquery-mootools.html) 11:26:58 INFO - PID 23255 | RSS: Main: 222175232 11:26:58 INFO - PID 23255 | 11:30:00 INFO - PID 23255 | Cycle 1(1): loaded http://localhost:38793/tests/dromaeo/cssquery-mootools.html (next: http://localhost:38793/tests/dromaeo/cssquery-prototype.html) 11:30:00 INFO - PID 23255 | RSS: Main: 219860992 11:30:00 INFO - PID 23255 | 11:33:04 INFO - PID 23255 | Cycle 1(1): loaded http://localhost:38793/tests/dromaeo/cssquery-prototype.html (next: http://localhost:38793/tests/dromaeo/cssquery-yui.html) 11:33:05 INFO - PID 23255 | RSS: Main: 224284672 11:33:05 INFO - PID 23255 | 11:36:07 INFO - PID 23255 | Cycle 1(1): loaded http://localhost:38793/tests/dromaeo/cssquery-yui.html (next: http://localhost:38793/tests/dromaeo/cssquery-dojo.html) 11:36:07 INFO - PID 23255 | RSS: Main: 224612352 11:36:07 INFO - PID 23255 | 11:36:07 INFO - PID 23255 | __start_tp_report 11:36:07 INFO - PID 23255 | _x_x_mozilla_page_load 11:36:07 INFO - PID 23255 | _x_x_mozilla_page_load_details 11:36:07 INFO - PID 23255 | |i|pagename|runs| 11:36:07 INFO - PID 23255 | |0;dojo.html;3106.3787242551493;3126.5622812806228;3132.013415774031;3150.9527357089646;3156.7316778073864;6152.077188421739;6156.445919867211;6286.214223222098;6295.43341099301;6392.872142557152;6175.197224360827;6202.968985155079;6225.097360882669;6232.345603711613;6246.750129994806;5672.773089076432;5727.742251598677;5736.741846616912;5746.9712651436685;5804.970975145139;5769.16347129666;5795.768169273224;5805.970970145143;5813.09896965971;5890.087036509327;5730.51290640294;5776.855578610526;5780.595358324919;5824.796132135376;5828.737706803204;5546.4453554644615;5615.101583746622;5689.886202275973;5765.711714414262;5786.7395967181155;5693.886122277573;5702.942970570282;5766.452187042224;5773.162891380726;5783.103618939072;6099.146119543268;6211.3167551569295;6219.844503887393;6277.403646653561;6285.528585356116;6567.474602031826;6570.605763654196;6593.274739778621;6639.966800165968;6686.866262674768;6745.966270168667;6778.593284402951;6781.525293229476;6783.084283621697;6798.864022719518;6154.353792851775;6230.626162430269;6254.280757712831;6306.621602703853;6316.30520642729;6955.095837541188;6967.268436814163;6975.232724400312;7030.050943122716;7087.716491340392;6518.608883467007;6566.343365663395;6587.769428069994;6622.238442579069;6693.330666933268;6526.836829079216;6614.470842332602;6622.238442579165;6627.834304142435;6779.288174741581;6677.198736151596;6720.865582688417;6722.428593569503;6728.798136055828;6729.528932974645;6714.261431242559;6717.630530320782;6737.6968036438475;6761.121054262914;6813.7955861324235;5170.767315470813;5277.683338999673;5337.6797392156595;5344.91982620261;5347.732613369316;4504.819807207675;4525.389072475239;4595.448546174481;4619.607333376701;4638.095571363552;5770.278715160605;5810.88378232433;5820.650760954271;5821.155932389865;5821.708914554255;6699.899501507384;6701.865962680719;6711.429528490035;6722.798316050526;6823.078884350648;5633.887322253532;5647.463490968352;5785.884282314414;5787.536997040227;5793.971030144822;5765;5780.277465316835;5781.132830075522;5781.971090144607;5785.768569257267;6445.1943507061615;6454.870902581922;6455.193100862392;6459.418652321314;6472.611643301417;6736.93263067363;6740.325967403319;6769.356911093439;6793.252742198453;6814.420774234048;6413.615183089029;6472.223333200046;6521.934780652133;6559.6064236145985;6560.3111673273615;6625;6644.10304608891;6712.865742685217;6713.12729345182;6723;6588.07766912623;6691.197056353269;6744.359285867835;6824.7952561423235;6832.419244364285;6507.414332710079;6561.048647946117;6581.14445122131;6581.539292249497;6628.436582890508;6534.509911756542;6600.735970561123;6614.107095542233;6621.635810030494;6622.437092847162;6439.356064393523;6450.41946224842;6527.477801775942;6537.1174891389055;6538.1500404947055;6388.87222255543;6492.74029038852;6566.146400967844;6652.83367915806;6661.2006559213205;6277.246730392382;6288.151099601495;6291.339409361951;6298.811035668938;6307.842303942254 11:36:07 INFO - PID 23255 | |1;ext.html;863.7711006583255;882.2721254964656;887.6405055952341;888.1118881118881;889.7508697564682;37500.81249593755;40771;40893.18213635725;40937.79531102348;41040.17919641605;39046;39315.41026884592;39390.409143862795;39481.802590987005;39504.80247598765;7053.612051337174;7183.425325973935;7187.029750983603;7189.532680375785;7191.0651615289935;7069.858602827941;7160.248173941739;7172.246914074025;7173.246809085049;7173.605451700155;7148.642567871611;7187.389071928892;7188.748393806218;7688.461807673465;7716.9614151929445;7680.462367634268;7780.844383112306;7865.370770338359;7866.881996770053;7872.724454644089;7760.805979850549;7832.765017049498;7841.05907291123;7853.293203611645;7856.25365590268;37412.25175496502;37747.62252377496;37825.81087094547;37842.24315513674;37938.24123517514;3463.6016858061394;3497.265574229415;3500.2824420993634;3500.6149323574386;3500.6849383555345;31095.689043109505;31345;31356;31579.21051973696;31585.21036974071;5159.948400515985;5269.7365131743645;5303.946960530422;5346.331708536433;5436.293281873371;177314;178643;179339;179869.1006544972;180659.09670451694;42575;43070.78464607657;48488.27267590989;48513;49092.50907490951;51179;51207.48792512027;51328.74335628298;51348;51502;16024.75962860558;16127.758083628754;16165.35338586467;16189.838101618832;16232.513024609281;13295.468181272834;13298.601041968757;13308.667283317995;13309;13327.067105302536;14270.286485675675;14273.64315892111;14280.928595356956;14316.355763990437;14406.279686015658;5720.885582288414;5832.766689332379;5846.210761547137;5911.467967882912;5917.230760001173;975.770693886936;1018.5212949913529;1028.6759670703855;1034.1468288661883;1035.1253191053547;22040.559188816133;22348.553028939332;22406.663900041513;22420.55158896813;22823.88588057049;1123.1576317761678;1127.3912087472672;1131.213806404541;1134.6596021193775;1147.942602869853;11844.170908036354;11975.700607484709;12055.216410933437;12062.879371206176;12089.214201076902;206501;209954;209988;211150;212632;50973.7451312741;51064;51659.741701292005;59471.405285947454;60544.39455605388;1509.9773503397457;1513.3870782333172;1520.1107352198867;1529.3653133949285;1539.4304107480305;26729.732702673504;27218.863905680344;27231.59152612673;27486.587701184097;27719.86140069287;38165.809170953966;38405;38499;38550.2289954205;38611;199344;202391;203542;203898;204555;31549.8422507886;32246.355072897943;32271;33533.15567643803;36221;41508.79245603873;43592.782036089615;43776;43913.78043109764;44926;31686.841565792023;31764.682353176173;31824.204394889388;31964.520532192502;32032.83983580067;31284.217894551908;31817;31835.20411989626;32064.198395040312;32237.677623223466;35797;36093;36515.452268215464;36556.81721591375;36617.267654646224;30654.693453065185;30748.692513074584;30837;31010.069697908195;31654.208644784063;22659.739221662116;22873.771262287828;22966.081356745544;23111.306660800205;23404.765952340258 11:36:07 INFO - PID 23255 | |2;jquery.html;532.4755116210532;555.5472290083584;566.2355819643484;578.7366748129601;603.2519675602254;21576;22068.33794986149;22144.88927555364;22294.331170064885;22429.439264018427;22417.439564010907;22705.54588908221;23282.06871725133;24841;25133.120340788075;6321.115043893847;6516.152900122977;6565.507586930999;6570.080188773575;6571.671416429183;6390.137331460263;6416.165898433197;6483.740650373979;6489.221293444793;6494.967525162368;6211.34780848009;6420.4542613877875;6425.228972523304;6528.608283502981;6597.142371491699;6496.512761542903;6499.252585952605;6526.2494813096155;6552.115464412314;6558.737650493975;6054.273487181566;6069.878602427971;6074.119252708332;6076.422739839708;6098.786542470993;26636.467270654477;27944.161675149575;28316.575251371247;28447.431051378855;28583.28541786451;1892.4511891551433;1956.9119389627501;1957.9902100489405;1965.4791480257743;1965.6068786242809;19034.238630454765;19613.41159765209;19635;19660.115294811625;19666.901665491725;2328.278233747527;2349.2130136404326;2374.6675465434855;2387.940301492459;2396.8202384821207;115275;122153;122661.38669306596;124617.37691311576;135455;14314.498992535211;14484.85515144835;14593.635159120895;14599.124052556881;14657.633559160893;22425.551488970457;22468.213612523483;22522.21172258963;22563.887180563994;22601.547969040526;9297.488638124833;9885.851712224323;9972.351797133164;10082.344647597884;10123.949380253052;9246.95376523113;9258.351915365995;9376.812463750686;9394.577244024036;9435.339526233234;8679;8747.650093996295;8853.867191992125;8989.876265466817;8999.685011024714;2688.220416079354;2699.20373489821;2702.3649442381025;2706.065163408173;2713.4301796622535;944.4663764972769;972.9610815567298;974.91713204377;979.4221409368507;984.4979060679105;18720.81279187218;18885.622287554448;19271.710924336145;19313.710294345598;19384.612307754047;1016.1972042086817;1017.9338343007681;1022.7420273064173;1025.702546261576;1030.1449796668746;10290.610767546435;10549.367037977747;10553.155747540179;10597.629082982214;10604.310719803188;440911;444062;451038;451445;458598;109264.4536777311;112735.43632281786;113779;114244;115572;1141.9143564232716;1164.0454827041744;1165.6736113888126;1166.690826930847;1171.4552732979205;16370.508884733477;16554.503364899072;16941.491755247363;16955.067471289196;17076.914615426842;54938;56000.719996399755;56101;57158.42841571531;57267;71881.6405917967;72194.63902680454;72357.27642723505;72598;72819.63590182015;13579.728405431639;14000.719985600435;14020.859791401956;14032;14033.789493157816;21544.89227553852;21652;21775.56448870982;21906.78093219111;22062.448438789157;17334.739978900074;17426.91286543559;17483.300667973137;17655.646887062445;17703;15358.923205383902;15970.520884373487;16114.919425403266;16271.430499932445;16534.83465165381;17790.91104544521;17808.3767068152;17854.107294634956;18004.36984705529;18020.819791802438;13481.932590336986;13613.52352667652;13655.112417692819;13783.379747911167;13799.586012419644;17387.391441299493;17465.825341746928;17472.73790893112;17567.736483952496;17637.382691605733 11:36:07 INFO - PID 23255 | |3;mootools.html;1285.3508977966126;1318.9802152967702;1348.0361541497828;1349.1095876721365;1355.5255660518812;15099.24503774811;16390.098544580043;16448;16454.095024773633;16465.09441980692;16038.919805400987;16131.677366452694;16171;16193.190340482988;16348.10085445303;2596.870156492168;2703.8783254753585;2749.8762555684943;2752.573351130578;2753.2979090331937;2731.9481999430163;2762.7927905407173;2787.776977841778;2787.958180627292;2793.1899749072745;2688.7042425333198;2700.297922540144;2707.878145483458;2708.553088740365;2723.6323096381934;2640.0363867188435;2643.193825883105;2660.4679064187144;2668.826526275786;2683.1413947536794;2577.2268319504074;2586.1336452288506;2593.7924966002674;2607.687077550706;2610.8955641774305;15013.774793378108;15112.319945602474;15118.244087795567;15308.158051307173;15316.693666126726;7465.925340746578;7752.302292793675;7756.534607923486;7774.727884524014;7793.103793063813;5076.923846142311;5261.158214685632;5330.333708286465;5374.059539580558;5382.085045542267;1853.416173905229;1929.488685498344;1937.2638397408894;1949.483386902472;1969.7439332886777;26277.605835912476;26557;26646.866765666047;26658;26827.865860670572;6503.317151699003;6657.600543967377;6674.2658307586125;6769.255381907986;6985.755498557526;17076.146192690318;17100.572485687957;17108.914455427643;17122;17122.40071597488;8032.638531266107;8034.638441270157;8084.595770211466;8117.472364296302;8120.390970677105;7248.130224373109;7394.186639469654;7416.555006699616;7441.293077157661;7441.479096463196;4971.950280497221;5099.388073431212;5122.667026643257;5137.383513978347;5170.793168273302;1525.3974680001338;1540.9922950385176;1551.100361790159;1555.5100143454777;1563.5934656989036;852.3649880838691;869.1004810021598;880.4893161966045;887.1793590928495;897.9012308646044;7244.13070431541;7318.3047610476915;7319.121705395387;7402.851942961111;8205.58972051395;726.7601691441812;727.4544091931052;728.8505856299446;734.2694019450681;742.4283301857539;4467.106578684276;4535.501094879561;4540.659450541157;4545.318202269686;4598.2412901871485;20873.582528349347;21096.367108986757;21670.34988950334;21936.232231871807;22000.779992200194;21139;21218.151273948868;21592.35222943314;21701.34895953124;22018.229361972255;11041.282316649393;11148.442577871074;11256.099512039018;11262.155338349656;11516.884831151749;7902.130765615892;7971.0833254174195;8029.59852007409;8090.150534193825;8154.796130096795;17682.5579360517;18360.816391836444;18451.44645660632;19084.332048378794;19164.329248476235;17731.202095905457;19340.323088691828;19374.612507750047;19431.805681943;19775.505612359808;10719.249652524248;10914;10951.780964380509;10957.232993690364;10960.616378426717;13109.27898965566;13977.091489053179;14042.578722638336;14043.244594425696;14145.434182632991;11306.208565400671;11760.470778815145;11772.293662380285;11809.940950295193;11958.940205298917;11105.888941110808;11343.829842552203;11351.205415620827;11544.769104617693;11766.294022358343;9739.902600974183;9951.651692191028;9983;10000.349977251455;10009.299349045497;7063.894041589483;7072.5402848814665;7079.716811327695;7100.751473698602;7260;7344.559326440431;7454.291842274975;7484.738034168778;7527.435442341737;7568.508046976929 11:36:07 INFO - PID 23255 | |4;prototype.html;499.15144254766903;504.7123139810307;526.1502673182811;533.5118366694475;536.2224774077586;6210.826210826214;6304.873902521953;6314.494840412767;6351.872962540752;6402.455791257748;6123.8162855114415;6127.3872612738705;6172.197614310134;6228.937710622892;6261.436470717635;5152.304438900738;5177.792888284464;5184;5198.324217851693;5200.895982080356;5078.1874900016;5122.897542049157;5194.896102077956;5209.869753256161;5265.815696450625;4735.3133795599615;4837;4916.631252656047;4923.532264434873;4936.432310284327;4906.386701662293;4935.9753201234125;4959.6528243023;4986.750662466899;5013.774380152884;4424.225760491901;4431.955680443187;4456.17560751262;4472.932906006413;4475.418195634579;6031.24609423822;6080.452759251644;6087.573869829113;6132.28996457146;6158.291796443422;5655.123455864347;5677.233573467571;5690.7439165237665;5703.486686198221;5727.455891690324;6408.67956602168;6468.8059358219325;6495.512836537278;6538.411542961157;6548.116004339401;4642.234031384817;4757.952420475785;4793.448753393334;4836.243341295463;4899.167141585939;6682.625274236528;6692.498062645321;6701.564398314143;6726.663666816639;6815.625140617264;4885.6335774817035;4909.140900342426;4922.138625740481;4932.55606995365;4949.628777841676;4868.732219727949;5000.799968001312;5037.861381390961;5053.2420136979745;5068.518490743373;5633.352164501053;5634.211210430543;5658.002517331642;5678.176664383641;5710.2576665033275;6514.459360849272;6556.492006838454;6563.638999855054;6586.37429444202;6623.43700785429;1704.3949397963793;1727.7062899307148;1740;1746.5982823950308;1751.6146447781723;1171.5782318365382;1199.9820002699967;1231.2673958994385;1234.4630085912656;1236.3818090954524;5664.518515926193;5664.575156863251;5681;5700.458456446631;5758.683272420057;6651.16860392451;6690.565113267622;6768.323167683291;6785.660716964132;6803.333183370106;5616.382197958222;5643.40744221859;5709.143628455765;5709.22925405065;5710.971445142831;3506.474028895686;3539.292441282421;3573.7855728656364;3573.9278216534935;3600.4959305697225;6331.651759153198;6346.746130154742;6503.154589903377;6564.4748420127235;6569.146011018537;6717.832054198587;6825;6837.265093962355;6861;6963.234044255128;6425.614463132227;6449.903251451138;6489.286178520359;6536.7712130075215;6569.343065693392;6126.816195514141;6669.933300667125;6773.288804675438;6827.795166145023;6834.838077526932;6340.714667839866;6491.253505846699;6692.1969363674725;6756.756756756686;6788.830279243059;6334.12272550143;6375.139356186855;6402.023059277459;6427.935720642734;6457.741690332522;4947.208446648519;4954.801807927643;4985.252212168204;4988.501149884983;5001.674891132065;6649.506435086842;6661.700223490052;6807.489438292247;6811.93188068113;6838.487113466411;6451.645159516084;6502.934970650233;6566.146400968035;6568.540202185801;6599.934000659932;6415.65271293015;6501.4798816095545;6531.575447595891;6542.869142617216;6605.372489613479;6326.3041065483685;6408.4232419080645;6409.814184375906;6454.386833250834;6512.283648798533;6507.804765857032;6550.803475895731;6604.471642268511;6657.2677005528385;6663.300353462817;6318.27339855904;6365.427111559982;6398.328175541501;6428;6444.226692796707 11:36:07 INFO - PID 23255 | |5;yui.html;854.2397266432874;894.8210357928414;913.6984795017645;921.7234829551137;936.2650319499195;18976.146073426695;19893.403197904066;19958.101885415173;19961.401157965247;19971.60056798867;20234.494137646565;20324.796752032475;20348.898255508702;20382.796172038274;20469;975.3367709957226;978.1783302026297;985.029745700488;988.2094324540375;989.5744829723216;992.1715367668006;992.2062350119911;992.2211064314514;992.8510723391477;992.8510723391477;1037.0510982451049;1041.8437234414823;1042.3120740311397;1046.5865982936734;1047.455323231919;1010.9595616175344;1032.3135115148418;1035.0787798859021;1040.7814358984585;1047.314009323894;751.70683433461;755.2296657409412;757.526545908807;758.8406434648675;769.7190525458224;19042.33351832693;19303.613927721508;19323.03384830753;19325.13036913342;19382.32161874342;21358.46603834901;21493.462663433384;21740.239091631716;21932.780672193232;22082.558348832932;17138.31446742129;17163.399281025104;17736;17841.821581784276;17914.820851791446;3731.067233191702;3734.3464893643777;3760.417135344026;3773.811309434517;3774.2074164425503;139939.30030349782;141383;141656;142384;144235;16885.83114168867;17131.486055418358;17300.826991730173;17461.30154793794;17477.038762868164;31013.379732405225;31641.52537711936;31684.524732129037;31859;31946.84026579852;8083.110857805636;8093.271605555528;8119.634616442274;8171;8178.713745018896;4018.3972404139026;4174.45732054837;4194.0563373240775;4195.832166713297;4211.873643790691;5424.7558859850615;5525.806596769094;5525.861853453695;5555.194496798023;5579.804706835323;985.7979114281555;1006.3307900246255;1014.6854475112739;1020.6835880876952;1025.9794804103876;629.8016124920636;657.710607332772;661.9205695316497;669.6015870557011;669.9765508207287;10646.467676616137;10680.359178449318;10692.786144277072;10955.50700218492;11261.774764504664;570.2330365658183;571.6627189957861;582.3506789929284;587.0460501684762;590.5747861539685;5197.194434862602;5271.393789714155;5277.472252774692;5343.759530821045;5376.220448035013;119519;121958;122868.38565807114;124226;126303.368483157;104516;105649;106803.46598266959;107831.46084269685;109131.45434272778;94064.52967735255;94349;98261.50869245607;100163.49918250216;100234;9575.473348965874;9637.759056023655;9921.65274215399;9926.404415735078;9952.303338766507;42127.36808947929;42287.788561057;44210;44405.555944440144;45211.321830173234;53807;53939.190912137135;54895.17657235065;54926.72536637291;56358;13595.388207530486;13826.516071937434;13885.514007009706;13928.373223205183;13980.510682126076;15571.221438927781;15694.843051569795;15727;15893;15903.920480397524;15133.697326053638;15470.226488675746;15498;15625.374985000473;15638.609034774221;13753;13819.447222111405;14158.292085395484;14171;14231.288435578386;14726.631834203801;14762.188079655292;14977.251137443302;14994.325255363317;15016.924915375354;10569.312994655324;10722.785544289227;10772.030517253485;10929.234953553176;10983.286086404358;11290.435478225892;11312;11316.094712423152;11421.31472111676;11438.37088960082 11:36:07 INFO - PID 23255 | __end_tp_report 11:36:07 INFO - PID 23255 | __start_cc_report 11:36:07 INFO - PID 23255 | _x_x_mozilla_cycle_collect,347 11:36:07 INFO - PID 23255 | __end_cc_report 11:36:07 INFO - PID 23255 | __startTimestamp1504982167436__endTimestamp 11:36:07 INFO - PID 23255 | 11:36:07 INFO - PID 23255 | ------- Summary: start ------- 11:36:07 INFO - PID 23255 | Number of tests: 6 11:36:07 INFO - PID 23255 | 11:36:07 INFO - PID 23255 | [#0] dojo.html Cycles:165 Average:6167.35 Median:6439.36 stddev:747.87 (11.6%) stddev-sans-first:710.56 11:36:07 INFO - PID 23255 | Values: 3106.4 3126.6 3132.0 3151.0 3156.7 6152.1 6156.4 6286.2 6295.4 6392.9 6175.2 6203.0 6225.1 6232.3 6246.8 5672.8 5727.7 5736.7 5747.0 5805.0 5769.2 5795.8 5806.0 5813.1 5890.1 5730.5 5776.9 5780.6 5824.8 5828.7 5546.4 5615.1 5689.9 5765.7 5786.7 5693.9 5702.9 5766.5 5773.2 5783.1 6099.1 6211.3 6219.8 6277.4 6285.5 6567.5 6570.6 6593.3 6640.0 6686.9 6746.0 6778.6 6781.5 6783.1 6798.9 6154.4 6230.6 6254.3 6306.6 6316.3 6955.1 6967.3 6975.2 7030.1 7087.7 6518.6 6566.3 6587.8 6622.2 6693.3 6526.8 6614.5 6622.2 6627.8 6779.3 6677.2 6720.9 6722.4 6728.8 6729.5 6714.3 6717.6 6737.7 6761.1 6813.8 5170.8 5277.7 5337.7 5344.9 5347.7 4504.8 4525.4 4595.4 4619.6 4638.1 5770.3 5810.9 5820.7 5821.2 5821.7 6699.9 6701.9 6711.4 6722.8 6823.1 5633.9 5647.5 5785.9 5787.5 5794.0 5765.0 5780.3 5781.1 5782.0 5785.8 6445.2 6454.9 6455.2 6459.4 6472.6 6736.9 6740.3 6769.4 6793.3 6814.4 6413.6 6472.2 6521.9 6559.6 6560.3 6625.0 6644.1 6712.9 6713.1 6723.0 6588.1 6691.2 6744.4 6824.8 6832.4 6507.4 6561.0 6581.1 6581.5 6628.4 6534.5 6600.7 6614.1 6621.6 6622.4 6439.4 6450.4 6527.5 6537.1 6538.2 6388.9 6492.7 6566.1 6652.8 6661.2 6277.2 6288.2 6291.3 6298.8 6307.8 11:36:07 INFO - PID 23255 | 11:36:07 INFO - PID 23255 | [#1] ext.html Cycles:180 Average:36784.17 Median:3500.45 stddev:51163.79 (1461.6%) stddev-sans-first:51236.22 11:36:07 INFO - PID 23255 | Values: 863.8 882.3 887.6 888.1 889.8 37500.8 40771.0 40893.2 40937.8 41040.2 39046.0 39315.4 39390.4 39481.8 39504.8 7053.6 7183.4 7187.0 7189.5 7191.1 7069.9 7160.2 7172.2 7173.2 7173.6 7148.6 7187.4 7188.7 7688.5 7717.0 7680.5 7780.8 7865.4 7866.9 7872.7 7760.8 7832.8 7841.1 7853.3 7856.3 37412.3 37747.6 37825.8 37842.2 37938.2 3463.6 3497.3 3500.3 3500.6 3500.7 31095.7 31345.0 31356.0 31579.2 31585.2 5159.9 5269.7 5303.9 5346.3 5436.3 177314.0 178643.0 179339.0 179869.1 180659.1 42575.0 43070.8 48488.3 48513.0 49092.5 51179.0 51207.5 51328.7 51348.0 51502.0 16024.8 16127.8 16165.4 16189.8 16232.5 13295.5 13298.6 13308.7 13309.0 13327.1 14270.3 14273.6 14280.9 14316.4 14406.3 5720.9 5832.8 5846.2 5911.5 5917.2 975.8 1018.5 1028.7 1034.1 1035.1 22040.6 22348.6 22406.7 22420.6 22823.9 1123.2 1127.4 1131.2 1134.7 1147.9 11844.2 11975.7 12055.2 12062.9 12089.2 206501.0 209954.0 209988.0 211150.0 212632.0 50973.7 51064.0 51659.7 59471.4 60544.4 1510.0 1513.4 1520.1 1529.4 1539.4 26729.7 27218.9 27231.6 27486.6 27719.9 38165.8 38405.0 38499.0 38550.2 38611.0 199344.0 202391.0 203542.0 203898.0 204555.0 31549.8 32246.4 32271.0 33533.2 36221.0 41508.8 43592.8 43776.0 43913.8 44926.0 31686.8 31764.7 31824.2 31964.5 32032.8 31284.2 31817.0 31835.2 32064.2 32237.7 35797.0 36093.0 36515.5 36556.8 36617.3 30654.7 30748.7 30837.0 31010.1 31654.2 22659.7 22873.8 22966.1 23111.3 23404.8 11:36:07 INFO - PID 23255 | 11:36:07 INFO - PID 23255 | [#2] jquery.html Cycles:180 Average:32803.98 Median:22355.89 stddev:75847.22 (339.3%) stddev-sans-first:76021.29 11:36:07 INFO - PID 23255 | Values: 532.5 555.5 566.2 578.7 603.3 21576.0 22068.3 22144.9 22294.3 22429.4 22417.4 22705.5 23282.1 24841.0 25133.1 6321.1 6516.2 6565.5 6570.1 6571.7 6390.1 6416.2 6483.7 6489.2 6495.0 6211.3 6420.5 6425.2 6528.6 6597.1 6496.5 6499.3 6526.2 6552.1 6558.7 6054.3 6069.9 6074.1 6076.4 6098.8 26636.5 27944.2 28316.6 28447.4 28583.3 1892.5 1956.9 1958.0 1965.5 1965.6 19034.2 19613.4 19635.0 19660.1 19666.9 2328.3 2349.2 2374.7 2387.9 2396.8 115275.0 122153.0 122661.4 124617.4 135455.0 14314.5 14484.9 14593.6 14599.1 14657.6 22425.6 22468.2 22522.2 22563.9 22601.5 9297.5 9885.9 9972.4 10082.3 10123.9 9247.0 9258.4 9376.8 9394.6 9435.3 8679.0 8747.7 8853.9 8989.9 8999.7 2688.2 2699.2 2702.4 2706.1 2713.4 944.5 973.0 974.9 979.4 984.5 18720.8 18885.6 19271.7 19313.7 19384.6 1016.2 1017.9 1022.7 1025.7 1030.1 10290.6 10549.4 10553.2 10597.6 10604.3 440911.0 444062.0 451038.0 451445.0 458598.0 109264.5 112735.4 113779.0 114244.0 115572.0 1141.9 1164.0 1165.7 1166.7 1171.5 16370.5 16554.5 16941.5 16955.1 17076.9 54938.0 56000.7 56101.0 57158.4 57267.0 71881.6 72194.6 72357.3 72598.0 72819.6 13579.7 14000.7 14020.9 14032.0 14033.8 21544.9 21652.0 21775.6 21906.8 22062.4 17334.7 17426.9 17483.3 17655.6 17703.0 15358.9 15970.5 16114.9 16271.4 16534.8 17790.9 17808.4 17854.1 18004.4 18020.8 13481.9 13613.5 13655.1 13783.4 13799.6 17387.4 17465.8 17472.7 17567.7 17637.4 11:36:07 INFO - PID 23255 | 11:36:07 INFO - PID 23255 | [#3] mootools.html Cycles:180 Average:9328.73 Median:14600.10 stddev:6757.07 (46.3%) stddev-sans-first:6749.00 11:36:07 INFO - PID 23255 | Values: 1285.4 1319.0 1348.0 1349.1 1355.5 15099.2 16390.1 16448.0 16454.1 16465.1 16038.9 16131.7 16171.0 16193.2 16348.1 2596.9 2703.9 2749.9 2752.6 2753.3 2731.9 2762.8 2787.8 2788.0 2793.2 2688.7 2700.3 2707.9 2708.6 2723.6 2640.0 2643.2 2660.5 2668.8 2683.1 2577.2 2586.1 2593.8 2607.7 2610.9 15013.8 15112.3 15118.2 15308.2 15316.7 7465.9 7752.3 7756.5 7774.7 7793.1 5076.9 5261.2 5330.3 5374.1 5382.1 1853.4 1929.5 1937.3 1949.5 1969.7 26277.6 26557.0 26646.9 26658.0 26827.9 6503.3 6657.6 6674.3 6769.3 6985.8 17076.1 17100.6 17108.9 17122.0 17122.4 8032.6 8034.6 8084.6 8117.5 8120.4 7248.1 7394.2 7416.6 7441.3 7441.5 4972.0 5099.4 5122.7 5137.4 5170.8 1525.4 1541.0 1551.1 1555.5 1563.6 852.4 869.1 880.5 887.2 897.9 7244.1 7318.3 7319.1 7402.9 8205.6 726.8 727.5 728.9 734.3 742.4 4467.1 4535.5 4540.7 4545.3 4598.2 20873.6 21096.4 21670.3 21936.2 22000.8 21139.0 21218.2 21592.4 21701.3 22018.2 11041.3 11148.4 11256.1 11262.2 11516.9 7902.1 7971.1 8029.6 8090.2 8154.8 17682.6 18360.8 18451.4 19084.3 19164.3 17731.2 19340.3 19374.6 19431.8 19775.5 10719.2 10914.0 10951.8 10957.2 10960.6 13109.3 13977.1 14042.6 14043.2 14145.4 11306.2 11760.5 11772.3 11809.9 11958.9 11105.9 11343.8 11351.2 11544.8 11766.3 9739.9 9951.7 9983.0 10000.3 10009.3 7063.9 7072.5 7079.7 7100.8 7260.0 7344.6 7454.3 7484.7 7527.4 7568.5 11:36:07 INFO - PID 23255 | 11:36:07 INFO - PID 23255 | [#4] prototype.html Cycles:180 Average:5496.67 Median:6129.84 stddev:1541.48 (25.1%) stddev-sans-first:1499.47 11:36:07 INFO - PID 23255 | Values: 499.2 504.7 526.2 533.5 536.2 6210.8 6304.9 6314.5 6351.9 6402.5 6123.8 6127.4 6172.2 6228.9 6261.4 5152.3 5177.8 5184.0 5198.3 5200.9 5078.2 5122.9 5194.9 5209.9 5265.8 4735.3 4837.0 4916.6 4923.5 4936.4 4906.4 4936.0 4959.7 4986.8 5013.8 4424.2 4432.0 4456.2 4472.9 4475.4 6031.2 6080.5 6087.6 6132.3 6158.3 5655.1 5677.2 5690.7 5703.5 5727.5 6408.7 6468.8 6495.5 6538.4 6548.1 4642.2 4758.0 4793.4 4836.2 4899.2 6682.6 6692.5 6701.6 6726.7 6815.6 4885.6 4909.1 4922.1 4932.6 4949.6 4868.7 5000.8 5037.9 5053.2 5068.5 5633.4 5634.2 5658.0 5678.2 5710.3 6514.5 6556.5 6563.6 6586.4 6623.4 1704.4 1727.7 1740.0 1746.6 1751.6 1171.6 1200.0 1231.3 1234.5 1236.4 5664.5 5664.6 5681.0 5700.5 5758.7 6651.2 6690.6 6768.3 6785.7 6803.3 5616.4 5643.4 5709.1 5709.2 5711.0 3506.5 3539.3 3573.8 3573.9 3600.5 6331.7 6346.7 6503.2 6564.5 6569.1 6717.8 6825.0 6837.3 6861.0 6963.2 6425.6 6449.9 6489.3 6536.8 6569.3 6126.8 6669.9 6773.3 6827.8 6834.8 6340.7 6491.3 6692.2 6756.8 6788.8 6334.1 6375.1 6402.0 6427.9 6457.7 4947.2 4954.8 4985.3 4988.5 5001.7 6649.5 6661.7 6807.5 6811.9 6838.5 6451.6 6502.9 6566.1 6568.5 6599.9 6415.7 6501.5 6531.6 6542.9 6605.4 6326.3 6408.4 6409.8 6454.4 6512.3 6507.8 6550.8 6604.5 6657.3 6663.3 6318.3 6365.4 6398.3 6428.0 6444.2 11:36:07 INFO - PID 23255 | 11:36:07 INFO - PID 23255 | [#5] yui.html Cycles:180 Average:24074.68 Median:20103.05 stddev:35529.88 (176.7%) stddev-sans-first:35586.77 11:36:07 INFO - PID 23255 | Values: 854.2 894.8 913.7 921.7 936.3 18976.1 19893.4 19958.1 19961.4 19971.6 20234.5 20324.8 20348.9 20382.8 20469.0 975.3 978.2 985.0 988.2 989.6 992.2 992.2 992.2 992.9 992.9 1037.1 1041.8 1042.3 1046.6 1047.5 1011.0 1032.3 1035.1 1040.8 1047.3 751.7 755.2 757.5 758.8 769.7 19042.3 19303.6 19323.0 19325.1 19382.3 21358.5 21493.5 21740.2 21932.8 22082.6 17138.3 17163.4 17736.0 17841.8 17914.8 3731.1 3734.3 3760.4 3773.8 3774.2 139939.3 141383.0 141656.0 142384.0 144235.0 16885.8 17131.5 17300.8 17461.3 17477.0 31013.4 31641.5 31684.5 31859.0 31946.8 8083.1 8093.3 8119.6 8171.0 8178.7 4018.4 4174.5 4194.1 4195.8 4211.9 5424.8 5525.8 5525.9 5555.2 5579.8 985.8 1006.3 1014.7 1020.7 1026.0 629.8 657.7 661.9 669.6 670.0 10646.5 10680.4 10692.8 10955.5 11261.8 570.2 571.7 582.4 587.0 590.6 5197.2 5271.4 5277.5 5343.8 5376.2 119519.0 121958.0 122868.4 124226.0 126303.4 104516.0 105649.0 106803.5 107831.5 109131.5 94064.5 94349.0 98261.5 100163.5 100234.0 9575.5 9637.8 9921.7 9926.4 9952.3 42127.4 42287.8 44210.0 44405.6 45211.3 53807.0 53939.2 54895.2 54926.7 56358.0 13595.4 13826.5 13885.5 13928.4 13980.5 15571.2 15694.8 15727.0 15893.0 15903.9 15133.7 15470.2 15498.0 15625.4 15638.6 13753.0 13819.4 14158.3 14171.0 14231.3 14726.6 14762.2 14977.3 14994.3 15016.9 10569.3 10722.8 10772.0 10929.2 10983.3 11290.4 11312.0 11316.1 11421.3 11438.4 11:36:07 INFO - PID 23255 | -------- Summary: end -------- 11:36:07 INFO - PID 23255 | 11:36:08 INFO - TEST-INFO | 23255: exit 0 11:36:08 INFO - TEST-OK | dromaeo_css | took 1112905ms 11:36:08 INFO - TEST-START | kraken 11:36:08 INFO - Initialising browser for kraken test... 11:36:08 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:38793/getInfo.html -profile /tmp/tmp5C6efu/profile 11:36:08 INFO - TEST-INFO | started process 23646 (/builds/slave/test/build/application/firefox/firefox http://localhost:38793/getInfo.html) 11:36:14 INFO - TEST-INFO | 23646: exit 0 11:36:14 INFO - Browser initialized. 11:36:14 INFO - Running cycle 1/1 for kraken test... 11:36:14 INFO - Using env: {'DISPLAY': ':0', 11:36:14 INFO - 'HOME': '/home/cltbld', 11:36:14 INFO - 'JSGC_DISABLE_POISONING': '1', 11:36:14 INFO - 'LANG': 'en_US.UTF-8', 11:36:14 INFO - 'LANGUAGE': 'en_US:en', 11:36:14 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 11:36:14 INFO - 'LOGNAME': 'cltbld', 11:36:14 INFO - 'MAIL': '/var/mail/cltbld', 11:36:14 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:36:14 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 11:36:14 INFO - 'MOZ_ACCELERATED': '1', 11:36:14 INFO - 'MOZ_CRASHREPORTER': '1', 11:36:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:36:14 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 11:36:14 INFO - 'MOZ_NO_REMOTE': '1', 11:36:14 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:36:14 INFO - 'MOZ_WEBRENDER': '1', 11:36:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:36:14 INFO - 'NO_EM_RESTART': '1', 11:36:14 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:36:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:36:14 INFO - 'PWD': '/builds/slave/test', 11:36:14 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:36:14 INFO - 'RUST_BACKTRACE': 'full', 11:36:14 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 11:36:14 INFO - 'SHELL': '/bin/bash', 11:36:14 INFO - 'SHLVL': '1', 11:36:14 INFO - 'TERM': 'linux', 11:36:14 INFO - 'TMOUT': '86400', 11:36:14 INFO - 'USER': 'cltbld', 11:36:14 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1504980998.160841-336240873', 11:36:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:36:14 INFO - '_': '/tools/buildbot/bin/python'} 11:36:14 INFO - TEST-INFO | started process 23856 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp5C6efu/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 11:36:15 INFO - PID 23856 | WebRender - OpenGL version new 3.2.0 NVIDIA 361.42 11:36:15 INFO - PID 23856 | WebRender - OpenGL version new 3.2.0 NVIDIA 361.42 11:36:16 INFO - PID 23856 | 11:36:16 INFO - PID 23856 | (/builds/slave/test/build/application/firefox/firefox:23917): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 11:36:16 INFO - PID 23856 | 11:36:26 INFO - PID 23856 | RSS: Main: 209805312 11:36:26 INFO - PID 23856 | 11:36:29 INFO - PID 23856 | Cycle 1(1): loaded http://localhost:38793/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:38793/tests/kraken/driver.html?testName=audio-beat-detection) 11:36:30 INFO - PID 23856 | RSS: Main: 215457792 11:36:30 INFO - PID 23856 | 11:36:32 INFO - PID 23856 | Cycle 1(1): loaded http://localhost:38793/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:38793/tests/kraken/driver.html?testName=audio-dft) 11:36:33 INFO - PID 23856 | RSS: Main: 215924736 11:36:33 INFO - PID 23856 | 11:36:36 INFO - PID 23856 | Cycle 1(1): loaded http://localhost:38793/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:38793/tests/kraken/driver.html?testName=audio-fft) 11:36:37 INFO - PID 23856 | RSS: Main: 210939904 11:36:37 INFO - PID 23856 | 11:36:39 INFO - PID 23856 | Cycle 1(1): loaded http://localhost:38793/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:38793/tests/kraken/driver.html?testName=audio-oscillator) 11:36:40 INFO - PID 23856 | RSS: Main: 211931136 11:36:40 INFO - PID 23856 | 11:36:42 INFO - PID 23856 | Cycle 1(1): loaded http://localhost:38793/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:38793/tests/kraken/driver.html?testName=imaging-gaussian-blur) 11:36:42 INFO - PID 23856 | RSS: Main: 213102592 11:36:42 INFO - PID 23856 | 11:36:46 INFO - PID 23856 | Cycle 1(1): loaded http://localhost:38793/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:38793/tests/kraken/driver.html?testName=imaging-darkroom) 11:36:46 INFO - PID 23856 | RSS: Main: 215408640 11:36:46 INFO - PID 23856 | 11:36:50 INFO - PID 23856 | Cycle 1(1): loaded http://localhost:38793/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:38793/tests/kraken/driver.html?testName=imaging-desaturate) 11:36:50 INFO - PID 23856 | RSS: Main: 213762048 11:36:50 INFO - PID 23856 | 11:36:53 INFO - PID 23856 | Cycle 1(1): loaded http://localhost:38793/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:38793/tests/kraken/driver.html?testName=json-parse-financial) 11:36:54 INFO - PID 23856 | RSS: Main: 215629824 11:36:54 INFO - PID 23856 | 11:36:56 INFO - PID 23856 | Cycle 1(1): loaded http://localhost:38793/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:38793/tests/kraken/driver.html?testName=json-stringify-tinderbox) 11:36:56 INFO - PID 23856 | RSS: Main: 215281664 11:36:56 INFO - PID 23856 | 11:36:58 INFO - PID 23856 | Cycle 1(1): loaded http://localhost:38793/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:38793/tests/kraken/driver.html?testName=stanford-crypto-aes) 11:36:59 INFO - PID 23856 | RSS: Main: 215822336 11:36:59 INFO - PID 23856 | 11:37:01 INFO - PID 23856 | Cycle 1(1): loaded http://localhost:38793/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:38793/tests/kraken/driver.html?testName=stanford-crypto-ccm) 11:37:02 INFO - PID 23856 | RSS: Main: 215953408 11:37:02 INFO - PID 23856 | 11:37:04 INFO - PID 23856 | Cycle 1(1): loaded http://localhost:38793/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:38793/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 11:37:05 INFO - PID 23856 | RSS: Main: 216719360 11:37:05 INFO - PID 23856 | 11:37:08 INFO - PID 23856 | Cycle 1(1): loaded http://localhost:38793/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:38793/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 11:37:09 INFO - PID 23856 | RSS: Main: 215093248 11:37:09 INFO - PID 23856 | 11:37:11 INFO - PID 23856 | Cycle 1(1): loaded http://localhost:38793/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:38793/tests/kraken/driver.html?testName=ai-astar) 11:37:11 INFO - PID 23856 | RSS: Main: 217894912 11:37:11 INFO - PID 23856 | 11:37:11 INFO - PID 23856 | __start_tp_report 11:37:11 INFO - PID 23856 | _x_x_mozilla_page_load 11:37:11 INFO - PID 23856 | _x_x_mozilla_page_load_details 11:37:11 INFO - PID 23856 | |i|pagename|runs| 11:37:11 INFO - PID 23856 | |0;ai-astar;114;108;107;121;107;117;107;112;108;108 11:37:11 INFO - PID 23856 | |1;audio-beat-detection;121;121;127;118;134;122;123;117;118;159 11:37:11 INFO - PID 23856 | |2;audio-dft;171;171;163;166;164;164;171;165;168;167 11:37:11 INFO - PID 23856 | |3;audio-fft;76;79;78;74;75;82;82;76;83;74 11:37:11 INFO - PID 23856 | |4;audio-oscillator;87;89;87;80;84;88;80;79;87;79 11:37:11 INFO - PID 23856 | |5;imaging-gaussian-blur;114;114;115;120;114;114;115;118;115;118 11:37:11 INFO - PID 23856 | |6;imaging-darkroom;148;149;150;150;151;151;148;153;148;149 11:37:11 INFO - PID 23856 | |7;imaging-desaturate;96;95;97;94;101;102;94;96;96;95 11:37:11 INFO - PID 23856 | |8;json-parse-financial;53;57;56;55;54;54;60;55;55;54 11:37:11 INFO - PID 23856 | |9;json-stringify-tinderbox;37;43;46;46;38;44;41;40;38;43 11:37:11 INFO - PID 23856 | |10;stanford-crypto-aes;81;75;80;77;79;79;87;80;76;80 11:37:11 INFO - PID 23856 | |11;stanford-crypto-ccm;123;124;132;124;135;137;121;118;124;135 11:37:11 INFO - PID 23856 | |12;stanford-crypto-pbkdf2;173;191;176;171;170;174;182;170;173;173 11:37:11 INFO - PID 23856 | |13;stanford-crypto-sha256-iterative;72;67;68;69;71;67;70;73;66;75 11:37:11 INFO - PID 23856 | __end_tp_report 11:37:11 INFO - PID 23856 | __start_cc_report 11:37:11 INFO - PID 23856 | _x_x_mozilla_cycle_collect,982 11:37:11 INFO - PID 23856 | __end_cc_report 11:37:11 INFO - PID 23856 | __startTimestamp1504982231246__endTimestamp 11:37:11 INFO - PID 23856 | 11:37:11 INFO - PID 23856 | ------- Summary: start ------- 11:37:11 INFO - PID 23856 | Number of tests: 14 11:37:11 INFO - PID 23856 | 11:37:11 INFO - PID 23856 | [#0] ai-astar Cycles:10 Average:110.90 Median:110.00 stddev:4.95 (4.5%) stddev-sans-first:5.13 11:37:11 INFO - PID 23856 | Values: 114.0 108.0 107.0 121.0 107.0 117.0 107.0 112.0 108.0 108.0 11:37:11 INFO - PID 23856 | 11:37:11 INFO - PID 23856 | [#1] audio-beat-detection Cycles:10 Average:126.00 Median:122.50 stddev:12.64 (10.3%) stddev-sans-first:13.28 11:37:11 INFO - PID 23856 | Values: 121.0 121.0 127.0 118.0 134.0 122.0 123.0 117.0 118.0 159.0 11:37:11 INFO - PID 23856 | 11:37:11 INFO - PID 23856 | [#2] audio-dft Cycles:10 Average:167.00 Median:167.50 stddev:3.13 (1.9%) stddev-sans-first:2.96 11:37:11 INFO - PID 23856 | Values: 171.0 171.0 163.0 166.0 164.0 164.0 171.0 165.0 168.0 167.0 11:37:11 INFO - PID 23856 | 11:37:11 INFO - PID 23856 | [#3] audio-fft Cycles:10 Average:77.90 Median:78.50 stddev:3.45 (4.4%) stddev-sans-first:3.59 11:37:11 INFO - PID 23856 | Values: 76.0 79.0 78.0 74.0 75.0 82.0 82.0 76.0 83.0 74.0 11:37:11 INFO - PID 23856 | 11:37:11 INFO - PID 23856 | [#4] audio-oscillator Cycles:10 Average:84.00 Median:87.00 stddev:4.08 (4.7%) stddev-sans-first:4.18 11:37:11 INFO - PID 23856 | Values: 87.0 89.0 87.0 80.0 84.0 88.0 80.0 79.0 87.0 79.0 11:37:11 INFO - PID 23856 | 11:37:11 INFO - PID 23856 | [#5] imaging-gaussian-blur Cycles:10 Average:115.70 Median:115.00 stddev:2.16 (1.9%) stddev-sans-first:2.20 11:37:11 INFO - PID 23856 | Values: 114.0 114.0 115.0 120.0 114.0 114.0 115.0 118.0 115.0 118.0 11:37:11 INFO - PID 23856 | 11:37:11 INFO - PID 23856 | [#6] imaging-darkroom Cycles:10 Average:149.70 Median:150.00 stddev:1.64 (1.1%) stddev-sans-first:1.62 11:37:11 INFO - PID 23856 | Values: 148.0 149.0 150.0 150.0 151.0 151.0 148.0 153.0 148.0 149.0 11:37:11 INFO - PID 23856 | 11:37:11 INFO - PID 23856 | [#7] imaging-desaturate Cycles:10 Average:96.60 Median:95.50 stddev:2.76 (2.9%) stddev-sans-first:2.92 11:37:11 INFO - PID 23856 | Values: 96.0 95.0 97.0 94.0 101.0 102.0 94.0 96.0 96.0 95.0 11:37:11 INFO - PID 23856 | 11:37:11 INFO - PID 23856 | [#8] json-parse-financial Cycles:10 Average:55.30 Median:55.00 stddev:2.00 (3.6%) stddev-sans-first:1.94 11:37:11 INFO - PID 23856 | Values: 53.0 57.0 56.0 55.0 54.0 54.0 60.0 55.0 55.0 54.0 11:37:11 INFO - PID 23856 | 11:37:11 INFO - PID 23856 | [#9] json-stringify-tinderbox Cycles:10 Average:41.60 Median:43.00 stddev:3.31 (7.7%) stddev-sans-first:3.06 11:37:11 INFO - PID 23856 | Values: 37.0 43.0 46.0 46.0 38.0 44.0 41.0 40.0 38.0 43.0 11:37:11 INFO - PID 23856 | 11:37:11 INFO - PID 23856 | [#10] stanford-crypto-aes Cycles:10 Average:79.40 Median:80.00 stddev:3.31 (4.1%) stddev-sans-first:3.46 11:37:11 INFO - PID 23856 | Values: 81.0 75.0 80.0 77.0 79.0 79.0 87.0 80.0 76.0 80.0 11:37:11 INFO - PID 23856 | 11:37:11 INFO - PID 23856 | [#11] stanford-crypto-ccm Cycles:10 Average:127.30 Median:128.00 stddev:6.77 (5.3%) stddev-sans-first:7.00 11:37:11 INFO - PID 23856 | Values: 123.0 124.0 132.0 124.0 135.0 137.0 121.0 118.0 124.0 135.0 11:37:11 INFO - PID 23856 | 11:37:11 INFO - PID 23856 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:175.30 Median:173.50 stddev:6.53 (3.8%) stddev-sans-first:6.88 11:37:11 INFO - PID 23856 | Values: 173.0 191.0 176.0 171.0 170.0 174.0 182.0 170.0 173.0 173.0 11:37:11 INFO - PID 23856 | 11:37:11 INFO - PID 23856 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.80 Median:70.50 stddev:2.94 (4.2%) stddev-sans-first:3.00 11:37:11 INFO - PID 23856 | Values: 72.0 67.0 68.0 69.0 71.0 67.0 70.0 73.0 66.0 75.0 11:37:11 INFO - PID 23856 | -------- Summary: end -------- 11:37:11 INFO - PID 23856 | 11:37:11 INFO - PID 23856 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 11:37:12 INFO - TEST-INFO | 23856: exit 0 11:37:12 INFO - TEST-OK | kraken | took 63766ms 11:37:12 INFO - SUITE-END | took 1176s 11:37:12 INFO - Completed test suite (00:19:36) 11:37:12 INFO - javascript benchmark 11:37:12 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8395.542235138824, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3106.3787242551493, 3126.5622812806228, 3132.013415774031, 3150.9527357089646, 3156.7316778073864, 6152.077188421739, 6156.445919867211, 6286.214223222098, 6295.43341099301, 6392.872142557152, 6175.197224360827, 6202.968985155079, 6225.097360882669, 6232.345603711613, 6246.750129994806, 5672.773089076432, 5727.742251598677, 5736.741846616912, 5746.9712651436685, 5804.970975145139, 5769.16347129666, 5795.768169273224, 5805.970970145143, 5813.09896965971, 5890.087036509327, 5730.51290640294, 5776.855578610526, 5780.595358324919, 5824.796132135376, 5828.737706803204, 5546.4453554644615, 5615.101583746622, 5689.886202275973, 5765.711714414262, 5786.7395967181155, 5693.886122277573, 5702.942970570282, 5766.452187042224, 5773.162891380726, 5783.103618939072, 6099.146119543268, 6211.3167551569295, 6219.844503887393, 6277.403646653561, 6285.528585356116, 6567.474602031826, 6570.605763654196, 6593.274739778621, 6639.966800165968, 6686.866262674768, 6745.966270168667, 6778.593284402951, 6781.525293229476, 6783.084283621697, 6798.864022719518, 6154.353792851775, 6230.626162430269, 6254.280757712831, 6306.621602703853, 6316.30520642729, 6955.095837541188, 6967.268436814163, 6975.232724400312, 7030.050943122716, 7087.716491340392, 6518.608883467007, 6566.343365663395, 6587.769428069994, 6622.238442579069, 6693.330666933268, 6526.836829079216, 6614.470842332602, 6622.238442579165, 6627.834304142435, 6779.288174741581, 6677.198736151596, 6720.865582688417, 6722.428593569503, 6728.798136055828, 6729.528932974645, 6714.261431242559, 6717.630530320782, 6737.6968036438475, 6761.121054262914, 6813.7955861324235, 5170.767315470813, 5277.683338999673, 5337.6797392156595, 5344.91982620261, 5347.732613369316, 4504.819807207675, 4525.389072475239, 4595.448546174481, 4619.607333376701, 4638.095571363552, 5770.278715160605, 5810.88378232433, 5820.650760954271, 5821.155932389865, 5821.708914554255, 6699.899501507384, 6701.865962680719, 6711.429528490035, 6722.798316050526, 6823.078884350648, 5633.887322253532, 5647.463490968352, 5785.884282314414, 5787.536997040227, 5793.971030144822, 5765.0, 5780.277465316835, 5781.132830075522, 5781.971090144607, 5785.768569257267, 6445.1943507061615, 6454.870902581922, 6455.193100862392, 6459.418652321314, 6472.611643301417, 6736.93263067363, 6740.325967403319, 6769.356911093439, 6793.252742198453, 6814.420774234048, 6413.615183089029, 6472.223333200046, 6521.934780652133, 6559.6064236145985, 6560.3111673273615, 6625.0, 6644.10304608891, 6712.865742685217, 6713.12729345182, 6723.0, 6588.07766912623, 6691.197056353269, 6744.359285867835, 6824.7952561423235, 6832.419244364285, 6507.414332710079, 6561.048647946117, 6581.14445122131, 6581.539292249497, 6628.436582890508, 6534.509911756542, 6600.735970561123, 6614.107095542233, 6621.635810030494, 6622.437092847162, 6439.356064393523, 6450.41946224842, 6527.477801775942, 6537.1174891389055, 6538.1500404947055, 6388.87222255543, 6492.74029038852, 6566.146400967844, 6652.83367915806, 6661.2006559213205, 6277.246730392382, 6288.151099601495, 6291.339409361951, 6298.811035668938, 6307.842303942254], "value": 6109.739452701506, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [863.7711006583255, 882.2721254964656, 887.6405055952341, 888.1118881118881, 889.7508697564682, 37500.81249593755, 40771.0, 40893.18213635725, 40937.79531102348, 41040.17919641605, 39046.0, 39315.41026884592, 39390.409143862795, 39481.802590987005, 39504.80247598765, 7053.612051337174, 7183.425325973935, 7187.029750983603, 7189.532680375785, 7191.0651615289935, 7069.858602827941, 7160.248173941739, 7172.246914074025, 7173.246809085049, 7173.605451700155, 7148.642567871611, 7187.389071928892, 7188.748393806218, 7688.461807673465, 7716.9614151929445, 7680.462367634268, 7780.844383112306, 7865.370770338359, 7866.881996770053, 7872.724454644089, 7760.805979850549, 7832.765017049498, 7841.05907291123, 7853.293203611645, 7856.25365590268, 37412.25175496502, 37747.62252377496, 37825.81087094547, 37842.24315513674, 37938.24123517514, 3463.6016858061394, 3497.265574229415, 3500.2824420993634, 3500.6149323574386, 3500.6849383555345, 31095.689043109505, 31345.0, 31356.0, 31579.21051973696, 31585.21036974071, 5159.948400515985, 5269.7365131743645, 5303.946960530422, 5346.331708536433, 5436.293281873371, 177314.0, 178643.0, 179339.0, 179869.1006544972, 180659.09670451694, 42575.0, 43070.78464607657, 48488.27267590989, 48513.0, 49092.50907490951, 51179.0, 51207.48792512027, 51328.74335628298, 51348.0, 51502.0, 16024.75962860558, 16127.758083628754, 16165.35338586467, 16189.838101618832, 16232.513024609281, 13295.468181272834, 13298.601041968757, 13308.667283317995, 13309.0, 13327.067105302536, 14270.286485675675, 14273.64315892111, 14280.928595356956, 14316.355763990437, 14406.279686015658, 5720.885582288414, 5832.766689332379, 5846.210761547137, 5911.467967882912, 5917.230760001173, 975.770693886936, 1018.5212949913529, 1028.6759670703855, 1034.1468288661883, 1035.1253191053547, 22040.559188816133, 22348.553028939332, 22406.663900041513, 22420.55158896813, 22823.88588057049, 1123.1576317761678, 1127.3912087472672, 1131.213806404541, 1134.6596021193775, 1147.942602869853, 11844.170908036354, 11975.700607484709, 12055.216410933437, 12062.879371206176, 12089.214201076902, 206501.0, 209954.0, 209988.0, 211150.0, 212632.0, 50973.7451312741, 51064.0, 51659.741701292005, 59471.405285947454, 60544.39455605388, 1509.9773503397457, 1513.3870782333172, 1520.1107352198867, 1529.3653133949285, 1539.4304107480305, 26729.732702673504, 27218.863905680344, 27231.59152612673, 27486.587701184097, 27719.86140069287, 38165.809170953966, 38405.0, 38499.0, 38550.2289954205, 38611.0, 199344.0, 202391.0, 203542.0, 203898.0, 204555.0, 31549.8422507886, 32246.355072897943, 32271.0, 33533.15567643803, 36221.0, 41508.79245603873, 43592.782036089615, 43776.0, 43913.78043109764, 44926.0, 31686.841565792023, 31764.682353176173, 31824.204394889388, 31964.520532192502, 32032.83983580067, 31284.217894551908, 31817.0, 31835.20411989626, 32064.198395040312, 32237.677623223466, 35797.0, 36093.0, 36515.452268215464, 36556.81721591375, 36617.267654646224, 30654.693453065185, 30748.692513074584, 30837.0, 31010.069697908195, 31654.208644784063, 22659.739221662116, 22873.771262287828, 22966.081356745544, 23111.306660800205, 23404.765952340258], "value": 17089.2603951018, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [532.4755116210532, 555.5472290083584, 566.2355819643484, 578.7366748129601, 603.2519675602254, 21576.0, 22068.33794986149, 22144.88927555364, 22294.331170064885, 22429.439264018427, 22417.439564010907, 22705.54588908221, 23282.06871725133, 24841.0, 25133.120340788075, 6321.115043893847, 6516.152900122977, 6565.507586930999, 6570.080188773575, 6571.671416429183, 6390.137331460263, 6416.165898433197, 6483.740650373979, 6489.221293444793, 6494.967525162368, 6211.34780848009, 6420.4542613877875, 6425.228972523304, 6528.608283502981, 6597.142371491699, 6496.512761542903, 6499.252585952605, 6526.2494813096155, 6552.115464412314, 6558.737650493975, 6054.273487181566, 6069.878602427971, 6074.119252708332, 6076.422739839708, 6098.786542470993, 26636.467270654477, 27944.161675149575, 28316.575251371247, 28447.431051378855, 28583.28541786451, 1892.4511891551433, 1956.9119389627501, 1957.9902100489405, 1965.4791480257743, 1965.6068786242809, 19034.238630454765, 19613.41159765209, 19635.0, 19660.115294811625, 19666.901665491725, 2328.278233747527, 2349.2130136404326, 2374.6675465434855, 2387.940301492459, 2396.8202384821207, 115275.0, 122153.0, 122661.38669306596, 124617.37691311576, 135455.0, 14314.498992535211, 14484.85515144835, 14593.635159120895, 14599.124052556881, 14657.633559160893, 22425.551488970457, 22468.213612523483, 22522.21172258963, 22563.887180563994, 22601.547969040526, 9297.488638124833, 9885.851712224323, 9972.351797133164, 10082.344647597884, 10123.949380253052, 9246.95376523113, 9258.351915365995, 9376.812463750686, 9394.577244024036, 9435.339526233234, 8679.0, 8747.650093996295, 8853.867191992125, 8989.876265466817, 8999.685011024714, 2688.220416079354, 2699.20373489821, 2702.3649442381025, 2706.065163408173, 2713.4301796622535, 944.4663764972769, 972.9610815567298, 974.91713204377, 979.4221409368507, 984.4979060679105, 18720.81279187218, 18885.622287554448, 19271.710924336145, 19313.710294345598, 19384.612307754047, 1016.1972042086817, 1017.9338343007681, 1022.7420273064173, 1025.702546261576, 1030.1449796668746, 10290.610767546435, 10549.367037977747, 10553.155747540179, 10597.629082982214, 10604.310719803188, 440911.0, 444062.0, 451038.0, 451445.0, 458598.0, 109264.4536777311, 112735.43632281786, 113779.0, 114244.0, 115572.0, 1141.9143564232716, 1164.0454827041744, 1165.6736113888126, 1166.690826930847, 1171.4552732979205, 16370.508884733477, 16554.503364899072, 16941.491755247363, 16955.067471289196, 17076.914615426842, 54938.0, 56000.719996399755, 56101.0, 57158.42841571531, 57267.0, 71881.6405917967, 72194.63902680454, 72357.27642723505, 72598.0, 72819.63590182015, 13579.728405431639, 14000.719985600435, 14020.859791401956, 14032.0, 14033.789493157816, 21544.89227553852, 21652.0, 21775.56448870982, 21906.78093219111, 22062.448438789157, 17334.739978900074, 17426.91286543559, 17483.300667973137, 17655.646887062445, 17703.0, 15358.923205383902, 15970.520884373487, 16114.919425403266, 16271.430499932445, 16534.83465165381, 17790.91104544521, 17808.3767068152, 17854.107294634956, 18004.36984705529, 18020.819791802438, 13481.932590336986, 13613.52352667652, 13655.112417692819, 13783.379747911167, 13799.586012419644, 17387.391441299493, 17465.825341746928, 17472.73790893112, 17567.736483952496, 17637.382691605733], "value": 11605.127081860774, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1285.3508977966126, 1318.9802152967702, 1348.0361541497828, 1349.1095876721365, 1355.5255660518812, 15099.24503774811, 16390.098544580043, 16448.0, 16454.095024773633, 16465.09441980692, 16038.919805400987, 16131.677366452694, 16171.0, 16193.190340482988, 16348.10085445303, 2596.870156492168, 2703.8783254753585, 2749.8762555684943, 2752.573351130578, 2753.2979090331937, 2731.9481999430163, 2762.7927905407173, 2787.776977841778, 2787.958180627292, 2793.1899749072745, 2688.7042425333198, 2700.297922540144, 2707.878145483458, 2708.553088740365, 2723.6323096381934, 2640.0363867188435, 2643.193825883105, 2660.4679064187144, 2668.826526275786, 2683.1413947536794, 2577.2268319504074, 2586.1336452288506, 2593.7924966002674, 2607.687077550706, 2610.8955641774305, 15013.774793378108, 15112.319945602474, 15118.244087795567, 15308.158051307173, 15316.693666126726, 7465.925340746578, 7752.302292793675, 7756.534607923486, 7774.727884524014, 7793.103793063813, 5076.923846142311, 5261.158214685632, 5330.333708286465, 5374.059539580558, 5382.085045542267, 1853.416173905229, 1929.488685498344, 1937.2638397408894, 1949.483386902472, 1969.7439332886777, 26277.605835912476, 26557.0, 26646.866765666047, 26658.0, 26827.865860670572, 6503.317151699003, 6657.600543967377, 6674.2658307586125, 6769.255381907986, 6985.755498557526, 17076.146192690318, 17100.572485687957, 17108.914455427643, 17122.0, 17122.40071597488, 8032.638531266107, 8034.638441270157, 8084.595770211466, 8117.472364296302, 8120.390970677105, 7248.130224373109, 7394.186639469654, 7416.555006699616, 7441.293077157661, 7441.479096463196, 4971.950280497221, 5099.388073431212, 5122.667026643257, 5137.383513978347, 5170.793168273302, 1525.3974680001338, 1540.9922950385176, 1551.100361790159, 1555.5100143454777, 1563.5934656989036, 852.3649880838691, 869.1004810021598, 880.4893161966045, 887.1793590928495, 897.9012308646044, 7244.13070431541, 7318.3047610476915, 7319.121705395387, 7402.851942961111, 8205.58972051395, 726.7601691441812, 727.4544091931052, 728.8505856299446, 734.2694019450681, 742.4283301857539, 4467.106578684276, 4535.501094879561, 4540.659450541157, 4545.318202269686, 4598.2412901871485, 20873.582528349347, 21096.367108986757, 21670.34988950334, 21936.232231871807, 22000.779992200194, 21139.0, 21218.151273948868, 21592.35222943314, 21701.34895953124, 22018.229361972255, 11041.282316649393, 11148.442577871074, 11256.099512039018, 11262.155338349656, 11516.884831151749, 7902.130765615892, 7971.0833254174195, 8029.59852007409, 8090.150534193825, 8154.796130096795, 17682.5579360517, 18360.816391836444, 18451.44645660632, 19084.332048378794, 19164.329248476235, 17731.202095905457, 19340.323088691828, 19374.612507750047, 19431.805681943, 19775.505612359808, 10719.249652524248, 10914.0, 10951.780964380509, 10957.232993690364, 10960.616378426717, 13109.27898965566, 13977.091489053179, 14042.578722638336, 14043.244594425696, 14145.434182632991, 11306.208565400671, 11760.470778815145, 11772.293662380285, 11809.940950295193, 11958.940205298917, 11105.888941110808, 11343.829842552203, 11351.205415620827, 11544.769104617693, 11766.294022358343, 9739.902600974183, 9951.651692191028, 9983.0, 10000.349977251455, 10009.299349045497, 7063.894041589483, 7072.5402848814665, 7079.716811327695, 7100.751473698602, 7260.0, 7344.559326440431, 7454.291842274975, 7484.738034168778, 7527.435442341737, 7568.508046976929], "value": 6583.861652469956, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [499.15144254766903, 504.7123139810307, 526.1502673182811, 533.5118366694475, 536.2224774077586, 6210.826210826214, 6304.873902521953, 6314.494840412767, 6351.872962540752, 6402.455791257748, 6123.8162855114415, 6127.3872612738705, 6172.197614310134, 6228.937710622892, 6261.436470717635, 5152.304438900738, 5177.792888284464, 5184.0, 5198.324217851693, 5200.895982080356, 5078.1874900016, 5122.897542049157, 5194.896102077956, 5209.869753256161, 5265.815696450625, 4735.3133795599615, 4837.0, 4916.631252656047, 4923.532264434873, 4936.432310284327, 4906.386701662293, 4935.9753201234125, 4959.6528243023, 4986.750662466899, 5013.774380152884, 4424.225760491901, 4431.955680443187, 4456.17560751262, 4472.932906006413, 4475.418195634579, 6031.24609423822, 6080.452759251644, 6087.573869829113, 6132.28996457146, 6158.291796443422, 5655.123455864347, 5677.233573467571, 5690.7439165237665, 5703.486686198221, 5727.455891690324, 6408.67956602168, 6468.8059358219325, 6495.512836537278, 6538.411542961157, 6548.116004339401, 4642.234031384817, 4757.952420475785, 4793.448753393334, 4836.243341295463, 4899.167141585939, 6682.625274236528, 6692.498062645321, 6701.564398314143, 6726.663666816639, 6815.625140617264, 4885.6335774817035, 4909.140900342426, 4922.138625740481, 4932.55606995365, 4949.628777841676, 4868.732219727949, 5000.799968001312, 5037.861381390961, 5053.2420136979745, 5068.518490743373, 5633.352164501053, 5634.211210430543, 5658.002517331642, 5678.176664383641, 5710.2576665033275, 6514.459360849272, 6556.492006838454, 6563.638999855054, 6586.37429444202, 6623.43700785429, 1704.3949397963793, 1727.7062899307148, 1740.0, 1746.5982823950308, 1751.6146447781723, 1171.5782318365382, 1199.9820002699967, 1231.2673958994385, 1234.4630085912656, 1236.3818090954524, 5664.518515926193, 5664.575156863251, 5681.0, 5700.458456446631, 5758.683272420057, 6651.16860392451, 6690.565113267622, 6768.323167683291, 6785.660716964132, 6803.333183370106, 5616.382197958222, 5643.40744221859, 5709.143628455765, 5709.22925405065, 5710.971445142831, 3506.474028895686, 3539.292441282421, 3573.7855728656364, 3573.9278216534935, 3600.4959305697225, 6331.651759153198, 6346.746130154742, 6503.154589903377, 6564.4748420127235, 6569.146011018537, 6717.832054198587, 6825.0, 6837.265093962355, 6861.0, 6963.234044255128, 6425.614463132227, 6449.903251451138, 6489.286178520359, 6536.7712130075215, 6569.343065693392, 6126.816195514141, 6669.933300667125, 6773.288804675438, 6827.795166145023, 6834.838077526932, 6340.714667839866, 6491.253505846699, 6692.1969363674725, 6756.756756756686, 6788.830279243059, 6334.12272550143, 6375.139356186855, 6402.023059277459, 6427.935720642734, 6457.741690332522, 4947.208446648519, 4954.801807927643, 4985.252212168204, 4988.501149884983, 5001.674891132065, 6649.506435086842, 6661.700223490052, 6807.489438292247, 6811.93188068113, 6838.487113466411, 6451.645159516084, 6502.934970650233, 6566.146400968035, 6568.540202185801, 6599.934000659932, 6415.65271293015, 6501.4798816095545, 6531.575447595891, 6542.869142617216, 6605.372489613479, 6326.3041065483685, 6408.4232419080645, 6409.814184375906, 6454.386833250834, 6512.283648798533, 6507.804765857032, 6550.803475895731, 6604.471642268511, 6657.2677005528385, 6663.300353462817, 6318.27339855904, 6365.427111559982, 6398.328175541501, 6428.0, 6444.226692796707], "value": 5043.932786522977, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [854.2397266432874, 894.8210357928414, 913.6984795017645, 921.7234829551137, 936.2650319499195, 18976.146073426695, 19893.403197904066, 19958.101885415173, 19961.401157965247, 19971.60056798867, 20234.494137646565, 20324.796752032475, 20348.898255508702, 20382.796172038274, 20469.0, 975.3367709957226, 978.1783302026297, 985.029745700488, 988.2094324540375, 989.5744829723216, 992.1715367668006, 992.2062350119911, 992.2211064314514, 992.8510723391477, 992.8510723391477, 1037.0510982451049, 1041.8437234414823, 1042.3120740311397, 1046.5865982936734, 1047.455323231919, 1010.9595616175344, 1032.3135115148418, 1035.0787798859021, 1040.7814358984585, 1047.314009323894, 751.70683433461, 755.2296657409412, 757.526545908807, 758.8406434648675, 769.7190525458224, 19042.33351832693, 19303.613927721508, 19323.03384830753, 19325.13036913342, 19382.32161874342, 21358.46603834901, 21493.462663433384, 21740.239091631716, 21932.780672193232, 22082.558348832932, 17138.31446742129, 17163.399281025104, 17736.0, 17841.821581784276, 17914.820851791446, 3731.067233191702, 3734.3464893643777, 3760.417135344026, 3773.811309434517, 3774.2074164425503, 139939.30030349782, 141383.0, 141656.0, 142384.0, 144235.0, 16885.83114168867, 17131.486055418358, 17300.826991730173, 17461.30154793794, 17477.038762868164, 31013.379732405225, 31641.52537711936, 31684.524732129037, 31859.0, 31946.84026579852, 8083.110857805636, 8093.271605555528, 8119.634616442274, 8171.0, 8178.713745018896, 4018.3972404139026, 4174.45732054837, 4194.0563373240775, 4195.832166713297, 4211.873643790691, 5424.7558859850615, 5525.806596769094, 5525.861853453695, 5555.194496798023, 5579.804706835323, 985.7979114281555, 1006.3307900246255, 1014.6854475112739, 1020.6835880876952, 1025.9794804103876, 629.8016124920636, 657.710607332772, 661.9205695316497, 669.6015870557011, 669.9765508207287, 10646.467676616137, 10680.359178449318, 10692.786144277072, 10955.50700218492, 11261.774764504664, 570.2330365658183, 571.6627189957861, 582.3506789929284, 587.0460501684762, 590.5747861539685, 5197.194434862602, 5271.393789714155, 5277.472252774692, 5343.759530821045, 5376.220448035013, 119519.0, 121958.0, 122868.38565807114, 124226.0, 126303.368483157, 104516.0, 105649.0, 106803.46598266959, 107831.46084269685, 109131.45434272778, 94064.52967735255, 94349.0, 98261.50869245607, 100163.49918250216, 100234.0, 9575.473348965874, 9637.759056023655, 9921.65274215399, 9926.404415735078, 9952.303338766507, 42127.36808947929, 42287.788561057, 44210.0, 44405.555944440144, 45211.321830173234, 53807.0, 53939.190912137135, 54895.17657235065, 54926.72536637291, 56358.0, 13595.388207530486, 13826.516071937434, 13885.514007009706, 13928.373223205183, 13980.510682126076, 15571.221438927781, 15694.843051569795, 15727.0, 15893.0, 15903.920480397524, 15133.697326053638, 15470.226488675746, 15498.0, 15625.374985000473, 15638.609034774221, 13753.0, 13819.447222111405, 14158.292085395484, 14171.0, 14231.288435578386, 14726.631834203801, 14762.188079655292, 14977.251137443302, 14994.325255363317, 15016.924915375354, 10569.312994655324, 10722.785544289227, 10772.030517253485, 10929.234953553176, 10983.286086404358, 11290.435478225892, 11312.0, 11316.094712423152, 11421.31472111676, 11438.37088960082], "value": 8702.041479129528, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1476.5, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 108.0, 107.0, 121.0, 107.0, 117.0, 107.0, 112.0, 108.0, 108.0], "value": 110.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [121.0, 121.0, 127.0, 118.0, 134.0, 122.0, 123.0, 117.0, 118.0, 159.0], "value": 126.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [171.0, 171.0, 163.0, 166.0, 164.0, 164.0, 171.0, 165.0, 168.0, 167.0], "value": 167.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 79.0, 78.0, 74.0, 75.0, 82.0, 82.0, 76.0, 83.0, 74.0], "value": 77.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 89.0, 87.0, 80.0, 84.0, 88.0, 80.0, 79.0, 87.0, 79.0], "value": 84.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 114.0, 115.0, 120.0, 114.0, 114.0, 115.0, 118.0, 115.0, 118.0], "value": 115.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 149.0, 150.0, 150.0, 151.0, 151.0, 148.0, 153.0, 148.0, 149.0], "value": 149.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 95.0, 97.0, 94.0, 101.0, 102.0, 94.0, 96.0, 96.0, 95.0], "value": 96.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 57.0, 56.0, 55.0, 54.0, 54.0, 60.0, 55.0, 55.0, 54.0], "value": 55.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [37.0, 43.0, 46.0, 46.0, 38.0, 44.0, 41.0, 40.0, 38.0, 43.0], "value": 41.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 75.0, 80.0, 77.0, 79.0, 79.0, 87.0, 80.0, 76.0, 80.0], "value": 79.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [123.0, 124.0, 132.0, 124.0, 135.0, 137.0, 121.0, 118.0, 124.0, 135.0], "value": 127.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [173.0, 191.0, 176.0, 171.0, 170.0, 174.0, 182.0, 170.0, 173.0, 173.0], "value": 175.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 67.0, 68.0, 69.0, 71.0, 67.0, 70.0, 73.0, 66.0, 75.0], "value": 69.8, "unit": "score"}]}]} 11:37:12 INFO - Return code: 0 11:37:12 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 11:37:12 INFO - # TBPL SUCCESS # 11:37:12 INFO - Running post-action listener: _package_coverage_data 11:37:12 INFO - Running post-action listener: _resource_record_post_action 11:37:12 INFO - [mozharness: 2017-09-09 18:37:12.516037Z] Finished run-tests step (success) 11:37:12 INFO - Running post-run listener: _resource_record_post_run 11:37:12 INFO - Total resource usage - Wall time: 1194s; CPU: 13.0%; Read bytes: 57344; Write bytes: 301056000; Read time: 192; Write time: 160096 11:37:12 INFO - TinderboxPrint: CPU usage
13.2% 11:37:12 INFO - TinderboxPrint: I/O read bytes / time
57,344 / 192 11:37:12 INFO - TinderboxPrint: I/O write bytes / time
301,056,000 / 160,096 11:37:12 INFO - TinderboxPrint: CPU idle
8,254.6 (86.7%) 11:37:12 INFO - TinderboxPrint: CPU user
1,200.3 (12.6%) 11:37:12 INFO - TinderboxPrint: Swap in / out
0 / 0 11:37:12 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 2441216; Read time: 0; Write time: 372 11:37:12 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 11:37:12 INFO - run-tests - Wall time: 1177s; CPU: 13.0%; Read bytes: 57344; Write bytes: 285040640; Read time: 192; Write time: 142788 11:37:13 INFO - Running post-run listener: _upload_blobber_files 11:37:13 INFO - Blob upload gear active. 11:37:13 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 11:37:13 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:37:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 11:37:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 11:37:13 INFO - (blobuploader) - INFO - Open directory for files ... 11:37:13 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 11:37:13 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:37:13 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:37:14 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 11:37:14 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:37:14 INFO - (blobuploader) - INFO - Done attempting. 11:37:14 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 11:37:14 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:37:14 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:37:15 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 11:37:15 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:37:15 INFO - (blobuploader) - INFO - Done attempting. 11:37:15 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 11:37:15 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:37:15 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:37:16 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 11:37:16 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:37:16 INFO - (blobuploader) - INFO - Done attempting. 11:37:16 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 11:37:16 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:37:16 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:37:23 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 11:37:23 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:37:23 INFO - (blobuploader) - INFO - Done attempting. 11:37:23 INFO - (blobuploader) - INFO - Iteration through files over. 11:37:23 INFO - Return code: 0 11:37:23 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 11:37:23 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 11:37:23 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/50c7ba0abe688846bceea11b9b795fb87c6f97e04a0146e165f3834c3f2bfe948dce15b658bab71a7d44b0b38fe22d38620bc96e45420daa1191d647d3a40ef1", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b274af877d32979388c4eaa4053f503bf40c878996570906b2e33d5ff426f94437bc43af8de2f76396e97e0a76ab2378819bc986b584b6ac8c0b796b9005f724", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/44d89c6073be3bca3b061bc5db05a0a72270b74b6273b1e51dd38150c6f203fdaa2763160c93fb93e6a704db957f26e024ce74cc1d880619dfa1739e9b42213a", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/369494e87384bcf899ef4a778622adcd36fd78ed680d0dc9e2c80a72688d618abc4f3f81613c357879ec6e8e0d0ca018d2ffc9692a979a105b41855b97a5c56e"} 11:37:23 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 11:37:23 INFO - Writing to file /builds/slave/test/properties/blobber_files 11:37:23 INFO - Contents: 11:37:23 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/50c7ba0abe688846bceea11b9b795fb87c6f97e04a0146e165f3834c3f2bfe948dce15b658bab71a7d44b0b38fe22d38620bc96e45420daa1191d647d3a40ef1", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b274af877d32979388c4eaa4053f503bf40c878996570906b2e33d5ff426f94437bc43af8de2f76396e97e0a76ab2378819bc986b584b6ac8c0b796b9005f724", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/44d89c6073be3bca3b061bc5db05a0a72270b74b6273b1e51dd38150c6f203fdaa2763160c93fb93e6a704db957f26e024ce74cc1d880619dfa1739e9b42213a", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/369494e87384bcf899ef4a778622adcd36fd78ed680d0dc9e2c80a72688d618abc4f3f81613c357879ec6e8e0d0ca018d2ffc9692a979a105b41855b97a5c56e"} 11:37:23 INFO - Running post-run listener: copy_logs_to_upload_dir 11:37:23 INFO - Copying logs to upload dir... 11:37:23 INFO - mkdir: /builds/slave/test/build/upload/logs 11:37:23 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1242.899677 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 42 secs) (at 2017-09-09 11:37:23.646792) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-09 11:37:23.650673) ========= 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=db7e7c15f3ca076d53731445000001ba-1504980998.160841-336240873 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/50c7ba0abe688846bceea11b9b795fb87c6f97e04a0146e165f3834c3f2bfe948dce15b658bab71a7d44b0b38fe22d38620bc96e45420daa1191d647d3a40ef1", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b274af877d32979388c4eaa4053f503bf40c878996570906b2e33d5ff426f94437bc43af8de2f76396e97e0a76ab2378819bc986b584b6ac8c0b796b9005f724", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/44d89c6073be3bca3b061bc5db05a0a72270b74b6273b1e51dd38150c6f203fdaa2763160c93fb93e6a704db957f26e024ce74cc1d880619dfa1739e9b42213a", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/369494e87384bcf899ef4a778622adcd36fd78ed680d0dc9e2c80a72688d618abc4f3f81613c357879ec6e8e0d0ca018d2ffc9692a979a105b41855b97a5c56e"} build_url:https://queue.taskcluster.net/v1/task/TzHGlhiiRQCEEVlLYRX_gg/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011148 build_url: 'https://queue.taskcluster.net/v1/task/TzHGlhiiRQCEEVlLYRX_gg/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/50c7ba0abe688846bceea11b9b795fb87c6f97e04a0146e165f3834c3f2bfe948dce15b658bab71a7d44b0b38fe22d38620bc96e45420daa1191d647d3a40ef1", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b274af877d32979388c4eaa4053f503bf40c878996570906b2e33d5ff426f94437bc43af8de2f76396e97e0a76ab2378819bc986b584b6ac8c0b796b9005f724", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/44d89c6073be3bca3b061bc5db05a0a72270b74b6273b1e51dd38150c6f203fdaa2763160c93fb93e6a704db957f26e024ce74cc1d880619dfa1739e9b42213a", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/369494e87384bcf899ef4a778622adcd36fd78ed680d0dc9e2c80a72688d618abc4f3f81613c357879ec6e8e0d0ca018d2ffc9692a979a105b41855b97a5c56e"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-09 11:37:23.679727) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-09 11:37:23.680110) ========= 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=db7e7c15f3ca076d53731445000001ba-1504980998.160841-336240873 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004494 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-09 11:37:23.766504) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-09 11:37:23.766980) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-09 11:37:23.767333) ========= ========= Total master_lag: 0.20 =========