builder: mozilla-central_ubuntu64_hw_qr_test-dromaeojs-e10s slave: talos-linux64-ix-056 starttime: 1507056631.4 results: success (0) revision: 9be05b2177667ed8221f9da4fdcc200dbdf3de62 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-10-03 11:50:31.395476) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-10-03 11:50:31.395947) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-10-03 11:50:31.396233) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-10-03 11:50:31.411977) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-10-03 11:50:31.412305) ========= 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=52faae308a556c440401f8e5000001e8-1507056630.497244-2141909120 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-10-03 11:50:31-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 215M=0s 2017-10-03 11:50:31 (215 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.099020 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-10-03 11:50:31.528595) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-10-03 11:50:31.528901) ========= 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=52faae308a556c440401f8e5000001e8-1507056630.497244-2141909120 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018641 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-10-03 11:50:31.578893) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-10-03 11:50:31.579232) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 9be05b2177667ed8221f9da4fdcc200dbdf3de62 --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 9be05b2177667ed8221f9da4fdcc200dbdf3de62 --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=52faae308a556c440401f8e5000001e8-1507056630.497244-2141909120 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-10-03 11:50:31,544 truncating revision to first 12 chars 2017-10-03 11:50:31,544 Setting DEBUG logging. 2017-10-03 11:50:31,544 attempt 1/10 2017-10-03 11:50:31,544 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/9be05b217766?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-10-03 11:50:31,799 unpacking tar archive at: mozilla-central-9be05b217766/testing/mozharness/ program finished with exit code 0 elapsedTime=0.559767 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-10-03 11:50:32.155652) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-10-03 11:50:32.155978) ========= script_repo_revision: 9be05b2177667ed8221f9da4fdcc200dbdf3de62 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-10-03 11:50:32.156348) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-10-03 11:50:32.156602) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-10-03 11:50:32.170336) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 50 secs) (at 2017-10-03 11:50:32.170673) ========= /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=52faae308a556c440401f8e5000001e8-1507056630.497244-2141909120 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 11:50:32 INFO - MultiFileLogger online at 20171003 11:50:32 in /builds/slave/test 11:50:32 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:50:32 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 11:50:32 INFO - {'append_to_log': False, 11:50:32 INFO - 'base_work_dir': '/builds/slave/test', 11:50:32 INFO - 'blob_upload_branch': 'Firefox', 11:50:32 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 11:50:32 INFO - 'branch': 'Firefox', 11:50:32 INFO - 'buildbot_json_path': 'buildprops.json', 11:50:32 INFO - 'code_coverage': False, 11:50:32 INFO - 'config_files': ('talos/linux_config.py',), 11:50:32 INFO - 'default_actions': ('clobber', 11:50:32 INFO - 'read-buildbot-config', 11:50:32 INFO - 'download-and-extract', 11:50:32 INFO - 'populate-webroot', 11:50:32 INFO - 'create-virtualenv', 11:50:32 INFO - 'install', 11:50:32 INFO - 'setup-mitmproxy', 11:50:32 INFO - 'run-tests'), 11:50:32 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 11:50:32 INFO - 'disable_ccov_upload': False, 11:50:32 INFO - 'disable_stylo': False, 11:50:32 INFO - 'download_minidump_stackwalk': True, 11:50:32 INFO - 'download_symbols': 'ondemand', 11:50:32 INFO - 'enable_stylo': False, 11:50:32 INFO - 'enable_webrender': False, 11:50:32 INFO - 'exes': {'tooltool.py': '/tools/tooltool.py'}, 11:50:32 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 11:50:32 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 11:50:32 INFO - 'gecko_profile': False, 11:50:32 INFO - 'gecko_profile_interval': 0, 11:50:32 INFO - 'installer_path': 'installer.exe', 11:50:32 INFO - 'log_level': 'info', 11:50:32 INFO - 'log_name': 'talos', 11:50:32 INFO - 'log_to_console': True, 11:50:32 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 11:50:32 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 11:50:32 INFO - 'opt_config_files': (), 11:50:32 INFO - 'pip_index': False, 11:50:32 INFO - 'suite': 'dromaeojs-e10s', 11:50:32 INFO - 'system_bits': '32', 11:50:32 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 11:50:32 INFO - 'title': 'talos-linux64-ix-056', 11:50:32 INFO - 'tooltool_cache': '/builds/tooltool_cache', 11:50:32 INFO - 'use_talos_json': True, 11:50:32 INFO - 'verify': 'False', 11:50:32 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 11:50:32 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 11:50:32 INFO - 'work_dir': 'build'} 11:50:32 INFO - [mozharness: 2017-10-03 18:50:32.280108Z] Running clobber step. 11:50:32 INFO - Running pre-action listener: _resource_record_pre_action 11:50:32 INFO - Running main action method: clobber 11:50:32 INFO - rmtree: /builds/slave/test/build 11:50:32 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 11:50:33 INFO - Running post-action listener: _resource_record_post_action 11:50:33 INFO - [mozharness: 2017-10-03 18:50:33.266343Z] Finished clobber step (success) 11:50:33 INFO - [mozharness: 2017-10-03 18:50:33.266441Z] Running read-buildbot-config step. 11:50:33 INFO - Running pre-action listener: _resource_record_pre_action 11:50:33 INFO - Running main action method: read_buildbot_config 11:50:33 INFO - Using buildbot properties: 11:50:33 INFO - { 11:50:33 INFO - "project": "", 11:50:33 INFO - "product": "firefox", 11:50:33 INFO - "who": "ffxbld@noreply.mozilla.org", 11:50:33 INFO - "installer_path": "public/build/target.tar.bz2", 11:50:33 INFO - "builddir": "mozilla-central_ubuntu64_hw_qr_test-dromaeojs-e10s", 11:50:33 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 11:50:33 INFO - "buildername": "Ubuntu HW 12.04 x64 qr mozilla-central talos dromaeojs-e10s", 11:50:33 INFO - "stage_platform": "linux64-qr", 11:50:33 INFO - "basedir": "/builds/slave/test", 11:50:33 INFO - "buildnumber": 98, 11:50:33 INFO - "platform": "ubuntu64_hw_qr", 11:50:33 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 11:50:33 INFO - "slavebuilddir": "test", 11:50:33 INFO - "taskId": "WKiksGqJRy2IscD-pCKDWQ", 11:50:33 INFO - "branch": "mozilla-central", 11:50:33 INFO - "script_repo_revision": "production", 11:50:33 INFO - "revision": "9be05b2177667ed8221f9da4fdcc200dbdf3de62", 11:50:33 INFO - "slavename": "talos-linux64-ix-056", 11:50:33 INFO - "repo_path": "mozilla-central" 11:50:33 INFO - } 11:50:33 INFO - Finding installer, test and symbols from parent task. 11:50:33 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/WKiksGqJRy2IscD-pCKDWQ'}, attempt #1 11:50:34 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/WKiksGqJRy2IscD-pCKDWQ'}, attempt #1 11:50:34 INFO - Task dependencies: Y228oe7GQHKzMAnD1Lmgzg 11:50:34 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Y228oe7GQHKzMAnD1Lmgzg'}, attempt #1 11:50:35 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/Y228oe7GQHKzMAnD1Lmgzg/artifacts/public/build/target.tar.bz2 11:50:35 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/Y228oe7GQHKzMAnD1Lmgzg/artifacts/public/build/target.test_packages.json 11:50:35 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/Y228oe7GQHKzMAnD1Lmgzg/artifacts/public/build/target.crashreporter-symbols.zip 11:50:35 INFO - Running post-action listener: _resource_record_post_action 11:50:35 INFO - [mozharness: 2017-10-03 18:50:35.219192Z] Finished read-buildbot-config step (success) 11:50:35 INFO - [mozharness: 2017-10-03 18:50:35.219414Z] Running download-and-extract step. 11:50:35 INFO - Running pre-action listener: _resource_record_pre_action 11:50:35 INFO - Running main action method: download_and_extract 11:50:35 INFO - mkdir: /builds/slave/test/build/tests 11:50: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:50:35 INFO - trying https://queue.taskcluster.net/v1/task/Y228oe7GQHKzMAnD1Lmgzg/artifacts/public/build/target.test_packages.json 11:50:35 INFO - Downloading https://queue.taskcluster.net/v1/task/Y228oe7GQHKzMAnD1Lmgzg/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 11:50:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Y228oe7GQHKzMAnD1Lmgzg/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 11:50:35 INFO - Downloaded 989 bytes. 11:50:35 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 11:50:35 INFO - Using the following test package requirements: 11:50:35 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 11:50:35 INFO - u'common': [u'target.common.tests.zip'], 11:50:35 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 11:50:35 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 11:50:35 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 11:50:35 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 11:50:35 INFO - u'mozbase': [u'target.common.tests.zip'], 11:50:35 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 11:50:35 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 11:50:35 INFO - u'web-platform': [u'target.common.tests.zip', 11:50:35 INFO - u'target.web-platform.tests.tar.gz'], 11:50:35 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 11:50:35 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite categories: ['common', 'talos'] 11:50:35 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Y228oe7GQHKzMAnD1Lmgzg/artifacts/public/build/target.common.tests.zip 11:50:35 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Y228oe7GQHKzMAnD1Lmgzg/artifacts/public/build/target.common.tests.zip'}, attempt #1 11:50:35 INFO - Fetch https://queue.taskcluster.net/v1/task/Y228oe7GQHKzMAnD1Lmgzg/artifacts/public/build/target.common.tests.zip into memory 11:50:36 INFO - Content-Length response header: 55304212 11:50:36 INFO - Bytes received: 55304212 11:50:47 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Y228oe7GQHKzMAnD1Lmgzg/artifacts/public/build/target.talos.tests.zip 11:50:47 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Y228oe7GQHKzMAnD1Lmgzg/artifacts/public/build/target.talos.tests.zip'}, attempt #1 11:50:47 INFO - Fetch https://queue.taskcluster.net/v1/task/Y228oe7GQHKzMAnD1Lmgzg/artifacts/public/build/target.talos.tests.zip into memory 11:50:48 INFO - Content-Length response header: 14522427 11:50:48 INFO - Bytes received: 14522427 11:50:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:50:48 INFO - trying https://queue.taskcluster.net/v1/task/Y228oe7GQHKzMAnD1Lmgzg/artifacts/public/build/target.tar.bz2 11:50:48 INFO - Downloading https://queue.taskcluster.net/v1/task/Y228oe7GQHKzMAnD1Lmgzg/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 11:50:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Y228oe7GQHKzMAnD1Lmgzg/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 11:50:49 INFO - Downloaded 61575035 bytes. 11:50:49 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Y228oe7GQHKzMAnD1Lmgzg/artifacts/public/build/target.tar.bz2 11:50:49 INFO - mkdir: /builds/slave/test/properties 11:50:49 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 11:50:49 INFO - Writing to file /builds/slave/test/properties/build_url 11:50:49 INFO - Contents: 11:50:49 INFO - build_url:https://queue.taskcluster.net/v1/task/Y228oe7GQHKzMAnD1Lmgzg/artifacts/public/build/target.tar.bz2 11:50:49 INFO - Running post-action listener: _resource_record_post_action 11:50:49 INFO - Running post-action listener: find_tests_for_verification 11:50:49 INFO - Running post-action listener: set_extra_try_arguments 11:50:49 INFO - [mozharness: 2017-10-03 18:50:49.869189Z] Finished download-and-extract step (success) 11:50:49 INFO - [mozharness: 2017-10-03 18:50:49.869288Z] Running populate-webroot step. 11:50:49 INFO - Running pre-action listener: _resource_record_pre_action 11:50:49 INFO - Running main action method: populate_webroot 11:50:49 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 11:50:49 INFO - 'chromez-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 11:50:49 INFO - 'tests': ['tresize', 11:50:49 INFO - 'tcanvasmark']}, 11:50:49 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 11:50:49 INFO - 'dromaeojs-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 11:50:49 INFO - 'tests': ['dromaeo_css', 11:50:49 INFO - 'kraken']}, 11:50:49 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 11:50:49 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:50:49 INFO - 'g1-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 11:50:49 INFO - 'talos_options': ['--disable-stylo'], 11:50:49 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:50:49 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 11:50:49 INFO - 'tests': ['damp', 'tps']}, 11:50:49 INFO - 'g2-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 11:50:49 INFO - 'talos_options': ['--disable-stylo'], 11:50:49 INFO - 'tests': ['damp', 'tps']}, 11:50:49 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 11:50:49 INFO - 'g3-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 11:50:49 INFO - 'tests': ['dromaeo_dom']}, 11:50:49 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 11:50:49 INFO - 'g4-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 11:50:49 INFO - 'tests': ['basic_compositor_video', 11:50:49 INFO - 'glvideo']}, 11:50:49 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 11:50:49 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 11:50:49 INFO - 'g5-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 11:50:49 INFO - 'talos_options': ['--disable-stylo'], 11:50:49 INFO - 'tests': ['ts_paint_webext', 11:50:49 INFO - 'tp5o_webext']}, 11:50:49 INFO - 'other-e10s': {'tests': ['a11yr', 11:50:49 INFO - 'ts_paint', 11:50:49 INFO - 'tpaint', 11:50:49 INFO - 'sessionrestore', 11:50:49 INFO - 'sessionrestore_many_windows', 11:50:49 INFO - 'sessionrestore_no_auto_restore', 11:50:49 INFO - 'tabpaint', 11:50:49 INFO - 'cpstartup']}, 11:50:49 INFO - 'other-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 11:50:49 INFO - 'tests': ['a11yr', 11:50:49 INFO - 'ts_paint', 11:50:49 INFO - 'tpaint', 11:50:49 INFO - 'sessionrestore', 11:50:49 INFO - 'sessionrestore_many_windows', 11:50:49 INFO - 'sessionrestore_no_auto_restore', 11:50:49 INFO - 'tabpaint', 11:50:49 INFO - 'cpstartup']}, 11:50:49 INFO - 'perf-reftest-e10s': {'tests': ['perf_reftest']}, 11:50:49 INFO - 'perf-reftest-singletons-e10s': {'tests': ['perf_reftest_singletons']}, 11:50:49 INFO - 'perf-reftest-singletons-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 11:50:49 INFO - 'tests': ['perf_reftest_singletons']}, 11:50:49 INFO - 'perf-reftest-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 11:50:49 INFO - 'tests': ['perf_reftest']}, 11:50:49 INFO - 'svgr-e10s': {'tests': ['tsvgx', 11:50:49 INFO - 'tsvgr_opacity', 11:50:49 INFO - 'tart', 11:50:49 INFO - 'tscrollx', 11:50:49 INFO - 'tsvg_static']}, 11:50:49 INFO - 'svgr-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 11:50:49 INFO - 'tests': ['tsvgx', 11:50:49 INFO - 'tsvgr_opacity', 11:50:49 INFO - 'tart', 11:50:49 INFO - 'tscrollx', 11:50:49 INFO - 'tsvg_static']}, 11:50:49 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 11:50:49 INFO - 'tp5o-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 11:50:49 INFO - 'talos_options': ['--disable-stylo'], 11:50:49 INFO - 'tests': ['tp5o']}, 11:50:49 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 11:50:49 INFO - 'mitmproxy_release_bin_osx': 'mitmproxy-2.0.2-osx.tar.gz', 11:50:49 INFO - 'talos_options': ['--mitmproxy', 11:50:49 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 11:50:49 INFO - '--firstNonBlankPaint'], 11:50:49 INFO - 'tests': ['tp6_google', 11:50:49 INFO - 'tp6_youtube', 11:50:49 INFO - 'tp6_amazon', 11:50:49 INFO - 'tp6_facebook']}, 11:50:49 INFO - 'tp6-stylo-disabled-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 11:50:49 INFO - 'mitmproxy_release_bin_osx': 'mitmproxy-2.0.2-osx.tar.gz', 11:50:49 INFO - 'talos_options': ['--disable-stylo', 11:50:49 INFO - '--mitmproxy', 11:50:49 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 11:50:49 INFO - '--firstNonBlankPaint'], 11:50:49 INFO - 'tests': ['tp6_google', 11:50:49 INFO - 'tp6_youtube', 11:50:49 INFO - 'tp6_amazon', 11:50:49 INFO - 'tp6_facebook']}, 11:50:49 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 11:50:49 INFO - 'mitmproxy_release_bin_osx': 'mitmproxy-2.0.2-osx.tar.gz', 11:50:49 INFO - 'talos_options': ['--stylo-threads=1', 11:50:49 INFO - '--mitmproxy', 11:50:49 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 11:50:49 INFO - '--firstNonBlankPaint'], 11:50:49 INFO - 'tests': ['tp6_google', 11:50:49 INFO - 'tp6_youtube', 11:50:49 INFO - 'tp6_amazon', 11:50:49 INFO - 'tp6_facebook']}, 11:50:49 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 11:50:49 INFO - 'talos_options': ['--xperf_path', 11:50:49 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:50:49 INFO - 'tests': ['tp5n']}, 11:50:49 INFO - 'xperf-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 11:50:49 INFO - 'talos_options': ['--disable-stylo', 11:50:49 INFO - '--xperf_path', 11:50:49 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:50:49 INFO - 'tests': ['tp5n']}}} 11:50:49 INFO - Running post-action listener: _resource_record_post_action 11:50:49 INFO - [mozharness: 2017-10-03 18:50:49.884815Z] Finished populate-webroot step (success) 11:50:49 INFO - [mozharness: 2017-10-03 18:50:49.884905Z] Running create-virtualenv step. 11:50:49 INFO - Running pre-action listener: _resource_record_pre_action 11:50:49 INFO - Running main action method: create_virtualenv 11:50:49 INFO - Creating virtualenv /builds/slave/test/build/venv 11:50:49 INFO - Running command: ['virtualenv', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 11:50:49 INFO - Copy/paste: virtualenv --no-site-packages --distribute /builds/slave/test/build/venv 11:50:49 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 11:50:49 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 11:50:49 INFO - New python executable in /builds/slave/test/build/venv/bin/python 11:50:50 INFO - Installing distribute.............................................................................................................................................................................................done. 11:50:50 INFO - Installing pip...............done. 11:50:50 INFO - Return code: 0 11:50:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 11:50:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 11:50:50 INFO - Reading from file tmpfile_stdout 11:50:50 INFO - Output received: 11:50:50 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:50:50 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 11:50:50 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:50:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:50:50 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:50:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:50:50 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 0x207e1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2246b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23eb9c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23e8d60>, '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 0x23e9a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23e9ef0>, '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': '52faae308a556c440401f8e5000001e8-1507056630.497244-2141909120', '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:50:50 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:50:50 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:50:50 INFO - Using env: {'DISPLAY': ':0', 11:50:50 INFO - 'HOME': '/home/cltbld', 11:50:50 INFO - 'LANG': 'en_US.UTF-8', 11:50:50 INFO - 'LANGUAGE': 'en_US:en', 11:50:50 INFO - 'LOGNAME': 'cltbld', 11:50:50 INFO - 'MAIL': '/var/mail/cltbld', 11:50:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:50:50 INFO - 'MOZ_NO_REMOTE': '1', 11:50:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:50:50 INFO - 'NO_EM_RESTART': '1', 11:50:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:50:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:50:50 INFO - 'PWD': '/builds/slave/test', 11:50:50 INFO - 'SHELL': '/bin/bash', 11:50:50 INFO - 'SHLVL': '1', 11:50:50 INFO - 'TERM': 'linux', 11:50:50 INFO - 'TMOUT': '86400', 11:50:50 INFO - 'USER': 'cltbld', 11:50:50 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1507056630.497244-2141909120', 11:50:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:50:50 INFO - '_': '/tools/buildbot/bin/python'} 11:50:53 INFO - Ignoring indexes: http://pypi.python.org/simple/ 11:50:53 INFO - Downloading/unpacking pip>=1.5 11:50:53 INFO - Running setup.py egg_info for package pip 11:50:53 INFO - warning: no files found matching 'pip/cacert.pem' 11:50:53 INFO - warning: no files found matching '*.html' under directory 'docs' 11:50:53 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 11:50:53 INFO - no previously-included directories found matching 'docs/_build/_sources' 11:50:53 INFO - Installing collected packages: pip 11:50:53 INFO - Found existing installation: pip 1.1 11:50:53 INFO - Uninstalling pip: 11:50:53 INFO - Successfully uninstalled pip 11:50:53 INFO - Running setup.py install for pip 11:50:53 INFO - warning: no files found matching 'pip/cacert.pem' 11:50:53 INFO - warning: no files found matching '*.html' under directory 'docs' 11:50:53 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 11:50:53 INFO - no previously-included directories found matching 'docs/_build/_sources' 11:50:53 INFO - Installing pip script to /builds/slave/test/build/venv/bin 11:50:53 INFO - Installing pip2.7 script to /builds/slave/test/build/venv/bin 11:50:53 INFO - Installing pip2 script to /builds/slave/test/build/venv/bin 11:50:53 INFO - Successfully installed pip 11:50:53 INFO - Cleaning up... 11:50:53 INFO - Return code: 0 11:50:53 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 11:50:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:50:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:50:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:50:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:50:53 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x207e1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2246b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23eb9c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23e8d60>, '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 0x23e9a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23e9ef0>, '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': '52faae308a556c440401f8e5000001e8-1507056630.497244-2141909120', '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:50:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 11:50:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 11:50:53 INFO - Using env: {'DISPLAY': ':0', 11:50:53 INFO - 'HOME': '/home/cltbld', 11:50:53 INFO - 'LANG': 'en_US.UTF-8', 11:50:53 INFO - 'LANGUAGE': 'en_US:en', 11:50:53 INFO - 'LOGNAME': 'cltbld', 11:50:53 INFO - 'MAIL': '/var/mail/cltbld', 11:50:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:50:53 INFO - 'MOZ_NO_REMOTE': '1', 11:50:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:50:53 INFO - 'NO_EM_RESTART': '1', 11:50:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:50:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:50:53 INFO - 'PWD': '/builds/slave/test', 11:50:53 INFO - 'SHELL': '/bin/bash', 11:50:53 INFO - 'SHLVL': '1', 11:50:53 INFO - 'TERM': 'linux', 11:50:53 INFO - 'TMOUT': '86400', 11:50:53 INFO - 'USER': 'cltbld', 11:50:53 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1507056630.497244-2141909120', 11:50:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:50:53 INFO - '_': '/tools/buildbot/bin/python'} 11:50:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:50:53 INFO - Downloading/unpacking psutil>=3.1.1 11:50:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:50:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:50:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:50:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:50:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 11:50:54 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:50:54 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:50:54 INFO - Installing collected packages: psutil 11:50:54 INFO - Running setup.py install for psutil 11:50:54 INFO - building 'psutil._psutil_linux' extension 11:50:54 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:50:55 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:50:55 INFO - building 'psutil._psutil_posix' extension 11:50:55 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:50:55 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:50:55 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:50:55 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:50:55 INFO - Successfully installed psutil 11:50:55 INFO - Cleaning up... 11:50:56 INFO - Return code: 0 11:50:56 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 11:50:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:50:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:50:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:50:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:50:56 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x207e1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2246b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23eb9c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23e8d60>, '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 0x23e9a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23e9ef0>, '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': '52faae308a556c440401f8e5000001e8-1507056630.497244-2141909120', '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:50:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 11:50:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 11:50:56 INFO - Using env: {'DISPLAY': ':0', 11:50:56 INFO - 'HOME': '/home/cltbld', 11:50:56 INFO - 'LANG': 'en_US.UTF-8', 11:50:56 INFO - 'LANGUAGE': 'en_US:en', 11:50:56 INFO - 'LOGNAME': 'cltbld', 11:50:56 INFO - 'MAIL': '/var/mail/cltbld', 11:50:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:50:56 INFO - 'MOZ_NO_REMOTE': '1', 11:50:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:50:56 INFO - 'NO_EM_RESTART': '1', 11:50:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:50:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:50:56 INFO - 'PWD': '/builds/slave/test', 11:50:56 INFO - 'SHELL': '/bin/bash', 11:50:56 INFO - 'SHLVL': '1', 11:50:56 INFO - 'TERM': 'linux', 11:50:56 INFO - 'TMOUT': '86400', 11:50:56 INFO - 'USER': 'cltbld', 11:50:56 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1507056630.497244-2141909120', 11:50:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:50:56 INFO - '_': '/tools/buildbot/bin/python'} 11:50:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:50:56 INFO - Downloading/unpacking mozsystemmonitor==0.3 11:50:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:50:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:50:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:50:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:50:57 INFO - Downloading mozsystemmonitor-0.3.tar.gz 11:50:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 11:50:57 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 11:50:57 INFO - Installing collected packages: mozsystemmonitor 11:50:57 INFO - Running setup.py install for mozsystemmonitor 11:50:57 INFO - Successfully installed mozsystemmonitor 11:50:57 INFO - Cleaning up... 11:50:57 INFO - Return code: 0 11:50:57 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 11:50: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:50:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:50: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:50:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:50:57 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x207e1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2246b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23eb9c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23e8d60>, '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 0x23e9a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23e9ef0>, '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': '52faae308a556c440401f8e5000001e8-1507056630.497244-2141909120', '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:50:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 11:50:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 11:50:57 INFO - Using env: {'DISPLAY': ':0', 11:50:57 INFO - 'HOME': '/home/cltbld', 11:50:57 INFO - 'LANG': 'en_US.UTF-8', 11:50:57 INFO - 'LANGUAGE': 'en_US:en', 11:50:57 INFO - 'LOGNAME': 'cltbld', 11:50:57 INFO - 'MAIL': '/var/mail/cltbld', 11:50:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:50:57 INFO - 'MOZ_NO_REMOTE': '1', 11:50:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:50:57 INFO - 'NO_EM_RESTART': '1', 11:50:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:50:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:50:57 INFO - 'PWD': '/builds/slave/test', 11:50:57 INFO - 'SHELL': '/bin/bash', 11:50:57 INFO - 'SHLVL': '1', 11:50:57 INFO - 'TERM': 'linux', 11:50:57 INFO - 'TMOUT': '86400', 11:50:57 INFO - 'USER': 'cltbld', 11:50:57 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1507056630.497244-2141909120', 11:50:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:50:57 INFO - '_': '/tools/buildbot/bin/python'} 11:50:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:50:57 INFO - Downloading/unpacking jsonschema==2.5.1 11:50:57 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:50:57 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:50:57 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:50:57 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:50:58 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 11:51:00 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 11:51:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:51:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:51:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:51:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:51:00 INFO - Downloading functools32-3.2.3-2.tar.gz 11:51:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 11:51:00 INFO - warning: no files found matching '*.txt' 11:51:00 INFO - no previously-included directories found matching 'build' 11:51:00 INFO - no previously-included directories found matching 'dist' 11:51:00 INFO - no previously-included directories found matching '.git*' 11:51:00 INFO - Installing collected packages: jsonschema, functools32 11:51:00 INFO - Running setup.py install for functools32 11:51:00 INFO - warning: no files found matching '*.txt' 11:51:00 INFO - no previously-included directories found matching 'build' 11:51:00 INFO - no previously-included directories found matching 'dist' 11:51:00 INFO - no previously-included directories found matching '.git*' 11:51:00 INFO - Successfully installed jsonschema functools32 11:51:00 INFO - Cleaning up... 11:51:00 INFO - Return code: 0 11:51:00 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 11:51: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:51:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:51: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:51:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:51: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', '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 0x207e1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2246b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23eb9c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23e8d60>, '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 0x23e9a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23e9ef0>, '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': '52faae308a556c440401f8e5000001e8-1507056630.497244-2141909120', '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:51: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', 'functools32==3.2.3-2'] in /builds/slave/test/build 11:51: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 functools32==3.2.3-2 11:51:00 INFO - Using env: {'DISPLAY': ':0', 11:51:00 INFO - 'HOME': '/home/cltbld', 11:51:00 INFO - 'LANG': 'en_US.UTF-8', 11:51:00 INFO - 'LANGUAGE': 'en_US:en', 11:51:00 INFO - 'LOGNAME': 'cltbld', 11:51:00 INFO - 'MAIL': '/var/mail/cltbld', 11:51:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:51:00 INFO - 'MOZ_NO_REMOTE': '1', 11:51:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:51:00 INFO - 'NO_EM_RESTART': '1', 11:51:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:51:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:51:00 INFO - 'PWD': '/builds/slave/test', 11:51:00 INFO - 'SHELL': '/bin/bash', 11:51:00 INFO - 'SHLVL': '1', 11:51:00 INFO - 'TERM': 'linux', 11:51:00 INFO - 'TMOUT': '86400', 11:51:00 INFO - 'USER': 'cltbld', 11:51:00 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1507056630.497244-2141909120', 11:51:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:51:00 INFO - '_': '/tools/buildbot/bin/python'} 11:51:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:51:01 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 11:51:01 INFO - Cleaning up... 11:51:01 INFO - Return code: 0 11:51:01 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 11:51:01 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:51:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:51:01 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:51:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:51:01 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 0x207e1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2246b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23eb9c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23e8d60>, '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 0x23e9a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23e9ef0>, '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': '52faae308a556c440401f8e5000001e8-1507056630.497244-2141909120', '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:51:01 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:51:01 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:51:01 INFO - Using env: {'DISPLAY': ':0', 11:51:01 INFO - 'HOME': '/home/cltbld', 11:51:01 INFO - 'LANG': 'en_US.UTF-8', 11:51:01 INFO - 'LANGUAGE': 'en_US:en', 11:51:01 INFO - 'LOGNAME': 'cltbld', 11:51:01 INFO - 'MAIL': '/var/mail/cltbld', 11:51:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:51:01 INFO - 'MOZ_NO_REMOTE': '1', 11:51:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:51:01 INFO - 'NO_EM_RESTART': '1', 11:51:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:51:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:51:01 INFO - 'PWD': '/builds/slave/test', 11:51:01 INFO - 'SHELL': '/bin/bash', 11:51:01 INFO - 'SHLVL': '1', 11:51:01 INFO - 'TERM': 'linux', 11:51:01 INFO - 'TMOUT': '86400', 11:51:01 INFO - 'USER': 'cltbld', 11:51:01 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1507056630.497244-2141909120', 11:51:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:51:01 INFO - '_': '/tools/buildbot/bin/python'} 11:51:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:51:01 INFO - Downloading/unpacking blobuploader==1.2.4 11:51: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:51: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:51: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:51: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:51:02 INFO - Downloading blobuploader-1.2.4.tar.gz 11:51:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 11:51:02 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 11:51:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:51:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:51:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:51:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:51:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 11:51:03 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 11:51: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:51: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:51: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:51: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:51:03 INFO - Downloading docopt-0.6.1.tar.gz 11:51:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 11:51:03 INFO - Installing collected packages: blobuploader, requests, docopt 11:51:03 INFO - Running setup.py install for blobuploader 11:51:03 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 11:51:03 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 11:51:03 INFO - Running setup.py install for requests 11:51:03 INFO - Running setup.py install for docopt 11:51:03 INFO - Successfully installed blobuploader requests docopt 11:51:03 INFO - Cleaning up... 11:51:03 INFO - Return code: 0 11:51:03 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:51:03 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:51:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:51:03 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:51:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:51:03 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 0x207e1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2246b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23eb9c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23e8d60>, '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 0x23e9a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23e9ef0>, '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': '52faae308a556c440401f8e5000001e8-1507056630.497244-2141909120', '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:51:03 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:51:03 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:51:03 INFO - Using env: {'DISPLAY': ':0', 11:51:03 INFO - 'HOME': '/home/cltbld', 11:51:03 INFO - 'LANG': 'en_US.UTF-8', 11:51:03 INFO - 'LANGUAGE': 'en_US:en', 11:51:03 INFO - 'LOGNAME': 'cltbld', 11:51:03 INFO - 'MAIL': '/var/mail/cltbld', 11:51:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:51:03 INFO - 'MOZ_NO_REMOTE': '1', 11:51:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:51:03 INFO - 'NO_EM_RESTART': '1', 11:51:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:51:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:51:03 INFO - 'PWD': '/builds/slave/test', 11:51:03 INFO - 'SHELL': '/bin/bash', 11:51:03 INFO - 'SHLVL': '1', 11:51:03 INFO - 'TERM': 'linux', 11:51:03 INFO - 'TMOUT': '86400', 11:51:03 INFO - 'USER': 'cltbld', 11:51:03 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1507056630.497244-2141909120', 11:51:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:51:03 INFO - '_': '/tools/buildbot/bin/python'} 11:51:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:51:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:51:04 INFO - Running setup.py (path:/tmp/pip-QhfjwR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:51:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:51:04 INFO - Running setup.py (path:/tmp/pip-byDhiM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:51:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:51:04 INFO - Running setup.py (path:/tmp/pip-MBfztl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:51:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:51:04 INFO - Running setup.py (path:/tmp/pip-IAgAdw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:51:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:51:04 INFO - Running setup.py (path:/tmp/pip-1UCqGP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:51:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:51:04 INFO - Running setup.py (path:/tmp/pip-Uoba4d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:51:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:51:04 INFO - Running setup.py (path:/tmp/pip-MvQ6BZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:51:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:51:04 INFO - Running setup.py (path:/tmp/pip-uOZhCe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:51:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:51:04 INFO - Running setup.py (path:/tmp/pip-d_bjoA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:51:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:51:04 INFO - Running setup.py (path:/tmp/pip-IWLN3_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:51:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:51:04 INFO - Running setup.py (path:/tmp/pip-sdhNaK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:51:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:51:04 INFO - Running setup.py (path:/tmp/pip-4F0iw2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:51:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:51:04 INFO - Running setup.py (path:/tmp/pip-pi48uM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:51:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:51:05 INFO - Running setup.py (path:/tmp/pip-shz4OU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:51:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:51:05 INFO - Running setup.py (path:/tmp/pip-yj7jNT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:51:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:51:05 INFO - Running setup.py (path:/tmp/pip-1LV06K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:51:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:51:05 INFO - Running setup.py (path:/tmp/pip-yLNv3v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:51:05 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 11:51:05 INFO - Running setup.py install for manifestparser 11:51:05 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 11:51:05 INFO - Running setup.py install for mozcrash 11:51:05 INFO - Running setup.py install for mozdebug 11:51:05 INFO - Running setup.py install for mozdevice 11:51:05 INFO - Installing dm script to /builds/slave/test/build/venv/bin 11:51:05 INFO - Running setup.py install for mozfile 11:51:05 INFO - Running setup.py install for mozhttpd 11:51:05 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 11:51:05 INFO - Running setup.py install for mozinfo 11:51:05 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 11:51:05 INFO - Running setup.py install for mozInstall 11:51:06 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 11:51:06 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 11:51:06 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 11:51:06 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 11:51:06 INFO - Running setup.py install for mozleak 11:51:06 INFO - Running setup.py install for mozlog 11:51:06 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 11:51:06 INFO - Running setup.py install for moznetwork 11:51:06 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 11:51:06 INFO - Running setup.py install for mozprocess 11:51:06 INFO - Running setup.py install for mozprofile 11:51:06 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 11:51:06 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 11:51:06 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 11:51:06 INFO - Running setup.py install for mozrunner 11:51:06 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 11:51:06 INFO - Running setup.py install for mozscreenshot 11:51:06 INFO - Running setup.py install for moztest 11:51:06 INFO - Running setup.py install for mozversion 11:51:07 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 11:51:07 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 11:51:07 INFO - Cleaning up... 11:51:07 INFO - Return code: 0 11:51:07 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:51:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:51:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:51:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:51:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:51:07 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 0x207e1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2246b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23eb9c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23e8d60>, '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 0x23e9a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23e9ef0>, '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': '52faae308a556c440401f8e5000001e8-1507056630.497244-2141909120', '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:51:07 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:51:07 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:51:07 INFO - Using env: {'DISPLAY': ':0', 11:51:07 INFO - 'HOME': '/home/cltbld', 11:51:07 INFO - 'LANG': 'en_US.UTF-8', 11:51:07 INFO - 'LANGUAGE': 'en_US:en', 11:51:07 INFO - 'LOGNAME': 'cltbld', 11:51:07 INFO - 'MAIL': '/var/mail/cltbld', 11:51:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:51:07 INFO - 'MOZ_NO_REMOTE': '1', 11:51:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:51:07 INFO - 'NO_EM_RESTART': '1', 11:51:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:51:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:51:07 INFO - 'PWD': '/builds/slave/test', 11:51:07 INFO - 'SHELL': '/bin/bash', 11:51:07 INFO - 'SHLVL': '1', 11:51:07 INFO - 'TERM': 'linux', 11:51:07 INFO - 'TMOUT': '86400', 11:51:07 INFO - 'USER': 'cltbld', 11:51:07 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1507056630.497244-2141909120', 11:51:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:51:07 INFO - '_': '/tools/buildbot/bin/python'} 11:51:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:51:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:51:07 INFO - Running setup.py (path:/tmp/pip-rdWVY7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:51:07 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:51:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:51:07 INFO - Running setup.py (path:/tmp/pip-hydwsH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:51:07 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:51:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:51:07 INFO - Running setup.py (path:/tmp/pip-R_UEQW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:51:07 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:51:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:51:07 INFO - Running setup.py (path:/tmp/pip-2nCodI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:51:07 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:51:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:51:07 INFO - Running setup.py (path:/tmp/pip-D1642C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:51:07 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:51:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:51:07 INFO - Running setup.py (path:/tmp/pip-e8z5JT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:51:07 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:51:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:51:07 INFO - Running setup.py (path:/tmp/pip-bnbKiD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:51:07 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:51:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:51:07 INFO - Running setup.py (path:/tmp/pip-UWMGH6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:51:07 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:51:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:51:07 INFO - Running setup.py (path:/tmp/pip-yaOHR_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:51:07 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:51:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:51:07 INFO - Running setup.py (path:/tmp/pip-QvP6l6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:51:08 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:51:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:51:08 INFO - Running setup.py (path:/tmp/pip-YAcOqP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:51:08 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:51:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:51:08 INFO - Running setup.py (path:/tmp/pip-WjSJku-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:51:08 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:51:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:51:08 INFO - Running setup.py (path:/tmp/pip-opFZt2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:51:08 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:51:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:51:08 INFO - Running setup.py (path:/tmp/pip-zXpqfn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:51:08 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:51:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:51:08 INFO - Running setup.py (path:/tmp/pip-XCoA5h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:51:08 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:51:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:51:08 INFO - Running setup.py (path:/tmp/pip-9UXQpY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:51:08 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:51:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:51:08 INFO - Running setup.py (path:/tmp/pip-z5Rp91-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:51:08 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:51:08 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:51:08 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:51:08 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:51:08 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:51:08 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:51:08 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:51:08 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:51: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:51: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:51: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:51: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:51:09 INFO - Downloading blessings-1.6.tar.gz 11:51:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 11:51:09 INFO - Installing collected packages: blessings 11:51:09 INFO - Running setup.py install for blessings 11:51:09 INFO - Successfully installed blessings 11:51:09 INFO - Cleaning up... 11:51:09 INFO - Return code: 0 11:51:09 INFO - Done creating virtualenv /builds/slave/test/build/venv. 11:51:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:51:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:51:10 INFO - Reading from file tmpfile_stdout 11:51:10 INFO - Current package versions: 11:51:10 INFO - argparse == 1.2.1 11:51:10 INFO - blessings == 1.6 11:51:10 INFO - blobuploader == 1.2.4 11:51:10 INFO - docopt == 0.6.1 11:51:10 INFO - functools32 == 3.2.3-2 11:51:10 INFO - jsonschema == 2.5.1 11:51:10 INFO - manifestparser == 1.1 11:51:10 INFO - mozInstall == 1.13 11:51:10 INFO - mozcrash == 1.0 11:51:10 INFO - mozdebug == 0.1 11:51:10 INFO - mozdevice == 0.51 11:51:10 INFO - mozfile == 1.2 11:51:10 INFO - mozhttpd == 0.7 11:51:10 INFO - mozinfo == 0.10 11:51:10 INFO - mozleak == 0.1 11:51:10 INFO - mozlog == 3.5 11:51:10 INFO - moznetwork == 0.27 11:51:10 INFO - mozprocess == 0.25 11:51:10 INFO - mozprofile == 0.28 11:51:10 INFO - mozrunner == 6.13 11:51:10 INFO - mozscreenshot == 0.1 11:51:10 INFO - mozsystemmonitor == 0.3 11:51:10 INFO - moztest == 0.8 11:51:10 INFO - mozversion == 1.4 11:51:10 INFO - psutil == 3.1.1 11:51:10 INFO - requests == 1.2.3 11:51:10 INFO - wsgiref == 0.1.2 11:51:10 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:51:10 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:51:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:51:10 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:51:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:51:10 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 0x207e1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2246b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23eb9c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23e8d60>, '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 0x23e9a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23e9ef0>, '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': '52faae308a556c440401f8e5000001e8-1507056630.497244-2141909120', '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:51:10 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:51:10 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:51:10 INFO - Using env: {'DISPLAY': ':0', 11:51:10 INFO - 'HOME': '/home/cltbld', 11:51:10 INFO - 'LANG': 'en_US.UTF-8', 11:51:10 INFO - 'LANGUAGE': 'en_US:en', 11:51:10 INFO - 'LOGNAME': 'cltbld', 11:51:10 INFO - 'MAIL': '/var/mail/cltbld', 11:51:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:51:10 INFO - 'MOZ_NO_REMOTE': '1', 11:51:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:51:10 INFO - 'NO_EM_RESTART': '1', 11:51:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:51:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:51:10 INFO - 'PWD': '/builds/slave/test', 11:51:10 INFO - 'SHELL': '/bin/bash', 11:51:10 INFO - 'SHLVL': '1', 11:51:10 INFO - 'TERM': 'linux', 11:51:10 INFO - 'TMOUT': '86400', 11:51:10 INFO - 'USER': 'cltbld', 11:51:10 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1507056630.497244-2141909120', 11:51:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:51:10 INFO - '_': '/tools/buildbot/bin/python'} 11:51:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:51:10 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:51:10 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:51:10 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:51:10 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:51:10 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:51:10 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:51:10 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:51:10 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:51:10 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:51:10 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 11:51:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:51:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:51:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:51:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:51:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 11:51:11 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:51:11 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:51:11 INFO - Installing collected packages: simplejson 11:51:11 INFO - Running setup.py install for simplejson 11:51:11 INFO - building 'simplejson._speedups' extension 11:51:11 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:51:12 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:51:12 INFO - Successfully installed simplejson 11:51:12 INFO - Cleaning up... 11:51:12 INFO - Return code: 0 11:51:12 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 11:51: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:51:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:51: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:51:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:51:12 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 0x207e1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2246b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23eb9c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23e8d60>, '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 0x23e9a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23e9ef0>, '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': '52faae308a556c440401f8e5000001e8-1507056630.497244-2141909120', '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:51:12 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:51:12 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:51:12 INFO - Using env: {'DISPLAY': ':0', 11:51:12 INFO - 'HOME': '/home/cltbld', 11:51:12 INFO - 'LANG': 'en_US.UTF-8', 11:51:12 INFO - 'LANGUAGE': 'en_US:en', 11:51:12 INFO - 'LOGNAME': 'cltbld', 11:51:12 INFO - 'MAIL': '/var/mail/cltbld', 11:51:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:51:12 INFO - 'MOZ_NO_REMOTE': '1', 11:51:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:51:12 INFO - 'NO_EM_RESTART': '1', 11:51:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:51:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:51:12 INFO - 'PWD': '/builds/slave/test', 11:51:12 INFO - 'SHELL': '/bin/bash', 11:51:12 INFO - 'SHLVL': '1', 11:51:12 INFO - 'TERM': 'linux', 11:51:12 INFO - 'TMOUT': '86400', 11:51:12 INFO - 'USER': 'cltbld', 11:51:12 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1507056630.497244-2141909120', 11:51:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:51:12 INFO - '_': '/tools/buildbot/bin/python'} 11:51:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:51:12 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 11:51:12 INFO - Cleaning up... 11:51:12 INFO - Return code: 0 11:51:12 INFO - Running post-action listener: _resource_record_post_action 11:51:12 INFO - Running post-action listener: _start_resource_monitoring 11:51:12 INFO - Starting resource monitoring. 11:51:12 INFO - [mozharness: 2017-10-03 18:51:12.798077Z] Finished create-virtualenv step (success) 11:51:12 INFO - [mozharness: 2017-10-03 18:51:12.798673Z] Running install step. 11:51:12 INFO - Running pre-action listener: _resource_record_pre_action 11:51:12 INFO - Running main action method: install 11:51:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:51:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:51:13 INFO - Reading from file tmpfile_stdout 11:51:13 INFO - Detecting whether we're running mozinstall >=1.0... 11:51:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 11:51:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 11:51:13 INFO - Reading from file tmpfile_stdout 11:51:13 INFO - Output received: 11:51:13 INFO - Usage: mozinstall [options] installer 11:51:13 INFO - Options: 11:51:13 INFO - -h, --help show this help message and exit 11:51:13 INFO - -d DEST, --destination=DEST 11:51:13 INFO - Directory to install application into. [default: 11:51:13 INFO - "/builds/slave/test"] 11:51:13 INFO - --app=APP Application being installed. [default: firefox] 11:51:13 INFO - mkdir: /builds/slave/test/build/application 11:51:13 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:51:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 11:51:30 INFO - Reading from file tmpfile_stdout 11:51:30 INFO - Output received: 11:51:30 INFO - /builds/slave/test/build/application/firefox/firefox 11:51:30 INFO - Running post-action listener: _resource_record_post_action 11:51:30 INFO - [mozharness: 2017-10-03 18:51:30.985409Z] Finished install step (success) 11:51:30 INFO - [mozharness: 2017-10-03 18:51:30.985529Z] Running setup-mitmproxy step. 11:51:30 INFO - Running pre-action listener: _resource_record_pre_action 11:51:30 INFO - Running main action method: setup_mitmproxy 11:51:30 INFO - Skipping: mitmproxy is not required 11:51:30 INFO - Running post-action listener: _resource_record_post_action 11:51:30 INFO - [mozharness: 2017-10-03 18:51:30.986051Z] Finished setup-mitmproxy step (success) 11:51:30 INFO - [mozharness: 2017-10-03 18:51:30.986161Z] Running run-tests step. 11:51:30 INFO - Running pre-action listener: _resource_record_pre_action 11:51:30 INFO - Running pre-action listener: _set_gcov_prefix 11:51:30 INFO - Running main action method: run_tests 11:51:30 WARNING - Try message not found. 11:51:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 11:51:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 11:51:30 INFO - Python 2.7.3 11:51:30 INFO - Return code: 0 11:51:30 INFO - grabbing minidump binary from tooltool 11:51:30 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:51:30 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 0x23e8d60>, '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 0x23e9a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23e9ef0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 11:51:30 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:51:30 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:51:30 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:51:31 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 11:51:31 INFO - Return code: 0 11:51:31 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 11:51:31 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 11:51:31 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 11:51:31 INFO - ENV: RUST_BACKTRACE is now full 11:51:31 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 11:51:31 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 11:51:31 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/Y228oe7GQHKzMAnD1Lmgzg/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-056', '--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:51:31 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/Y228oe7GQHKzMAnD1Lmgzg/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-056 --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:51:31 INFO - Using env: {'DISPLAY': ':0', 11:51:31 INFO - 'HOME': '/home/cltbld', 11:51:31 INFO - 'LANG': 'en_US.UTF-8', 11:51:31 INFO - 'LANGUAGE': 'en_US:en', 11:51:31 INFO - 'LOGNAME': 'cltbld', 11:51:31 INFO - 'MAIL': '/var/mail/cltbld', 11:51:31 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:51:31 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 11:51:31 INFO - 'MOZ_ACCELERATED': '1', 11:51:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:51:31 INFO - 'MOZ_NO_REMOTE': '1', 11:51:31 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:51:31 INFO - 'MOZ_WEBRENDER': '1', 11:51:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:51:31 INFO - 'NO_EM_RESTART': '1', 11:51:31 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:51:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:51:31 INFO - 'PWD': '/builds/slave/test', 11:51:31 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:51:31 INFO - 'RUST_BACKTRACE': 'full', 11:51:31 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 11:51:31 INFO - 'SHELL': '/bin/bash', 11:51:31 INFO - 'SHLVL': '1', 11:51:31 INFO - 'TERM': 'linux', 11:51:31 INFO - 'TMOUT': '86400', 11:51:31 INFO - 'USER': 'cltbld', 11:51:31 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1507056630.497244-2141909120', 11:51:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:51:31 INFO - '_': '/tools/buildbot/bin/python'} 11:51:31 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/Y228oe7GQHKzMAnD1Lmgzg/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-056', '--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:51:31 INFO - mozversion application_buildid: 20171003175736 11:51:31 INFO - mozversion application_changeset: 9be05b2177667ed8221f9da4fdcc200dbdf3de62 11:51:31 INFO - mozversion application_display_name: Nightly 11:51:31 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 11:51:31 INFO - mozversion application_name: Firefox 11:51:31 INFO - mozversion application_remotingname: firefox 11:51:31 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 11:51:31 INFO - mozversion application_vendor: Mozilla 11:51:31 INFO - mozversion application_version: 58.0a1 11:51:31 INFO - mozversion platform_buildid: 20171003175736 11:51:31 INFO - mozversion platform_changeset: 9be05b2177667ed8221f9da4fdcc200dbdf3de62 11:51:31 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 11:51:31 INFO - mozversion platform_version: 58.0a1 11:51:31 INFO - using testdate: 1507056691 11:51:31 INFO - actual date: 1507056691 11:51:31 INFO - starting webserver on 'localhost:44215' 11:51:31 INFO - SUITE-START | Running 2 tests 11:51:31 INFO - TEST-START | dromaeo_css 11:51:31 INFO - Initialising browser for dromaeo_css test... 11:51:31 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:44215/getInfo.html -profile /tmp/tmpfAzZ7c/profile 11:51:31 INFO - TEST-INFO | started process 5902 (/builds/slave/test/build/application/firefox/firefox http://localhost:44215/getInfo.html) 11:51:40 INFO - TEST-INFO | 5902: exit 0 11:51:40 INFO - Browser initialized. 11:51:40 INFO - Running cycle 1/1 for dromaeo_css test... 11:51:40 INFO - Using env: {'DISPLAY': ':0', 11:51:40 INFO - 'HOME': '/home/cltbld', 11:51:40 INFO - 'JSGC_DISABLE_POISONING': '1', 11:51:40 INFO - 'LANG': 'en_US.UTF-8', 11:51:40 INFO - 'LANGUAGE': 'en_US:en', 11:51:40 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 11:51:40 INFO - 'LOGNAME': 'cltbld', 11:51:40 INFO - 'MAIL': '/var/mail/cltbld', 11:51:40 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:51:40 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 11:51:40 INFO - 'MOZ_ACCELERATED': '1', 11:51:40 INFO - 'MOZ_CRASHREPORTER': '1', 11:51:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:51:40 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 11:51:40 INFO - 'MOZ_NO_REMOTE': '1', 11:51:40 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:51:40 INFO - 'MOZ_WEBRENDER': '1', 11:51:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:51:40 INFO - 'NO_EM_RESTART': '1', 11:51:40 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:51:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:51:40 INFO - 'PWD': '/builds/slave/test', 11:51:40 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:51:40 INFO - 'RUST_BACKTRACE': 'full', 11:51:40 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 11:51:40 INFO - 'SHELL': '/bin/bash', 11:51:40 INFO - 'SHLVL': '1', 11:51:40 INFO - 'TERM': 'linux', 11:51:40 INFO - 'TMOUT': '86400', 11:51:40 INFO - 'USER': 'cltbld', 11:51:40 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1507056630.497244-2141909120', 11:51:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:51:40 INFO - '_': '/tools/buildbot/bin/python'} 11:51:40 INFO - TEST-INFO | started process 6148 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpfAzZ7c/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 11:51:41 INFO - PID 6148 | WebRender - OpenGL version new 3.2.0 NVIDIA 361.42 11:51:41 INFO - PID 6148 | WebRender - OpenGL version new 3.2.0 NVIDIA 361.42 11:51:41 INFO - PID 6148 | 11:51:41 INFO - PID 6148 | (/builds/slave/test/build/application/firefox/firefox:6209): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 11:51:41 INFO - PID 6148 | 11:51:52 INFO - PID 6148 | RSS: Main: 210276352 11:51:52 INFO - PID 6148 | 11:54:49 INFO - PID 6148 | Cycle 1(1): loaded http://localhost:44215/tests/dromaeo/cssquery-dojo.html (next: http://localhost:44215/tests/dromaeo/cssquery-ext.html) 11:54:50 INFO - PID 6148 | RSS: Main: 205516800 11:54:50 INFO - PID 6148 | 11:57:53 INFO - PID 6148 | Cycle 1(1): loaded http://localhost:44215/tests/dromaeo/cssquery-ext.html (next: http://localhost:44215/tests/dromaeo/cssquery-jquery.html) 11:57:53 INFO - PID 6148 | RSS: Main: 204070912 11:57:53 INFO - PID 6148 | 12:00:55 INFO - PID 6148 | Cycle 1(1): loaded http://localhost:44215/tests/dromaeo/cssquery-jquery.html (next: http://localhost:44215/tests/dromaeo/cssquery-mootools.html) 12:00:56 INFO - PID 6148 | RSS: Main: 205316096 12:00:56 INFO - PID 6148 | 12:03:58 INFO - PID 6148 | Cycle 1(1): loaded http://localhost:44215/tests/dromaeo/cssquery-mootools.html (next: http://localhost:44215/tests/dromaeo/cssquery-prototype.html) 12:03:59 INFO - PID 6148 | RSS: Main: 205275136 12:03:59 INFO - PID 6148 | 12:07:02 INFO - PID 6148 | Cycle 1(1): loaded http://localhost:44215/tests/dromaeo/cssquery-prototype.html (next: http://localhost:44215/tests/dromaeo/cssquery-yui.html) 12:07:03 INFO - PID 6148 | RSS: Main: 207785984 12:07:03 INFO - PID 6148 | 12:10:05 INFO - PID 6148 | Cycle 1(1): loaded http://localhost:44215/tests/dromaeo/cssquery-yui.html (next: http://localhost:44215/tests/dromaeo/cssquery-dojo.html) 12:10:05 INFO - PID 6148 | RSS: Main: 209330176 12:10:05 INFO - PID 6148 | 12:10:05 INFO - PID 6148 | __start_tp_report 12:10:05 INFO - PID 6148 | _x_x_mozilla_page_load 12:10:05 INFO - PID 6148 | _x_x_mozilla_page_load_details 12:10:05 INFO - PID 6148 | |i|pagename|runs| 12:10:05 INFO - PID 6148 | |0;dojo.html;3084.907452776416;3117.3141908780067;3125.1562078238862;3131.264152924064;3136.4354416205088;5997.490213331861;6151.815445536636;6172.7530898764;6181.350958149392;6197.101420294055;6090.086487026948;6127.295361033483;6184.505239580834;6191.566590338678;6290.779822706206;5736.4550367715;5788.652680839163;5803.448672376117;5817.301923769132;5874.236349274588;1089.786039533753;5686.943130568683;5763.049096899028;5769.278840144982;5782;5535.889282214353;5554.1946417769395;5622.662640241558;5699.601027928005;5716.514096301819;5659.717014149276;5692.0323544997445;5791.507721843648;5809.2738407699035;5809.738561764731;5572.916406253909;5644.181593668895;5729.398413166599;5759.5968282220265;5776.133579962997;6096;6175.845603859894;6180.783672571483;6197.907031394533;6200.565960382775;6634.270230274666;6655.201375834882;6675.732970681167;6721.529492935497;6741.730330786762;6244.094606282109;6366.26787919386;6539.149910511651;6571.507136964747;6681.5656982296;6188.226471691039;6206.565540412173;6241.812745617639;6288.779892703734;6296.181496405438;6816.795496135124;6824.0446337512785;6884.277150899184;6929.757458488929;6937.514373993873;6530.346965303526;6541.378569035934;6584.5061620378665;6630.9668451657435;6632.071509988606;6442.549021568539;6563.8359041023405;6585.506087043491;6630.602163870183;6684.197896252481;6546.0508226307875;6593.340665933369;6652;6655.301193374723;6708.2956289589865;6586.6377349245295;6662.866742665216;6679.465642748569;6758.357955994173;6778;4716.198246298138;4789.880252993633;4854.320395144612;4896.314515967767;4898.975505122452;4172.603602657743;4187.958120418818;4305.634021108178;4314.784260786948;4351.8694439166875;5683.261176047087;5739.196512488255;5756.510696590753;5757.193992841006;5757.222774925415;6598.505112116611;6624.436922861611;6669.199696036507;6671;6694.631795251211;5474.644148130438;5592.748326325325;5616.66300022;5620.100783874642;5667.09326507765;5491.148871924858;5495.697736624524;5499.285092937893;5500.037493438632;5505.9724701376235;6330.8100756977365;6351.079093531412;6358.300586935434;6372.745090196433;6395.52033597482;6522.445592124723;6613.603183808987;6621.172353455721;6680.6993685283305;6712.463002959849;6389.169407976933;6408.231012278557;6448.645324507197;6471.579347342407;6496.285408605144;6425.164728585254;6525.967370163119;6550.377714117151;6577.309382514958;6594.340565943367;6373.6175829450385;6439.227292724903;6629.602223866584;6641.634710090992;6651.900221496779;6476.6114033158165;6493.253275873335;6525.923222668207;6532.216134063943;6536.640484773193;6369.49044076482;6470.22357317125;6476.935230647633;6478.70845811949;6485.189351331083;6363.7772677956045;6384.361563843764;6412.6793660317735;6448.45188158993;6451.6774161290805;6379;6417.96791016042;6420.967895160681;6578.210614726264;6659.866802663822;6132.049532322497;6146.907796383147;6153.784617538365;6167.660778657038;6183.196184495987 12:10:05 INFO - PID 6148 | |1;ext.html;803.5379656697397;818.4802650317049;829.2412442615008;829.9626516806743;832.6086739232559;39973.80013099934;43514.782426087826;43522.347164792474;43775.12449751003;44112.77943610278;38779.61220387795;39133.21733565327;39415;39448.40827387592;39694;7049.612271325088;7199.460040496958;7233.927660723378;7242.855142897139;7244.782656520287;7096.645167741618;7138.821529461753;7155.6064416457075;7201.711931522759;7203.307222802638;7089.149302083757;7114.715411383564;7158.8568228635395;7176.820579485502;7178.712851485934;7744.651490682904;8003.4797738146835;8021.398395120389;8024.317932975646;8038.678452861878;7781.455298129134;7792.727254546064;7839.725609603694;7854.253845884632;7856.214378562098;38504.80747596244;38527;38924;38939.41590876139;38949.610503895165;3482.0946553895915;3573.9456860226296;3574.160072382988;3579.1410061585293;3581.8925432237074;31610.525842112387;31955.52066718978;31999.200019999687;32040.679593204004;32100.678993210004;5037.0103808995245;5132.974335128338;5142.07442660321;5170.224466330043;5259.5529380002745;195475;196172.01913990482;196361;197563;198441;43290;43846.78076609661;49001;49233.75383123061;49666.255006174935;51954.22068668973;53402.73298633482;53438;53723.73138134284;54017;16176.110313932846;16283.755743663854;16326.34694612226;16338.101404422634;16342.346306147621;13087.738245235232;13151.868481315256;13253;13294.601161965156;13311;14141.29293535319;14352.210628415329;14397.712045759026;14519.128852268897;14653.487127950471;5597.552195824324;5725.799597014085;5826.359100498942;5840.970795145997;5967.16459695643;983.2036050798876;996.446971930571;1003.934744241622;1006.2201793609864;1018.3482571154467;23058.308250752503;23538.64692029621;23579.646305305436;23622.7637723624;23641.645375319385;1109.6060898380958;1114.9888501115047;1120.93834839083;1127.3968426891574;1129.2829053551054;12151.453184606715;12205.38973051344;12373.690657733448;12375.814362784566;12512.624621261377;230274.24314392274;230311;231330;232831;233194;53534.464655353724;54251.72874135604;54600;54634.45365546373;55314.17028744572;1425.465450456079;1467.9045862018934;1468.3319089813895;1471.168789633875;1473.4253641079988;22646.886765566065;22908.198213062464;22929.31212063641;23200.651990219823;23202.41993950097;34387.14032149116;34411.65588344185;34829.825850870584;34867.65132348746;34986.65013349936;196457;197191;198236;198675;198725;29446.411071778017;31027.68972310248;31045.223869403446;31387.90142345007;33553.66446335505;44212.55787442085;44391.77804110959;44566.3315050268;44662.77668611636;45030.324545131196;31932.361352773278;32017.67982320147;32036.67963320337;32044.83977580097;32338.35323293568;31184.22039449032;31241;31527;31631.683683162875;31649.683503164673;34915.12712182216;36308.636913631584;36327.09182270464;36678.8166059168;36769.448458272615;30095.54856677108;30529.765973049773;30578.235544110685;30718.078457646305;31634.525482117326;23483.88258058699;23587.764122358556;23600.29199124029;23713.52572948566;24042.63936040926 12:10:05 INFO - PID 6148 | |2;jquery.html;578.8929048126096;580.3268208877703;584.2959234122885;593.0967912070415;593.7624950019991;21825.454363640896;22350.66474002891;22361.54649947752;22500.66249006264;22648.43378915528;22806.771932280673;23528.29415117545;24180.27459176223;24335.14826981056;24549.75450245497;6265.812025639215;6386.968065159667;6425.45383642391;6497.05792660064;6520.608763474207;6250.218687674013;6337.366263373672;6371.012493063583;6379.489640828722;6412.903806442907;6161.907571386433;6446.967765161167;6481.319461456526;6485.254195767477;6486.513511486633;6317.463015643652;6361.395667411589;6368.74525019001;6393.328700486451;6407.903881441735;5742.598018138732;5893.14549390336;6004;6012.128241404972;6015.669138197398;27859.86070069657;28709.425811483863;28718.13845584615;28764.280892977633;28821;1973.0627951722818;1988.1550341105117;1997.0514005847251;2001.789812069741;2004.8696834705843;18025.369112081014;18562.350317738816;18591.721124183146;18705.812941870543;18899.716504252447;2466.5683505386487;2477.4797292568583;2478.578641630927;2484.7266800651914;2519.0553542421594;120932;127983;144213;150390;150434.24782876016;14331.713365732627;14396.519199768705;14418.206998615176;14712.779308310384;14808.3336249869;23460.178893738637;23545.175918843102;23562.764372356058;23652;23674.881625591763;9759.512024398751;10022.298439109192;10085.747856303651;10213.33613315132;10250.128739057263;9169.174774270348;9242.445453272825;9247.306452016126;9392.671256506126;9478;8792.42849214799;9037.954810225907;9081.45511269326;9231.815363692824;9242.722718318326;2695.582184761365;2761.471187252907;2772.1406364027216;2800.207866965144;2840.4461130079435;934.6868798952291;942.5805516545072;955.2119501411363;963.3834346018554;970.8495183246608;17927.641447170983;18609.53476163107;18732.81267187338;18853.245870165316;19030.42908712741;1005.240187711187;1014.5890914179769;1032.143321043547;1036.7459972306683;1037.9584816607403;10387.68836934893;10470.214733894989;10500.527476263587;10500.789984200273;10554.894451055392;450728;455169;472774;477228;478687;112074;112237.43881280541;114095;114863.42568287105;115147.42426287982;1131.2703306367512;1191.4876603060768;1236.5857437758273;1253.0977696058824;1267.7527882063093;19624.90187549053;19867.701984469957;19871.40385788429;20914.58170836605;21008.159673613496;58759.412405877105;59233.111503326625;59793.701031494566;60494.395056048874;61159.694201528706;71273.64363178359;71793;71936;73624;75524.62237688997;14514.201718905562;14658.853411465749;14885.181315027778;14934.10395376281;15027.624309392353;21944.122235111055;22854.657180141978;23098.422539436648;23180.652290215323;23486.530269394858;18200.362987295382;18545.16546755372;18620.627587447903;18659.44021679352;18707;15435.15106669099;15445.613859653598;15540.766888496455;15877.285522151762;16130.919345403197;18500.537486562942;18883;18906;19050.23799048078;19138.904305478383;14571.198584077554;14608.269586520844;14751.631209219855;14800.555983320517;14906.701865962837;17284.74072888933;18090.366837160636;18135;18302.725459118392;18371 12:10:05 INFO - PID 6148 | |3;mootools.html;1333.1601091312475;1384.8338199416069;1395.0722769358376;1398.1750767047447;1412.0821466047075;15713.528594142166;16358.427455039076;16424.999999999985;16622.085785281804;16661.750073748888;15999.280032398541;16056.518304450885;16161.191940402961;16211.946223495464;16278.26747796349;2731.549294366427;2752.2431331383927;2816.9718302816914;2821.054946592894;2824.943501129976;2648.7616114549687;2752.559590465526;2769.6814866290333;2781.9860900695467;2790.679071906736;2692.3538350795766;2723.4689235599067;2778.5554311310193;2789.079603730764;2826.8586570671487;2648.682158141026;2693.5151672698908;2707.44497378037;2722.5916112583072;2737.3293543081872;2451.9387015324583;2483.3543278747657;2491.426971796497;2493.4265119022543;2494.3888747257038;14981.70036599262;15053.247337633184;15144.772828407582;15230.619234519116;15303.617409564738;8226.341892648634;8558.61486233121;8562.100979397199;8564.571771411405;8579.313654907592;5265.894682106375;5466.125419932831;5466.289382380305;5502.119660854284;5553.916986187695;1908.7783818356263;1922.884626922389;1931.661959157156;1945.8151475609795;1972.7139564763172;23232.3030309091;24194.516109677883;26967.73032269672;27420.588691169647;27569.448611027867;6683.231428385798;6876.140482439695;6977.79066628002;6986.371226589631;7025.578465292099;18083;18089.095545222684;18108.275668973358;18112.909435452737;18145.45563633093;7813.374930005586;7958.363330933512;8025.3980951428875;8029.3175080118845;8056.959715201387;7366.852662946818;7418.406527477789;7453.590052547053;7464.552126872405;7506.43701722373;5299.6290259681455;5398.2982212312145;5479.178123281539;5504.862378440571;5517.420670829505;1552.3945661192145;1578.5501132177503;1598.2328482328548;1598.3926108079088;1623.699615571123;881.2905610983092;897.7576054465258;914.1377679304884;932.2541966426832;944.7732544189345;8877.600507977157;8909.420887642282;8981.281497480186;9046.909530904606;9137.451752894847;971.2812518736225;980.9362391444533;989.9257555683353;1006.4213077480478;1014.9035841595037;5033.823816166417;5311.654742441729;5400.891982160335;5569;5575.888482230333;20269.797302026793;20486.79513204879;20559.691604625943;21833.454163645718;22874.826891445286;19001.239950402105;20246.898765506077;20428.591428171352;20516.281930132373;20658.690119648218;10946.014858662758;11066.502007409686;11378.658640240807;11384.658460246206;11760.294382337259;8381;8383.455075420079;8490.957545212234;8653.39426240157;8789.38474306818;18576.328130468322;18835.24659013624;18960.336388226347;19213.519662008002;19548.31580894662;19314.358279545835;19559.21763129459;19651.11569979326;19927;20498;10255.692329230134;11142.888571114185;11165.218434709492;11165.832512512481;11190.160737944849;13807.654808629864;13913.513027044004;14013.859861401663;14147.151170929777;14224.14655120696;11128.944355278172;11395.829062564235;11435.885641143816;11526;11774.646760597196;11064.170187235828;11261.7747645045;11376.260543064674;11405.201635885409;11567.884321157017;9489.857652135086;9627.518624068629;9659.951700241454;9744.902550974683;9752.414855108716;7308.159561650478;7311.634418279171;7372.189059203591;7374.793066996498;7459.888101678588;7273.599952002691;7379.446541509516;7448.962755186406;7465.477416580788;7512 12:10:05 INFO - PID 6148 | |4;prototype.html;508.5245295648571;511.12597458346215;527.952484276415;532.603210608097;535.1063723581618;5945.346011938684;6048.697565121748;6056.788012419566;6085.78699745509;6131.54013448992;5934.910976335347;5999.450233650692;6027.336992930785;6066.9978906960705;6120.54095942805;4887.898203772376;4902.730349830758;4921.040397122562;4931.3835770528685;4971.279164521142;4727.621790256771;4879.072976134541;4889.755512224392;4937.802487900498;4966.776495057713;4901.730404827733;4905.533974272438;4928.408590969071;4930.975345123269;4937.432195297551;4871.926921096187;4886.951130488721;4900.926486102711;4915.557599815998;4922.286268491067;4376.89057773555;4392.714473559208;4399.1641588098155;4413.337999300131;4442.2004039272915;6000.579959402844;6020.471402011166;6028.547858910555;6042.607230530046;6067.848303792396;5591.440855914417;5631.662100273997;5694.320175548223;5708.885822283531;5711.371749107595;6416.903746443761;6425.1647285853005;6436.388543088399;6503.739850405978;6517.739290428377;4790.233562629963;4847.418309802846;4850.514948505156;4852.126617208901;4861.173600487926;6649.301823308531;6671.766488172939;6774.491913106487;6785.8642827143185;6803.863922721567;4986.601071914238;5019.67372120811;5034.723090230073;5052.797888084509;5066.9746651266505;5036.294918711384;5063.063333283354;5068.721220332917;5105.795768169306;5122.667026643257;5502.2296878437055;5532.197831314437;5562.249096372019;5623.381428042912;5668.603197776116;6168.8766224675255;6356.777512787123;6377.74489020434;6402.551821372553;6458.741650334028;1638.000819500104;1669.96660066798;1676.2121802752686;1697.439844851196;1710.7767945918479;1184.1592469346688;1224.9448774804978;1225.615054987858;1228.2016689151944;1236.3879879459726;5444.292242008592;5525.640833345819;5533.750981205855;5556.666600004012;5627.8874422512135;6359.092272318286;6366.9681651591445;6606.240282367493;6612.669366531751;6624.470042396693;5600.887982240332;5608.355039170466;5618.213450116987;5648.870225954825;5683.857903552444;3449.6032956209856;3478.599961004517;3479.634638362986;3483.2511010132944;3533.2403533240476;6238.781642642486;6288.748450062038;6403.199600049994;6406.615603063831;6408.359164083555;6551.017347397833;6637.46900247979;6656.60060396368;6690;6713.328667133248;6202.813915582449;6318.304986451487;6372.904406433814;6397.488200943913;6456.903146452713;6433.8713225736155;6442.452391546771;6573.671316434064;6615.536912416084;6618.238902526078;6402.399400149962;6456.774012909714;6485.156929599122;6485.509236831467;6576.76981305652;6209.627422354673;6221.946757569901;6237;6324.272708638566;6365.172527571386;4933.260010998379;4935.481774413634;4978.352814134139;5001.174806156943;5028.270900719448;6311.895418301687;6535.901961470487;6571.868562628816;6591.307912669293;6613.966930165318;5964.463198312173;6263.154474145932;6327.493800495858;6332.683365831598;6406.391392817675;6356.968215158895;6359.791639588463;6386.744530218739;6386.9361306386345;6391.712372943136;6223.408776166257;6300.936990630218;6305.558610897193;6380.585261957958;6436.806895793134;6313;6368.0766288886925;6375.250438423404;6453.322401147811;6538.921078022263;6133.785317514044;6174.38256174379;6188.504919606511;6240.469560087444;6263.74945002213 12:10:05 INFO - PID 6148 | |5;yui.html;868.3704314372081;922.460360688997;929.9814003719925;935.3405848876538;940.4545363689059;19010.42968710941;19434.90282548589;19721.309754158607;19820.99999999998;19855.5036124097;18872.43382698518;18966.81033189668;19205;19219.903900480513;19270.903645481754;971.616211596419;983.0709979069782;983.4050399508302;985.261054209343;986.5856340337076;935.6491315756591;979.8971108033661;986.344081186014;994.0308199505497;994.5872462927913;1048.7430579508032;1053.415354478268;1065.137238836541;1065.477915821246;1069.5989004123453;1042.5881776698238;1052.847337136111;1055.5091882274742;1060.6075751971782;1062.3041907550567;770.2413123073768;770.5338270346416;778.7702627724778;779.0962483519147;782.1201148707704;19699.11353989074;19756.80243197564;19804;19988.20047198125;20102.899485502625;21503.892480537652;21639.134434622596;22054.669179962315;22093.33719988403;22186.112555497763;16815.41146059894;17037.233324500427;17037.318507259693;17125.14374281281;17292.481225563126;3693.095191678029;3727.9813600932093;3734.7945862977526;3742.363798154293;3745.494358261627;133745;143051;143834.28082859624;144573.27713361365;147021;14224.217668028357;14735.263236838115;16321.18394080315;16526.917365413337;16823.831761682228;31077.378452430825;31247.531287030713;31267.37465250728;31968.520472192937;32151.839240803645;9327.393719408217;9340;9381.484018378918;9396.87237531487;9452.480113593818;4449.710768800018;4455.242608756519;4502.3246513023305;4531.365608814768;4532.7280363178315;5427.674339539641;5597.216389705444;5611.438856114438;5620.494155526022;5634.577406694514;1093.786711591248;1125.915556333262;1145.6906635208447;1148.2134737704532;1156.6587856582328;693.3343989769877;693.729445516249;708.0229283588615;712.1881055596624;717.7846646006282;11918.225315354473;12124.63626091201;12231.327276999851;12608.11743177987;12775.105742598114;626.7367705563674;627.1126356206008;642.996785016072;649.9447546958467;651.3779340729592;5148.819791307286;5229.529342359206;5248.895022099537;5322.946770532322;5394.757235924393;121893;124784.37607812084;126439;131309;132415;109026.45486772674;109363.45318273357;111983;113307;116290.41854790841;96486;99041;99966;100344.49827750814;101299.49350253202;9964;9968.601255949681;10001;10101.191904647463;10335;35779.821100894325;36143.638563614026;36523.81738091292;40840.59159408368;44218.77890610526;69961;78479;80731;81192.59403702944;82765.58617207117;19346.903265483583;19449.31927382535;19609.31367402134;19627.607447850678;19671.21315147378;19868.90065549663;21114;21179;22103.226387076375;22557.774422256225;20268;20302.69545956782;20362.79637203609;20365.287214947406;20682;19160;19366.61266774685;19413.902930485823;20088.89955550213;20639.58720825545;19233.230670773013;19756;20022;20217.59564808725;20459;14200.78698819498;14497.710045799236;14685.41258349654;14752.041117327339;14931.477398291008;14651.176729132725;14711.632209194428;15427.5371738848;15644.687106257583;15684.921575392507 12:10:05 INFO - PID 6148 | __end_tp_report 12:10:05 INFO - PID 6148 | __start_cc_report 12:10:05 INFO - PID 6148 | _x_x_mozilla_cycle_collect,293 12:10:05 INFO - PID 6148 | __end_cc_report 12:10:05 INFO - PID 6148 | __startTimestamp1507057805868__endTimestamp 12:10:05 INFO - PID 6148 | 12:10:05 INFO - PID 6148 | ------- Summary: start ------- 12:10:05 INFO - PID 6148 | Number of tests: 6 12:10:05 INFO - PID 6148 | 12:10:05 INFO - PID 6148 | [#0] dojo.html Cycles:165 Average:6036.59 Median:6351.08 stddev:859.98 (13.5%) stddev-sans-first:830.86 12:10:05 INFO - PID 6148 | Values: 3084.9 3117.3 3125.2 3131.3 3136.4 5997.5 6151.8 6172.8 6181.4 6197.1 6090.1 6127.3 6184.5 6191.6 6290.8 5736.5 5788.7 5803.4 5817.3 5874.2 1089.8 5686.9 5763.0 5769.3 5782.0 5535.9 5554.2 5622.7 5699.6 5716.5 5659.7 5692.0 5791.5 5809.3 5809.7 5572.9 5644.2 5729.4 5759.6 5776.1 6096.0 6175.8 6180.8 6197.9 6200.6 6634.3 6655.2 6675.7 6721.5 6741.7 6244.1 6366.3 6539.1 6571.5 6681.6 6188.2 6206.6 6241.8 6288.8 6296.2 6816.8 6824.0 6884.3 6929.8 6937.5 6530.3 6541.4 6584.5 6631.0 6632.1 6442.5 6563.8 6585.5 6630.6 6684.2 6546.1 6593.3 6652.0 6655.3 6708.3 6586.6 6662.9 6679.5 6758.4 6778.0 4716.2 4789.9 4854.3 4896.3 4899.0 4172.6 4188.0 4305.6 4314.8 4351.9 5683.3 5739.2 5756.5 5757.2 5757.2 6598.5 6624.4 6669.2 6671.0 6694.6 5474.6 5592.7 5616.7 5620.1 5667.1 5491.1 5495.7 5499.3 5500.0 5506.0 6330.8 6351.1 6358.3 6372.7 6395.5 6522.4 6613.6 6621.2 6680.7 6712.5 6389.2 6408.2 6448.6 6471.6 6496.3 6425.2 6526.0 6550.4 6577.3 6594.3 6373.6 6439.2 6629.6 6641.6 6651.9 6476.6 6493.3 6525.9 6532.2 6536.6 6369.5 6470.2 6476.9 6478.7 6485.2 6363.8 6384.4 6412.7 6448.5 6451.7 6379.0 6418.0 6421.0 6578.2 6659.9 6132.0 6146.9 6153.8 6167.7 6183.2 12:10:05 INFO - PID 6148 | 12:10:05 INFO - PID 6148 | [#1] ext.html Cycles:180 Average:37711.11 Median:19155.96 stddev:54286.41 (283.4%) stddev-sans-first:54367.96 12:10:05 INFO - PID 6148 | Values: 803.5 818.5 829.2 830.0 832.6 39973.8 43514.8 43522.3 43775.1 44112.8 38779.6 39133.2 39415.0 39448.4 39694.0 7049.6 7199.5 7233.9 7242.9 7244.8 7096.6 7138.8 7155.6 7201.7 7203.3 7089.1 7114.7 7158.9 7176.8 7178.7 7744.7 8003.5 8021.4 8024.3 8038.7 7781.5 7792.7 7839.7 7854.3 7856.2 38504.8 38527.0 38924.0 38939.4 38949.6 3482.1 3573.9 3574.2 3579.1 3581.9 31610.5 31955.5 31999.2 32040.7 32100.7 5037.0 5133.0 5142.1 5170.2 5259.6 195475.0 196172.0 196361.0 197563.0 198441.0 43290.0 43846.8 49001.0 49233.8 49666.3 51954.2 53402.7 53438.0 53723.7 54017.0 16176.1 16283.8 16326.3 16338.1 16342.3 13087.7 13151.9 13253.0 13294.6 13311.0 14141.3 14352.2 14397.7 14519.1 14653.5 5597.6 5725.8 5826.4 5841.0 5967.2 983.2 996.4 1003.9 1006.2 1018.3 23058.3 23538.6 23579.6 23622.8 23641.6 1109.6 1115.0 1120.9 1127.4 1129.3 12151.5 12205.4 12373.7 12375.8 12512.6 230274.2 230311.0 231330.0 232831.0 233194.0 53534.5 54251.7 54600.0 54634.5 55314.2 1425.5 1467.9 1468.3 1471.2 1473.4 22646.9 22908.2 22929.3 23200.7 23202.4 34387.1 34411.7 34829.8 34867.7 34986.7 196457.0 197191.0 198236.0 198675.0 198725.0 29446.4 31027.7 31045.2 31387.9 33553.7 44212.6 44391.8 44566.3 44662.8 45030.3 31932.4 32017.7 32036.7 32044.8 32338.4 31184.2 31241.0 31527.0 31631.7 31649.7 34915.1 36308.6 36327.1 36678.8 36769.4 30095.5 30529.8 30578.2 30718.1 31634.5 23483.9 23587.8 23600.3 23713.5 24042.6 12:10:05 INFO - PID 6148 | 12:10:05 INFO - PID 6148 | [#2] jquery.html Cycles:180 Average:34097.74 Median:22830.71 stddev:79120.83 (346.6%) stddev-sans-first:79302.76 12:10:05 INFO - PID 6148 | Values: 578.9 580.3 584.3 593.1 593.8 21825.5 22350.7 22361.5 22500.7 22648.4 22806.8 23528.3 24180.3 24335.1 24549.8 6265.8 6387.0 6425.5 6497.1 6520.6 6250.2 6337.4 6371.0 6379.5 6412.9 6161.9 6447.0 6481.3 6485.3 6486.5 6317.5 6361.4 6368.7 6393.3 6407.9 5742.6 5893.1 6004.0 6012.1 6015.7 27859.9 28709.4 28718.1 28764.3 28821.0 1973.1 1988.2 1997.1 2001.8 2004.9 18025.4 18562.4 18591.7 18705.8 18899.7 2466.6 2477.5 2478.6 2484.7 2519.1 120932.0 127983.0 144213.0 150390.0 150434.2 14331.7 14396.5 14418.2 14712.8 14808.3 23460.2 23545.2 23562.8 23652.0 23674.9 9759.5 10022.3 10085.7 10213.3 10250.1 9169.2 9242.4 9247.3 9392.7 9478.0 8792.4 9038.0 9081.5 9231.8 9242.7 2695.6 2761.5 2772.1 2800.2 2840.4 934.7 942.6 955.2 963.4 970.8 17927.6 18609.5 18732.8 18853.2 19030.4 1005.2 1014.6 1032.1 1036.7 1038.0 10387.7 10470.2 10500.5 10500.8 10554.9 450728.0 455169.0 472774.0 477228.0 478687.0 112074.0 112237.4 114095.0 114863.4 115147.4 1131.3 1191.5 1236.6 1253.1 1267.8 19624.9 19867.7 19871.4 20914.6 21008.2 58759.4 59233.1 59793.7 60494.4 61159.7 71273.6 71793.0 71936.0 73624.0 75524.6 14514.2 14658.9 14885.2 14934.1 15027.6 21944.1 22854.7 23098.4 23180.7 23486.5 18200.4 18545.2 18620.6 18659.4 18707.0 15435.2 15445.6 15540.8 15877.3 16130.9 18500.5 18883.0 18906.0 19050.2 19138.9 14571.2 14608.3 14751.6 14800.6 14906.7 17284.7 18090.4 18135.0 18302.7 18371.0 12:10:05 INFO - PID 6148 | 12:10:05 INFO - PID 6148 | [#3] mootools.html Cycles:180 Average:9452.27 Median:2670.56 stddev:6661.60 (249.4%) stddev-sans-first:6652.35 12:10:05 INFO - PID 6148 | Values: 1333.2 1384.8 1395.1 1398.2 1412.1 15713.5 16358.4 16425.0 16622.1 16661.8 15999.3 16056.5 16161.2 16211.9 16278.3 2731.5 2752.2 2817.0 2821.1 2824.9 2648.8 2752.6 2769.7 2782.0 2790.7 2692.4 2723.5 2778.6 2789.1 2826.9 2648.7 2693.5 2707.4 2722.6 2737.3 2451.9 2483.4 2491.4 2493.4 2494.4 14981.7 15053.2 15144.8 15230.6 15303.6 8226.3 8558.6 8562.1 8564.6 8579.3 5265.9 5466.1 5466.3 5502.1 5553.9 1908.8 1922.9 1931.7 1945.8 1972.7 23232.3 24194.5 26967.7 27420.6 27569.4 6683.2 6876.1 6977.8 6986.4 7025.6 18083.0 18089.1 18108.3 18112.9 18145.5 7813.4 7958.4 8025.4 8029.3 8057.0 7366.9 7418.4 7453.6 7464.6 7506.4 5299.6 5398.3 5479.2 5504.9 5517.4 1552.4 1578.6 1598.2 1598.4 1623.7 881.3 897.8 914.1 932.3 944.8 8877.6 8909.4 8981.3 9046.9 9137.5 971.3 980.9 989.9 1006.4 1014.9 5033.8 5311.7 5400.9 5569.0 5575.9 20269.8 20486.8 20559.7 21833.5 22874.8 19001.2 20246.9 20428.6 20516.3 20658.7 10946.0 11066.5 11378.7 11384.7 11760.3 8381.0 8383.5 8491.0 8653.4 8789.4 18576.3 18835.2 18960.3 19213.5 19548.3 19314.4 19559.2 19651.1 19927.0 20498.0 10255.7 11142.9 11165.2 11165.8 11190.2 13807.7 13913.5 14013.9 14147.2 14224.1 11128.9 11395.8 11435.9 11526.0 11774.6 11064.2 11261.8 11376.3 11405.2 11567.9 9489.9 9627.5 9660.0 9744.9 9752.4 7308.2 7311.6 7372.2 7374.8 7459.9 7273.6 7379.4 7449.0 7465.5 7512.0 12:10:05 INFO - PID 6148 | 12:10:05 INFO - PID 6148 | [#4] prototype.html Cycles:180 Average:5394.27 Median:6023.90 stddev:1496.20 (24.8%) stddev-sans-first:1454.76 12:10:05 INFO - PID 6148 | Values: 508.5 511.1 528.0 532.6 535.1 5945.3 6048.7 6056.8 6085.8 6131.5 5934.9 5999.5 6027.3 6067.0 6120.5 4887.9 4902.7 4921.0 4931.4 4971.3 4727.6 4879.1 4889.8 4937.8 4966.8 4901.7 4905.5 4928.4 4931.0 4937.4 4871.9 4887.0 4900.9 4915.6 4922.3 4376.9 4392.7 4399.2 4413.3 4442.2 6000.6 6020.5 6028.5 6042.6 6067.8 5591.4 5631.7 5694.3 5708.9 5711.4 6416.9 6425.2 6436.4 6503.7 6517.7 4790.2 4847.4 4850.5 4852.1 4861.2 6649.3 6671.8 6774.5 6785.9 6803.9 4986.6 5019.7 5034.7 5052.8 5067.0 5036.3 5063.1 5068.7 5105.8 5122.7 5502.2 5532.2 5562.2 5623.4 5668.6 6168.9 6356.8 6377.7 6402.6 6458.7 1638.0 1670.0 1676.2 1697.4 1710.8 1184.2 1224.9 1225.6 1228.2 1236.4 5444.3 5525.6 5533.8 5556.7 5627.9 6359.1 6367.0 6606.2 6612.7 6624.5 5600.9 5608.4 5618.2 5648.9 5683.9 3449.6 3478.6 3479.6 3483.3 3533.2 6238.8 6288.7 6403.2 6406.6 6408.4 6551.0 6637.5 6656.6 6690.0 6713.3 6202.8 6318.3 6372.9 6397.5 6456.9 6433.9 6442.5 6573.7 6615.5 6618.2 6402.4 6456.8 6485.2 6485.5 6576.8 6209.6 6221.9 6237.0 6324.3 6365.2 4933.3 4935.5 4978.4 5001.2 5028.3 6311.9 6535.9 6571.9 6591.3 6614.0 5964.5 6263.2 6327.5 6332.7 6406.4 6357.0 6359.8 6386.7 6386.9 6391.7 6223.4 6300.9 6305.6 6380.6 6436.8 6313.0 6368.1 6375.3 6453.3 6538.9 6133.8 6174.4 6188.5 6240.5 6263.7 12:10:05 INFO - PID 6148 | 12:10:05 INFO - PID 6148 | [#5] yui.html Cycles:180 Average:25923.57 Median:20332.75 stddev:36842.55 (181.2%) stddev-sans-first:36897.87 12:10:05 INFO - PID 6148 | Values: 868.4 922.5 930.0 935.3 940.5 19010.4 19434.9 19721.3 19821.0 19855.5 18872.4 18966.8 19205.0 19219.9 19270.9 971.6 983.1 983.4 985.3 986.6 935.6 979.9 986.3 994.0 994.6 1048.7 1053.4 1065.1 1065.5 1069.6 1042.6 1052.8 1055.5 1060.6 1062.3 770.2 770.5 778.8 779.1 782.1 19699.1 19756.8 19804.0 19988.2 20102.9 21503.9 21639.1 22054.7 22093.3 22186.1 16815.4 17037.2 17037.3 17125.1 17292.5 3693.1 3728.0 3734.8 3742.4 3745.5 133745.0 143051.0 143834.3 144573.3 147021.0 14224.2 14735.3 16321.2 16526.9 16823.8 31077.4 31247.5 31267.4 31968.5 32151.8 9327.4 9340.0 9381.5 9396.9 9452.5 4449.7 4455.2 4502.3 4531.4 4532.7 5427.7 5597.2 5611.4 5620.5 5634.6 1093.8 1125.9 1145.7 1148.2 1156.7 693.3 693.7 708.0 712.2 717.8 11918.2 12124.6 12231.3 12608.1 12775.1 626.7 627.1 643.0 649.9 651.4 5148.8 5229.5 5248.9 5322.9 5394.8 121893.0 124784.4 126439.0 131309.0 132415.0 109026.5 109363.5 111983.0 113307.0 116290.4 96486.0 99041.0 99966.0 100344.5 101299.5 9964.0 9968.6 10001.0 10101.2 10335.0 35779.8 36143.6 36523.8 40840.6 44218.8 69961.0 78479.0 80731.0 81192.6 82765.6 19346.9 19449.3 19609.3 19627.6 19671.2 19868.9 21114.0 21179.0 22103.2 22557.8 20268.0 20302.7 20362.8 20365.3 20682.0 19160.0 19366.6 19413.9 20088.9 20639.6 19233.2 19756.0 20022.0 20217.6 20459.0 14200.8 14497.7 14685.4 14752.0 14931.5 14651.2 14711.6 15427.5 15644.7 15684.9 12:10:05 INFO - PID 6148 | -------- Summary: end -------- 12:10:05 INFO - PID 6148 | 12:10:06 INFO - TEST-INFO | 6148: exit 0 12:10:06 INFO - TEST-OK | dromaeo_css | took 1115324ms 12:10:06 INFO - TEST-START | kraken 12:10:06 INFO - Initialising browser for kraken test... 12:10:06 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:44215/getInfo.html -profile /tmp/tmpuv0FU4/profile 12:10:06 INFO - TEST-INFO | started process 6569 (/builds/slave/test/build/application/firefox/firefox http://localhost:44215/getInfo.html) 12:10:13 INFO - TEST-INFO | 6569: exit 0 12:10:14 INFO - Browser initialized. 12:10:14 INFO - Running cycle 1/1 for kraken test... 12:10:14 INFO - Using env: {'DISPLAY': ':0', 12:10:14 INFO - 'HOME': '/home/cltbld', 12:10:14 INFO - 'JSGC_DISABLE_POISONING': '1', 12:10:14 INFO - 'LANG': 'en_US.UTF-8', 12:10:14 INFO - 'LANGUAGE': 'en_US:en', 12:10:14 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 12:10:14 INFO - 'LOGNAME': 'cltbld', 12:10:14 INFO - 'MAIL': '/var/mail/cltbld', 12:10:14 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 12:10:14 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 12:10:14 INFO - 'MOZ_ACCELERATED': '1', 12:10:14 INFO - 'MOZ_CRASHREPORTER': '1', 12:10:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:10:14 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 12:10:14 INFO - 'MOZ_NO_REMOTE': '1', 12:10:14 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 12:10:14 INFO - 'MOZ_WEBRENDER': '1', 12:10:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:10:14 INFO - 'NO_EM_RESTART': '1', 12:10:14 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:10:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:10:14 INFO - 'PWD': '/builds/slave/test', 12:10:14 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 12:10:14 INFO - 'RUST_BACKTRACE': 'full', 12:10:14 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 12:10:14 INFO - 'SHELL': '/bin/bash', 12:10:14 INFO - 'SHLVL': '1', 12:10:14 INFO - 'TERM': 'linux', 12:10:14 INFO - 'TMOUT': '86400', 12:10:14 INFO - 'USER': 'cltbld', 12:10:14 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1507056630.497244-2141909120', 12:10:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:10:14 INFO - '_': '/tools/buildbot/bin/python'} 12:10:14 INFO - TEST-INFO | started process 6815 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpuv0FU4/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 12:10:14 INFO - PID 6815 | WebRender - OpenGL version new 3.2.0 NVIDIA 361.42 12:10:15 INFO - PID 6815 | WebRender - OpenGL version new 3.2.0 NVIDIA 361.42 12:10:15 INFO - PID 6815 | 12:10:15 INFO - PID 6815 | (/builds/slave/test/build/application/firefox/firefox:6874): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 12:10:15 INFO - PID 6815 | 12:10:25 INFO - PID 6815 | RSS: Main: 210096128 12:10:25 INFO - PID 6815 | 12:10:28 INFO - PID 6815 | Cycle 1(1): loaded http://localhost:44215/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:44215/tests/kraken/driver.html?testName=audio-beat-detection) 12:10:29 INFO - PID 6815 | RSS: Main: 207581184 12:10:29 INFO - PID 6815 | 12:10:32 INFO - PID 6815 | Cycle 1(1): loaded http://localhost:44215/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:44215/tests/kraken/driver.html?testName=audio-dft) 12:10:32 INFO - PID 6815 | RSS: Main: 208027648 12:10:32 INFO - PID 6815 | 12:10:35 INFO - PID 6815 | Cycle 1(1): loaded http://localhost:44215/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:44215/tests/kraken/driver.html?testName=audio-fft) 12:10:36 INFO - PID 6815 | RSS: Main: 203907072 12:10:36 INFO - PID 6815 | 12:10:38 INFO - PID 6815 | Cycle 1(1): loaded http://localhost:44215/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:44215/tests/kraken/driver.html?testName=audio-oscillator) 12:10:38 INFO - PID 6815 | RSS: Main: 203980800 12:10:38 INFO - PID 6815 | 12:10:41 INFO - PID 6815 | Cycle 1(1): loaded http://localhost:44215/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:44215/tests/kraken/driver.html?testName=imaging-gaussian-blur) 12:10:41 INFO - PID 6815 | RSS: Main: 204271616 12:10:41 INFO - PID 6815 | 12:10:45 INFO - PID 6815 | Cycle 1(1): loaded http://localhost:44215/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:44215/tests/kraken/driver.html?testName=imaging-darkroom) 12:10:45 INFO - PID 6815 | RSS: Main: 206417920 12:10:45 INFO - PID 6815 | 12:10:49 INFO - PID 6815 | Cycle 1(1): loaded http://localhost:44215/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:44215/tests/kraken/driver.html?testName=imaging-desaturate) 12:10:49 INFO - PID 6815 | RSS: Main: 206131200 12:10:49 INFO - PID 6815 | 12:10:53 INFO - PID 6815 | Cycle 1(1): loaded http://localhost:44215/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:44215/tests/kraken/driver.html?testName=json-parse-financial) 12:10:53 INFO - PID 6815 | RSS: Main: 206409728 12:10:53 INFO - PID 6815 | 12:10:55 INFO - PID 6815 | Cycle 1(1): loaded http://localhost:44215/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:44215/tests/kraken/driver.html?testName=json-stringify-tinderbox) 12:10:55 INFO - PID 6815 | RSS: Main: 206303232 12:10:55 INFO - PID 6815 | 12:10:57 INFO - PID 6815 | Cycle 1(1): loaded http://localhost:44215/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:44215/tests/kraken/driver.html?testName=stanford-crypto-aes) 12:10:58 INFO - PID 6815 | RSS: Main: 206794752 12:10:58 INFO - PID 6815 | 12:11:00 INFO - PID 6815 | Cycle 1(1): loaded http://localhost:44215/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:44215/tests/kraken/driver.html?testName=stanford-crypto-ccm) 12:11:01 INFO - PID 6815 | RSS: Main: 206741504 12:11:01 INFO - PID 6815 | 12:11:03 INFO - PID 6815 | Cycle 1(1): loaded http://localhost:44215/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:44215/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 12:11:04 INFO - PID 6815 | RSS: Main: 206958592 12:11:04 INFO - PID 6815 | 12:11:07 INFO - PID 6815 | Cycle 1(1): loaded http://localhost:44215/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:44215/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 12:11:07 INFO - PID 6815 | RSS: Main: 206684160 12:11:07 INFO - PID 6815 | 12:11:09 INFO - PID 6815 | Cycle 1(1): loaded http://localhost:44215/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:44215/tests/kraken/driver.html?testName=ai-astar) 12:11:09 INFO - PID 6815 | RSS: Main: 208142336 12:11:09 INFO - PID 6815 | 12:11:09 INFO - PID 6815 | __start_tp_report 12:11:09 INFO - PID 6815 | _x_x_mozilla_page_load 12:11:09 INFO - PID 6815 | _x_x_mozilla_page_load_details 12:11:09 INFO - PID 6815 | |i|pagename|runs| 12:11:09 INFO - PID 6815 | |0;ai-astar;114;113;121;116;108;113;116;111;107;110 12:11:09 INFO - PID 6815 | |1;audio-beat-detection;122;121;120;117;129;114;125;120;118;125 12:11:09 INFO - PID 6815 | |2;audio-dft;166;165;167;172;173;172;170;167;165;167 12:11:09 INFO - PID 6815 | |3;audio-fft;80;81;75;77;82;79;86;75;73;75 12:11:09 INFO - PID 6815 | |4;audio-oscillator;82;85;81;88;78;81;79;80;90;81 12:11:09 INFO - PID 6815 | |5;imaging-gaussian-blur;125;115;120;114;118;120;114;120;112;119 12:11:09 INFO - PID 6815 | |6;imaging-darkroom;149;148;149;154;149;151;150;154;159;152 12:11:09 INFO - PID 6815 | |7;imaging-desaturate;97;101;95;94;101;95;99;95;95;96 12:11:09 INFO - PID 6815 | |8;json-parse-financial;52;62;51;49;51;55;50;57;51;51 12:11:09 INFO - PID 6815 | |9;json-stringify-tinderbox;37;38;38;37;37;48;46;47;45;43 12:11:09 INFO - PID 6815 | |10;stanford-crypto-aes;71;73;76;82;74;78;77;73;73;73 12:11:09 INFO - PID 6815 | |11;stanford-crypto-ccm;114;115;119;114;117;113;119;122;114;111 12:11:09 INFO - PID 6815 | |12;stanford-crypto-pbkdf2;160;162;168;164;166;163;161;165;166;167 12:11:09 INFO - PID 6815 | |13;stanford-crypto-sha256-iterative;65;65;78;68;67;69;72;68;68;64 12:11:09 INFO - PID 6815 | __end_tp_report 12:11:09 INFO - PID 6815 | __start_cc_report 12:11:09 INFO - PID 6815 | _x_x_mozilla_cycle_collect,740 12:11:09 INFO - PID 6815 | __end_cc_report 12:11:09 INFO - PID 6815 | __startTimestamp1507057869864__endTimestamp 12:11:09 INFO - PID 6815 | 12:11:09 INFO - PID 6815 | ------- Summary: start ------- 12:11:09 INFO - PID 6815 | Number of tests: 14 12:11:09 INFO - PID 6815 | 12:11:09 INFO - PID 6815 | [#0] ai-astar Cycles:10 Average:112.90 Median:113.50 stddev:4.18 (3.7%) stddev-sans-first:4.41 12:11:09 INFO - PID 6815 | Values: 114.0 113.0 121.0 116.0 108.0 113.0 116.0 111.0 107.0 110.0 12:11:09 INFO - PID 6815 | 12:11:09 INFO - PID 6815 | [#1] audio-beat-detection Cycles:10 Average:121.10 Median:121.50 stddev:4.38 (3.6%) stddev-sans-first:4.64 12:11:09 INFO - PID 6815 | Values: 122.0 121.0 120.0 117.0 129.0 114.0 125.0 120.0 118.0 125.0 12:11:09 INFO - PID 6815 | 12:11:09 INFO - PID 6815 | [#2] audio-dft Cycles:10 Average:168.40 Median:168.50 stddev:3.06 (1.8%) stddev-sans-first:3.12 12:11:09 INFO - PID 6815 | Values: 166.0 165.0 167.0 172.0 173.0 172.0 170.0 167.0 165.0 167.0 12:11:09 INFO - PID 6815 | 12:11:09 INFO - PID 6815 | [#3] audio-fft Cycles:10 Average:78.30 Median:79.50 stddev:4.03 (5.1%) stddev-sans-first:4.23 12:11:09 INFO - PID 6815 | Values: 80.0 81.0 75.0 77.0 82.0 79.0 86.0 75.0 73.0 75.0 12:11:09 INFO - PID 6815 | 12:11:09 INFO - PID 6815 | [#4] audio-oscillator Cycles:10 Average:82.50 Median:81.50 stddev:3.92 (4.8%) stddev-sans-first:4.16 12:11:09 INFO - PID 6815 | Values: 82.0 85.0 81.0 88.0 78.0 81.0 79.0 80.0 90.0 81.0 12:11:09 INFO - PID 6815 | 12:11:09 INFO - PID 6815 | [#5] imaging-gaussian-blur Cycles:10 Average:117.70 Median:119.50 stddev:3.92 (3.3%) stddev-sans-first:3.14 12:11:09 INFO - PID 6815 | Values: 125.0 115.0 120.0 114.0 118.0 120.0 114.0 120.0 112.0 119.0 12:11:09 INFO - PID 6815 | 12:11:09 INFO - PID 6815 | [#6] imaging-darkroom Cycles:10 Average:151.50 Median:151.50 stddev:3.37 (2.2%) stddev-sans-first:3.46 12:11:09 INFO - PID 6815 | Values: 149.0 148.0 149.0 154.0 149.0 151.0 150.0 154.0 159.0 152.0 12:11:09 INFO - PID 6815 | 12:11:09 INFO - PID 6815 | [#7] imaging-desaturate Cycles:10 Average:96.80 Median:95.00 stddev:2.62 (2.8%) stddev-sans-first:2.77 12:11:09 INFO - PID 6815 | Values: 97.0 101.0 95.0 94.0 101.0 95.0 99.0 95.0 95.0 96.0 12:11:09 INFO - PID 6815 | 12:11:09 INFO - PID 6815 | [#8] json-parse-financial Cycles:10 Average:52.90 Median:51.50 stddev:3.98 (7.7%) stddev-sans-first:4.21 12:11:09 INFO - PID 6815 | Values: 52.0 62.0 51.0 49.0 51.0 55.0 50.0 57.0 51.0 51.0 12:11:09 INFO - PID 6815 | 12:11:09 INFO - PID 6815 | [#9] json-stringify-tinderbox Cycles:10 Average:41.60 Median:44.00 stddev:4.62 (10.5%) stddev-sans-first:4.59 12:11:09 INFO - PID 6815 | Values: 37.0 38.0 38.0 37.0 37.0 48.0 46.0 47.0 45.0 43.0 12:11:09 INFO - PID 6815 | 12:11:09 INFO - PID 6815 | [#10] stanford-crypto-aes Cycles:10 Average:75.00 Median:75.00 stddev:3.27 (4.4%) stddev-sans-first:3.13 12:11:09 INFO - PID 6815 | Values: 71.0 73.0 76.0 82.0 74.0 78.0 77.0 73.0 73.0 73.0 12:11:09 INFO - PID 6815 | 12:11:09 INFO - PID 6815 | [#11] stanford-crypto-ccm Cycles:10 Average:115.80 Median:116.00 stddev:3.36 (2.9%) stddev-sans-first:3.50 12:11:09 INFO - PID 6815 | Values: 114.0 115.0 119.0 114.0 117.0 113.0 119.0 122.0 114.0 111.0 12:11:09 INFO - PID 6815 | 12:11:09 INFO - PID 6815 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:164.20 Median:165.50 stddev:2.66 (1.6%) stddev-sans-first:2.35 12:11:09 INFO - PID 6815 | Values: 160.0 162.0 168.0 164.0 166.0 163.0 161.0 165.0 166.0 167.0 12:11:09 INFO - PID 6815 | 12:11:09 INFO - PID 6815 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.40 Median:68.00 stddev:4.09 (6.0%) stddev-sans-first:4.15 12:11:09 INFO - PID 6815 | Values: 65.0 65.0 78.0 68.0 67.0 69.0 72.0 68.0 68.0 64.0 12:11:09 INFO - PID 6815 | -------- Summary: end -------- 12:11:09 INFO - PID 6815 | 12:11:10 INFO - PID 6815 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 12:11:10 INFO - TEST-INFO | 6815: exit 0 12:11:10 INFO - TEST-OK | kraken | took 64090ms 12:11:10 INFO - SUITE-END | took 1179s 12:11:11 INFO - Completed test suite (00:19:39) 12:11:11 INFO - javascript benchmark 12:11:11 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8531.255072731628, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3084.907452776416, 3117.3141908780067, 3125.1562078238862, 3131.264152924064, 3136.4354416205088, 5997.490213331861, 6151.815445536636, 6172.7530898764, 6181.350958149392, 6197.101420294055, 6090.086487026948, 6127.295361033483, 6184.505239580834, 6191.566590338678, 6290.779822706206, 5736.4550367715, 5788.652680839163, 5803.448672376117, 5817.301923769132, 5874.236349274588, 1089.786039533753, 5686.943130568683, 5763.049096899028, 5769.278840144982, 5782.0, 5535.889282214353, 5554.1946417769395, 5622.662640241558, 5699.601027928005, 5716.514096301819, 5659.717014149276, 5692.0323544997445, 5791.507721843648, 5809.2738407699035, 5809.738561764731, 5572.916406253909, 5644.181593668895, 5729.398413166599, 5759.5968282220265, 5776.133579962997, 6096.0, 6175.845603859894, 6180.783672571483, 6197.907031394533, 6200.565960382775, 6634.270230274666, 6655.201375834882, 6675.732970681167, 6721.529492935497, 6741.730330786762, 6244.094606282109, 6366.26787919386, 6539.149910511651, 6571.507136964747, 6681.5656982296, 6188.226471691039, 6206.565540412173, 6241.812745617639, 6288.779892703734, 6296.181496405438, 6816.795496135124, 6824.0446337512785, 6884.277150899184, 6929.757458488929, 6937.514373993873, 6530.346965303526, 6541.378569035934, 6584.5061620378665, 6630.9668451657435, 6632.071509988606, 6442.549021568539, 6563.8359041023405, 6585.506087043491, 6630.602163870183, 6684.197896252481, 6546.0508226307875, 6593.340665933369, 6652.0, 6655.301193374723, 6708.2956289589865, 6586.6377349245295, 6662.866742665216, 6679.465642748569, 6758.357955994173, 6778.0, 4716.198246298138, 4789.880252993633, 4854.320395144612, 4896.314515967767, 4898.975505122452, 4172.603602657743, 4187.958120418818, 4305.634021108178, 4314.784260786948, 4351.8694439166875, 5683.261176047087, 5739.196512488255, 5756.510696590753, 5757.193992841006, 5757.222774925415, 6598.505112116611, 6624.436922861611, 6669.199696036507, 6671.0, 6694.631795251211, 5474.644148130438, 5592.748326325325, 5616.66300022, 5620.100783874642, 5667.09326507765, 5491.148871924858, 5495.697736624524, 5499.285092937893, 5500.037493438632, 5505.9724701376235, 6330.8100756977365, 6351.079093531412, 6358.300586935434, 6372.745090196433, 6395.52033597482, 6522.445592124723, 6613.603183808987, 6621.172353455721, 6680.6993685283305, 6712.463002959849, 6389.169407976933, 6408.231012278557, 6448.645324507197, 6471.579347342407, 6496.285408605144, 6425.164728585254, 6525.967370163119, 6550.377714117151, 6577.309382514958, 6594.340565943367, 6373.6175829450385, 6439.227292724903, 6629.602223866584, 6641.634710090992, 6651.900221496779, 6476.6114033158165, 6493.253275873335, 6525.923222668207, 6532.216134063943, 6536.640484773193, 6369.49044076482, 6470.22357317125, 6476.935230647633, 6478.70845811949, 6485.189351331083, 6363.7772677956045, 6384.361563843764, 6412.6793660317735, 6448.45188158993, 6451.6774161290805, 6379.0, 6417.96791016042, 6420.967895160681, 6578.210614726264, 6659.866802663822, 6132.049532322497, 6146.907796383147, 6153.784617538365, 6167.660778657038, 6183.196184495987], "value": 5971.59975014438, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [803.5379656697397, 818.4802650317049, 829.2412442615008, 829.9626516806743, 832.6086739232559, 39973.80013099934, 43514.782426087826, 43522.347164792474, 43775.12449751003, 44112.77943610278, 38779.61220387795, 39133.21733565327, 39415.0, 39448.40827387592, 39694.0, 7049.612271325088, 7199.460040496958, 7233.927660723378, 7242.855142897139, 7244.782656520287, 7096.645167741618, 7138.821529461753, 7155.6064416457075, 7201.711931522759, 7203.307222802638, 7089.149302083757, 7114.715411383564, 7158.8568228635395, 7176.820579485502, 7178.712851485934, 7744.651490682904, 8003.4797738146835, 8021.398395120389, 8024.317932975646, 8038.678452861878, 7781.455298129134, 7792.727254546064, 7839.725609603694, 7854.253845884632, 7856.214378562098, 38504.80747596244, 38527.0, 38924.0, 38939.41590876139, 38949.610503895165, 3482.0946553895915, 3573.9456860226296, 3574.160072382988, 3579.1410061585293, 3581.8925432237074, 31610.525842112387, 31955.52066718978, 31999.200019999687, 32040.679593204004, 32100.678993210004, 5037.0103808995245, 5132.974335128338, 5142.07442660321, 5170.224466330043, 5259.5529380002745, 195475.0, 196172.01913990482, 196361.0, 197563.0, 198441.0, 43290.0, 43846.78076609661, 49001.0, 49233.75383123061, 49666.255006174935, 51954.22068668973, 53402.73298633482, 53438.0, 53723.73138134284, 54017.0, 16176.110313932846, 16283.755743663854, 16326.34694612226, 16338.101404422634, 16342.346306147621, 13087.738245235232, 13151.868481315256, 13253.0, 13294.601161965156, 13311.0, 14141.29293535319, 14352.210628415329, 14397.712045759026, 14519.128852268897, 14653.487127950471, 5597.552195824324, 5725.799597014085, 5826.359100498942, 5840.970795145997, 5967.16459695643, 983.2036050798876, 996.446971930571, 1003.934744241622, 1006.2201793609864, 1018.3482571154467, 23058.308250752503, 23538.64692029621, 23579.646305305436, 23622.7637723624, 23641.645375319385, 1109.6060898380958, 1114.9888501115047, 1120.93834839083, 1127.3968426891574, 1129.2829053551054, 12151.453184606715, 12205.38973051344, 12373.690657733448, 12375.814362784566, 12512.624621261377, 230274.24314392274, 230311.0, 231330.0, 232831.0, 233194.0, 53534.464655353724, 54251.72874135604, 54600.0, 54634.45365546373, 55314.17028744572, 1425.465450456079, 1467.9045862018934, 1468.3319089813895, 1471.168789633875, 1473.4253641079988, 22646.886765566065, 22908.198213062464, 22929.31212063641, 23200.651990219823, 23202.41993950097, 34387.14032149116, 34411.65588344185, 34829.825850870584, 34867.65132348746, 34986.65013349936, 196457.0, 197191.0, 198236.0, 198675.0, 198725.0, 29446.411071778017, 31027.68972310248, 31045.223869403446, 31387.90142345007, 33553.66446335505, 44212.55787442085, 44391.77804110959, 44566.3315050268, 44662.77668611636, 45030.324545131196, 31932.361352773278, 32017.67982320147, 32036.67963320337, 32044.83977580097, 32338.35323293568, 31184.22039449032, 31241.0, 31527.0, 31631.683683162875, 31649.683503164673, 34915.12712182216, 36308.636913631584, 36327.09182270464, 36678.8166059168, 36769.448458272615, 30095.54856677108, 30529.765973049773, 30578.235544110685, 30718.078457646305, 31634.525482117326, 23483.88258058699, 23587.764122358556, 23600.29199124029, 23713.52572948566, 24042.63936040926], "value": 17061.321779348364, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [578.8929048126096, 580.3268208877703, 584.2959234122885, 593.0967912070415, 593.7624950019991, 21825.454363640896, 22350.66474002891, 22361.54649947752, 22500.66249006264, 22648.43378915528, 22806.771932280673, 23528.29415117545, 24180.27459176223, 24335.14826981056, 24549.75450245497, 6265.812025639215, 6386.968065159667, 6425.45383642391, 6497.05792660064, 6520.608763474207, 6250.218687674013, 6337.366263373672, 6371.012493063583, 6379.489640828722, 6412.903806442907, 6161.907571386433, 6446.967765161167, 6481.319461456526, 6485.254195767477, 6486.513511486633, 6317.463015643652, 6361.395667411589, 6368.74525019001, 6393.328700486451, 6407.903881441735, 5742.598018138732, 5893.14549390336, 6004.0, 6012.128241404972, 6015.669138197398, 27859.86070069657, 28709.425811483863, 28718.13845584615, 28764.280892977633, 28821.0, 1973.0627951722818, 1988.1550341105117, 1997.0514005847251, 2001.789812069741, 2004.8696834705843, 18025.369112081014, 18562.350317738816, 18591.721124183146, 18705.812941870543, 18899.716504252447, 2466.5683505386487, 2477.4797292568583, 2478.578641630927, 2484.7266800651914, 2519.0553542421594, 120932.0, 127983.0, 144213.0, 150390.0, 150434.24782876016, 14331.713365732627, 14396.519199768705, 14418.206998615176, 14712.779308310384, 14808.3336249869, 23460.178893738637, 23545.175918843102, 23562.764372356058, 23652.0, 23674.881625591763, 9759.512024398751, 10022.298439109192, 10085.747856303651, 10213.33613315132, 10250.128739057263, 9169.174774270348, 9242.445453272825, 9247.306452016126, 9392.671256506126, 9478.0, 8792.42849214799, 9037.954810225907, 9081.45511269326, 9231.815363692824, 9242.722718318326, 2695.582184761365, 2761.471187252907, 2772.1406364027216, 2800.207866965144, 2840.4461130079435, 934.6868798952291, 942.5805516545072, 955.2119501411363, 963.3834346018554, 970.8495183246608, 17927.641447170983, 18609.53476163107, 18732.81267187338, 18853.245870165316, 19030.42908712741, 1005.240187711187, 1014.5890914179769, 1032.143321043547, 1036.7459972306683, 1037.9584816607403, 10387.68836934893, 10470.214733894989, 10500.527476263587, 10500.789984200273, 10554.894451055392, 450728.0, 455169.0, 472774.0, 477228.0, 478687.0, 112074.0, 112237.43881280541, 114095.0, 114863.42568287105, 115147.42426287982, 1131.2703306367512, 1191.4876603060768, 1236.5857437758273, 1253.0977696058824, 1267.7527882063093, 19624.90187549053, 19867.701984469957, 19871.40385788429, 20914.58170836605, 21008.159673613496, 58759.412405877105, 59233.111503326625, 59793.701031494566, 60494.395056048874, 61159.694201528706, 71273.64363178359, 71793.0, 71936.0, 73624.0, 75524.62237688997, 14514.201718905562, 14658.853411465749, 14885.181315027778, 14934.10395376281, 15027.624309392353, 21944.122235111055, 22854.657180141978, 23098.422539436648, 23180.652290215323, 23486.530269394858, 18200.362987295382, 18545.16546755372, 18620.627587447903, 18659.44021679352, 18707.0, 15435.15106669099, 15445.613859653598, 15540.766888496455, 15877.285522151762, 16130.919345403197, 18500.537486562942, 18883.0, 18906.0, 19050.23799048078, 19138.904305478383, 14571.198584077554, 14608.269586520844, 14751.631209219855, 14800.555983320517, 14906.701865962837, 17284.74072888933, 18090.366837160636, 18135.0, 18302.725459118392, 18371.0], "value": 11879.684682807836, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1333.1601091312475, 1384.8338199416069, 1395.0722769358376, 1398.1750767047447, 1412.0821466047075, 15713.528594142166, 16358.427455039076, 16424.999999999985, 16622.085785281804, 16661.750073748888, 15999.280032398541, 16056.518304450885, 16161.191940402961, 16211.946223495464, 16278.26747796349, 2731.549294366427, 2752.2431331383927, 2816.9718302816914, 2821.054946592894, 2824.943501129976, 2648.7616114549687, 2752.559590465526, 2769.6814866290333, 2781.9860900695467, 2790.679071906736, 2692.3538350795766, 2723.4689235599067, 2778.5554311310193, 2789.079603730764, 2826.8586570671487, 2648.682158141026, 2693.5151672698908, 2707.44497378037, 2722.5916112583072, 2737.3293543081872, 2451.9387015324583, 2483.3543278747657, 2491.426971796497, 2493.4265119022543, 2494.3888747257038, 14981.70036599262, 15053.247337633184, 15144.772828407582, 15230.619234519116, 15303.617409564738, 8226.341892648634, 8558.61486233121, 8562.100979397199, 8564.571771411405, 8579.313654907592, 5265.894682106375, 5466.125419932831, 5466.289382380305, 5502.119660854284, 5553.916986187695, 1908.7783818356263, 1922.884626922389, 1931.661959157156, 1945.8151475609795, 1972.7139564763172, 23232.3030309091, 24194.516109677883, 26967.73032269672, 27420.588691169647, 27569.448611027867, 6683.231428385798, 6876.140482439695, 6977.79066628002, 6986.371226589631, 7025.578465292099, 18083.0, 18089.095545222684, 18108.275668973358, 18112.909435452737, 18145.45563633093, 7813.374930005586, 7958.363330933512, 8025.3980951428875, 8029.3175080118845, 8056.959715201387, 7366.852662946818, 7418.406527477789, 7453.590052547053, 7464.552126872405, 7506.43701722373, 5299.6290259681455, 5398.2982212312145, 5479.178123281539, 5504.862378440571, 5517.420670829505, 1552.3945661192145, 1578.5501132177503, 1598.2328482328548, 1598.3926108079088, 1623.699615571123, 881.2905610983092, 897.7576054465258, 914.1377679304884, 932.2541966426832, 944.7732544189345, 8877.600507977157, 8909.420887642282, 8981.281497480186, 9046.909530904606, 9137.451752894847, 971.2812518736225, 980.9362391444533, 989.9257555683353, 1006.4213077480478, 1014.9035841595037, 5033.823816166417, 5311.654742441729, 5400.891982160335, 5569.0, 5575.888482230333, 20269.797302026793, 20486.79513204879, 20559.691604625943, 21833.454163645718, 22874.826891445286, 19001.239950402105, 20246.898765506077, 20428.591428171352, 20516.281930132373, 20658.690119648218, 10946.014858662758, 11066.502007409686, 11378.658640240807, 11384.658460246206, 11760.294382337259, 8381.0, 8383.455075420079, 8490.957545212234, 8653.39426240157, 8789.38474306818, 18576.328130468322, 18835.24659013624, 18960.336388226347, 19213.519662008002, 19548.31580894662, 19314.358279545835, 19559.21763129459, 19651.11569979326, 19927.0, 20498.0, 10255.692329230134, 11142.888571114185, 11165.218434709492, 11165.832512512481, 11190.160737944849, 13807.654808629864, 13913.513027044004, 14013.859861401663, 14147.151170929777, 14224.14655120696, 11128.944355278172, 11395.829062564235, 11435.885641143816, 11526.0, 11774.646760597196, 11064.170187235828, 11261.7747645045, 11376.260543064674, 11405.201635885409, 11567.884321157017, 9489.857652135086, 9627.518624068629, 9659.951700241454, 9744.902550974683, 9752.414855108716, 7308.159561650478, 7311.634418279171, 7372.189059203591, 7374.793066996498, 7459.888101678588, 7273.599952002691, 7379.446541509516, 7448.962755186406, 7465.477416580788, 7512.0], "value": 6781.419568670899, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [508.5245295648571, 511.12597458346215, 527.952484276415, 532.603210608097, 535.1063723581618, 5945.346011938684, 6048.697565121748, 6056.788012419566, 6085.78699745509, 6131.54013448992, 5934.910976335347, 5999.450233650692, 6027.336992930785, 6066.9978906960705, 6120.54095942805, 4887.898203772376, 4902.730349830758, 4921.040397122562, 4931.3835770528685, 4971.279164521142, 4727.621790256771, 4879.072976134541, 4889.755512224392, 4937.802487900498, 4966.776495057713, 4901.730404827733, 4905.533974272438, 4928.408590969071, 4930.975345123269, 4937.432195297551, 4871.926921096187, 4886.951130488721, 4900.926486102711, 4915.557599815998, 4922.286268491067, 4376.89057773555, 4392.714473559208, 4399.1641588098155, 4413.337999300131, 4442.2004039272915, 6000.579959402844, 6020.471402011166, 6028.547858910555, 6042.607230530046, 6067.848303792396, 5591.440855914417, 5631.662100273997, 5694.320175548223, 5708.885822283531, 5711.371749107595, 6416.903746443761, 6425.1647285853005, 6436.388543088399, 6503.739850405978, 6517.739290428377, 4790.233562629963, 4847.418309802846, 4850.514948505156, 4852.126617208901, 4861.173600487926, 6649.301823308531, 6671.766488172939, 6774.491913106487, 6785.8642827143185, 6803.863922721567, 4986.601071914238, 5019.67372120811, 5034.723090230073, 5052.797888084509, 5066.9746651266505, 5036.294918711384, 5063.063333283354, 5068.721220332917, 5105.795768169306, 5122.667026643257, 5502.2296878437055, 5532.197831314437, 5562.249096372019, 5623.381428042912, 5668.603197776116, 6168.8766224675255, 6356.777512787123, 6377.74489020434, 6402.551821372553, 6458.741650334028, 1638.000819500104, 1669.96660066798, 1676.2121802752686, 1697.439844851196, 1710.7767945918479, 1184.1592469346688, 1224.9448774804978, 1225.615054987858, 1228.2016689151944, 1236.3879879459726, 5444.292242008592, 5525.640833345819, 5533.750981205855, 5556.666600004012, 5627.8874422512135, 6359.092272318286, 6366.9681651591445, 6606.240282367493, 6612.669366531751, 6624.470042396693, 5600.887982240332, 5608.355039170466, 5618.213450116987, 5648.870225954825, 5683.857903552444, 3449.6032956209856, 3478.599961004517, 3479.634638362986, 3483.2511010132944, 3533.2403533240476, 6238.781642642486, 6288.748450062038, 6403.199600049994, 6406.615603063831, 6408.359164083555, 6551.017347397833, 6637.46900247979, 6656.60060396368, 6690.0, 6713.328667133248, 6202.813915582449, 6318.304986451487, 6372.904406433814, 6397.488200943913, 6456.903146452713, 6433.8713225736155, 6442.452391546771, 6573.671316434064, 6615.536912416084, 6618.238902526078, 6402.399400149962, 6456.774012909714, 6485.156929599122, 6485.509236831467, 6576.76981305652, 6209.627422354673, 6221.946757569901, 6237.0, 6324.272708638566, 6365.172527571386, 4933.260010998379, 4935.481774413634, 4978.352814134139, 5001.174806156943, 5028.270900719448, 6311.895418301687, 6535.901961470487, 6571.868562628816, 6591.307912669293, 6613.966930165318, 5964.463198312173, 6263.154474145932, 6327.493800495858, 6332.683365831598, 6406.391392817675, 6356.968215158895, 6359.791639588463, 6386.744530218739, 6386.9361306386345, 6391.712372943136, 6223.408776166257, 6300.936990630218, 6305.558610897193, 6380.585261957958, 6436.806895793134, 6313.0, 6368.0766288886925, 6375.250438423404, 6453.322401147811, 6538.921078022263, 6133.785317514044, 6174.38256174379, 6188.504919606511, 6240.469560087444, 6263.74945002213], "value": 4957.639421689255, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [868.3704314372081, 922.460360688997, 929.9814003719925, 935.3405848876538, 940.4545363689059, 19010.42968710941, 19434.90282548589, 19721.309754158607, 19820.99999999998, 19855.5036124097, 18872.43382698518, 18966.81033189668, 19205.0, 19219.903900480513, 19270.903645481754, 971.616211596419, 983.0709979069782, 983.4050399508302, 985.261054209343, 986.5856340337076, 935.6491315756591, 979.8971108033661, 986.344081186014, 994.0308199505497, 994.5872462927913, 1048.7430579508032, 1053.415354478268, 1065.137238836541, 1065.477915821246, 1069.5989004123453, 1042.5881776698238, 1052.847337136111, 1055.5091882274742, 1060.6075751971782, 1062.3041907550567, 770.2413123073768, 770.5338270346416, 778.7702627724778, 779.0962483519147, 782.1201148707704, 19699.11353989074, 19756.80243197564, 19804.0, 19988.20047198125, 20102.899485502625, 21503.892480537652, 21639.134434622596, 22054.669179962315, 22093.33719988403, 22186.112555497763, 16815.41146059894, 17037.233324500427, 17037.318507259693, 17125.14374281281, 17292.481225563126, 3693.095191678029, 3727.9813600932093, 3734.7945862977526, 3742.363798154293, 3745.494358261627, 133745.0, 143051.0, 143834.28082859624, 144573.27713361365, 147021.0, 14224.217668028357, 14735.263236838115, 16321.18394080315, 16526.917365413337, 16823.831761682228, 31077.378452430825, 31247.531287030713, 31267.37465250728, 31968.520472192937, 32151.839240803645, 9327.393719408217, 9340.0, 9381.484018378918, 9396.87237531487, 9452.480113593818, 4449.710768800018, 4455.242608756519, 4502.3246513023305, 4531.365608814768, 4532.7280363178315, 5427.674339539641, 5597.216389705444, 5611.438856114438, 5620.494155526022, 5634.577406694514, 1093.786711591248, 1125.915556333262, 1145.6906635208447, 1148.2134737704532, 1156.6587856582328, 693.3343989769877, 693.729445516249, 708.0229283588615, 712.1881055596624, 717.7846646006282, 11918.225315354473, 12124.63626091201, 12231.327276999851, 12608.11743177987, 12775.105742598114, 626.7367705563674, 627.1126356206008, 642.996785016072, 649.9447546958467, 651.3779340729592, 5148.819791307286, 5229.529342359206, 5248.895022099537, 5322.946770532322, 5394.757235924393, 121893.0, 124784.37607812084, 126439.0, 131309.0, 132415.0, 109026.45486772674, 109363.45318273357, 111983.0, 113307.0, 116290.41854790841, 96486.0, 99041.0, 99966.0, 100344.49827750814, 101299.49350253202, 9964.0, 9968.601255949681, 10001.0, 10101.191904647463, 10335.0, 35779.821100894325, 36143.638563614026, 36523.81738091292, 40840.59159408368, 44218.77890610526, 69961.0, 78479.0, 80731.0, 81192.59403702944, 82765.58617207117, 19346.903265483583, 19449.31927382535, 19609.31367402134, 19627.607447850678, 19671.21315147378, 19868.90065549663, 21114.0, 21179.0, 22103.226387076375, 22557.774422256225, 20268.0, 20302.69545956782, 20362.79637203609, 20365.287214947406, 20682.0, 19160.0, 19366.61266774685, 19413.902930485823, 20088.89955550213, 20639.58720825545, 19233.230670773013, 19756.0, 20022.0, 20217.59564808725, 20459.0, 14200.78698819498, 14497.710045799236, 14685.41258349654, 14752.041117327339, 14931.477398291008, 14651.176729132725, 14711.632209194428, 15427.5371738848, 15644.687106257583, 15684.921575392507], "value": 9474.296111409707, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1447.1000000000001, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 113.0, 121.0, 116.0, 108.0, 113.0, 116.0, 111.0, 107.0, 110.0], "value": 112.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [122.0, 121.0, 120.0, 117.0, 129.0, 114.0, 125.0, 120.0, 118.0, 125.0], "value": 121.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [166.0, 165.0, 167.0, 172.0, 173.0, 172.0, 170.0, 167.0, 165.0, 167.0], "value": 168.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 81.0, 75.0, 77.0, 82.0, 79.0, 86.0, 75.0, 73.0, 75.0], "value": 78.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 85.0, 81.0, 88.0, 78.0, 81.0, 79.0, 80.0, 90.0, 81.0], "value": 82.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [125.0, 115.0, 120.0, 114.0, 118.0, 120.0, 114.0, 120.0, 112.0, 119.0], "value": 117.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 148.0, 149.0, 154.0, 149.0, 151.0, 150.0, 154.0, 159.0, 152.0], "value": 151.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [97.0, 101.0, 95.0, 94.0, 101.0, 95.0, 99.0, 95.0, 95.0, 96.0], "value": 96.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [52.0, 62.0, 51.0, 49.0, 51.0, 55.0, 50.0, 57.0, 51.0, 51.0], "value": 52.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [37.0, 38.0, 38.0, 37.0, 37.0, 48.0, 46.0, 47.0, 45.0, 43.0], "value": 41.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 73.0, 76.0, 82.0, 74.0, 78.0, 77.0, 73.0, 73.0, 73.0], "value": 75.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 115.0, 119.0, 114.0, 117.0, 113.0, 119.0, 122.0, 114.0, 111.0], "value": 115.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 162.0, 168.0, 164.0, 166.0, 163.0, 161.0, 165.0, 166.0, 167.0], "value": 164.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 65.0, 78.0, 68.0, 67.0, 69.0, 72.0, 68.0, 68.0, 64.0], "value": 68.4, "unit": "score"}]}]} 12:11:11 INFO - Return code: 0 12:11:11 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 12:11:11 INFO - # TBPL SUCCESS # 12:11:11 INFO - Running post-action listener: _package_coverage_data 12:11:11 INFO - Running post-action listener: _resource_record_post_action 12:11:11 INFO - [mozharness: 2017-10-03 19:11:11.135628Z] Finished run-tests step (success) 12:11:11 INFO - Running post-run listener: _resource_record_post_run 12:11:11 INFO - Total resource usage - Wall time: 1198s; CPU: 13.0%; Read bytes: 7974912; Write bytes: 343257088; Read time: 8048; Write time: 476552 12:11:11 INFO - TinderboxPrint: CPU usage
13.3% 12:11:11 INFO - TinderboxPrint: I/O read bytes / time
7,974,912 / 8,048 12:11:11 INFO - TinderboxPrint: I/O write bytes / time
343,257,088 / 476,552 12:11:11 INFO - TinderboxPrint: CPU idle
8,271.2 (86.7%) 12:11:11 INFO - TinderboxPrint: CPU user
1,200.9 (12.6%) 12:11:11 INFO - TinderboxPrint: Swap in / out
0 / 0 12:11:11 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 10919936; Read time: 0; Write time: 2852 12:11:11 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 12:11:11 INFO - run-tests - Wall time: 1180s; CPU: 13.0%; Read bytes: 7970816; Write bytes: 331620352; Read time: 8036; Write time: 473684 12:11:11 INFO - Running post-run listener: _upload_blobber_files 12:11:11 INFO - Blob upload gear active. 12:11:11 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 12:11:11 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 12:11:11 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'] 12:11:11 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 12:11:12 INFO - (blobuploader) - INFO - Open directory for files ... 12:11:12 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 12:11:12 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:11:12 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:11:13 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 12:11:13 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:11:13 INFO - (blobuploader) - INFO - Done attempting. 12:11:13 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 12:11:13 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:11:13 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:11:20 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 12:11:20 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:11:20 INFO - (blobuploader) - INFO - Done attempting. 12:11:20 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 12:11:20 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:11:20 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:11:21 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 12:11:21 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:11:21 INFO - (blobuploader) - INFO - Done attempting. 12:11:21 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 12:11:21 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:11:21 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:11:22 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 12:11:22 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:11:22 INFO - (blobuploader) - INFO - Done attempting. 12:11:22 INFO - (blobuploader) - INFO - Iteration through files over. 12:11:22 INFO - Return code: 0 12:11:22 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 12:11:22 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 12:11:22 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e3d6a11e15c42c8ec7c36caa9e11f7de8029d2ad5a3f8df9e5f5e4d54c1d92c8811aeb8fb54b71cb85453d718f46b96b1b0b43701eb76aa8a89181e0423776e1", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c712d22aac1f72f57875d4d044a40052dea78d3ff6ed103146ec1fc3bda893dd2cecf68538dedbb0dac8a8c21790091d7061480704fe1946e0f1c9676a488fab", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9cc693be5fa3e82ed3ce74847d84e013731fa11f9bc7c253733e1e64dd3be582685e1138a4aefbbe75adb99752da7b445a0c2082c92a515f6cf8247a9f9f501c", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/97c9885d67728199e7f3fc33043b483ff2eeaad280e28fc386a1702c4fd812bcfb537ddc3386415e878e110c0a78b0bfa267eb651352575bf9bb2ee5d6e5daa2"} 12:11:22 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 12:11:22 INFO - Writing to file /builds/slave/test/properties/blobber_files 12:11:22 INFO - Contents: 12:11:22 INFO - blobber_files:{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e3d6a11e15c42c8ec7c36caa9e11f7de8029d2ad5a3f8df9e5f5e4d54c1d92c8811aeb8fb54b71cb85453d718f46b96b1b0b43701eb76aa8a89181e0423776e1", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c712d22aac1f72f57875d4d044a40052dea78d3ff6ed103146ec1fc3bda893dd2cecf68538dedbb0dac8a8c21790091d7061480704fe1946e0f1c9676a488fab", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9cc693be5fa3e82ed3ce74847d84e013731fa11f9bc7c253733e1e64dd3be582685e1138a4aefbbe75adb99752da7b445a0c2082c92a515f6cf8247a9f9f501c", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/97c9885d67728199e7f3fc33043b483ff2eeaad280e28fc386a1702c4fd812bcfb537ddc3386415e878e110c0a78b0bfa267eb651352575bf9bb2ee5d6e5daa2"} 12:11:22 INFO - Running post-run listener: copy_logs_to_upload_dir 12:11:22 INFO - Copying logs to upload dir... 12:11:22 INFO - mkdir: /builds/slave/test/build/upload/logs 12:11:22 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1250.369306 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 50 secs) (at 2017-10-03 12:11:22.580632) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-10-03 12:11:22.584368) ========= 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=52faae308a556c440401f8e5000001e8-1507056630.497244-2141909120 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e3d6a11e15c42c8ec7c36caa9e11f7de8029d2ad5a3f8df9e5f5e4d54c1d92c8811aeb8fb54b71cb85453d718f46b96b1b0b43701eb76aa8a89181e0423776e1", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c712d22aac1f72f57875d4d044a40052dea78d3ff6ed103146ec1fc3bda893dd2cecf68538dedbb0dac8a8c21790091d7061480704fe1946e0f1c9676a488fab", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9cc693be5fa3e82ed3ce74847d84e013731fa11f9bc7c253733e1e64dd3be582685e1138a4aefbbe75adb99752da7b445a0c2082c92a515f6cf8247a9f9f501c", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/97c9885d67728199e7f3fc33043b483ff2eeaad280e28fc386a1702c4fd812bcfb537ddc3386415e878e110c0a78b0bfa267eb651352575bf9bb2ee5d6e5daa2"} build_url:https://queue.taskcluster.net/v1/task/Y228oe7GQHKzMAnD1Lmgzg/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011458 build_url: 'https://queue.taskcluster.net/v1/task/Y228oe7GQHKzMAnD1Lmgzg/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e3d6a11e15c42c8ec7c36caa9e11f7de8029d2ad5a3f8df9e5f5e4d54c1d92c8811aeb8fb54b71cb85453d718f46b96b1b0b43701eb76aa8a89181e0423776e1", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c712d22aac1f72f57875d4d044a40052dea78d3ff6ed103146ec1fc3bda893dd2cecf68538dedbb0dac8a8c21790091d7061480704fe1946e0f1c9676a488fab", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9cc693be5fa3e82ed3ce74847d84e013731fa11f9bc7c253733e1e64dd3be582685e1138a4aefbbe75adb99752da7b445a0c2082c92a515f6cf8247a9f9f501c", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/97c9885d67728199e7f3fc33043b483ff2eeaad280e28fc386a1702c4fd812bcfb537ddc3386415e878e110c0a78b0bfa267eb651352575bf9bb2ee5d6e5daa2"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-10-03 12:11:22.616945) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-10-03 12:11:22.617295) ========= 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=52faae308a556c440401f8e5000001e8-1507056630.497244-2141909120 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004450 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-10-03 12:11:22.698558) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-10-03 12:11:22.698870) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-10-03 12:11:22.700156) ========= ========= Total master_lag: 0.20 =========