builder: mozilla-beta_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-055 starttime: 1506458070.31 results: success (0) revision: 18235244bde0c69589b794f3959762beab1f6d8d ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-09-26 13:34:30.313689) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-09-26 13:34:30.314169) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-26 13:34:30.314602) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-26 13:34:30.349941) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-26 13:34:30.350302) ========= 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=bb9b54edd4a927dc735d112f000001d9-1506457791.22431-788204233 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-09-26 13:34:30-- 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% 41.6M=0s 2017-09-26 13:34:30 (41.6 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.097029 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-26 13:34:30.465225) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-26 13:34:30.465576) ========= 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=bb9b54edd4a927dc735d112f000001d9-1506457791.22431-788204233 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017167 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-26 13:34:30.515762) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-26 13:34:30.516101) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 18235244bde0c69589b794f3959762beab1f6d8d --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 18235244bde0c69589b794f3959762beab1f6d8d --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=bb9b54edd4a927dc735d112f000001d9-1506457791.22431-788204233 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-09-26 13:34:30,568 truncating revision to first 12 chars 2017-09-26 13:34:30,568 Setting DEBUG logging. 2017-09-26 13:34:30,568 attempt 1/10 2017-09-26 13:34:30,569 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/18235244bde0?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-09-26 13:34:30,997 unpacking tar archive at: mozilla-beta-18235244bde0/testing/mozharness/ program finished with exit code 0 elapsedTime=0.728667 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-26 13:34:31.261575) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-26 13:34:31.261931) ========= script_repo_revision: 18235244bde0c69589b794f3959762beab1f6d8d ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-26 13:34:31.262342) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-26 13:34:31.262685) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-26 13:34:31.276421) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 30 secs) (at 2017-09-26 13:34:31.277063) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Beta-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Beta-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Beta-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=bb9b54edd4a927dc735d112f000001d9-1506457791.22431-788204233 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 13:34:31 INFO - MultiFileLogger online at 20170926 13:34:31 in /builds/slave/test 13:34:31 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Beta-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta-Non-PGO 13:34:31 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 13:34:31 INFO - {'append_to_log': False, 13:34:31 INFO - 'base_work_dir': '/builds/slave/test', 13:34:31 INFO - 'blob_upload_branch': 'Mozilla-Beta-Non-PGO', 13:34:31 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 13:34:31 INFO - 'branch': 'Mozilla-Beta-Non-PGO', 13:34:31 INFO - 'buildbot_json_path': 'buildprops.json', 13:34:31 INFO - 'code_coverage': False, 13:34:31 INFO - 'config_files': ('talos/linux_config.py',), 13:34:31 INFO - 'default_actions': ('clobber', 13:34:31 INFO - 'read-buildbot-config', 13:34:31 INFO - 'download-and-extract', 13:34:31 INFO - 'populate-webroot', 13:34:31 INFO - 'create-virtualenv', 13:34:31 INFO - 'install', 13:34:31 INFO - 'setup-mitmproxy', 13:34:31 INFO - 'run-tests'), 13:34:31 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 13:34:31 INFO - 'disable_ccov_upload': False, 13:34:31 INFO - 'disable_stylo': False, 13:34:31 INFO - 'download_minidump_stackwalk': True, 13:34:31 INFO - 'download_symbols': 'ondemand', 13:34:31 INFO - 'enable_stylo': False, 13:34:31 INFO - 'enable_webrender': False, 13:34:31 INFO - 'exes': {'tooltool.py': '/tools/tooltool.py'}, 13:34:31 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 13:34:31 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 13:34:31 INFO - 'gecko_profile': False, 13:34:31 INFO - 'gecko_profile_interval': 0, 13:34:31 INFO - 'installer_path': 'installer.exe', 13:34:31 INFO - 'log_level': 'info', 13:34:31 INFO - 'log_name': 'talos', 13:34:31 INFO - 'log_to_console': True, 13:34:31 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 13:34:31 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 13:34:31 INFO - 'opt_config_files': (), 13:34:31 INFO - 'pip_index': False, 13:34:31 INFO - 'suite': 'dromaeojs-e10s', 13:34:31 INFO - 'system_bits': '32', 13:34:31 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 13:34:31 INFO - 'title': 'talos-linux64-ix-055', 13:34:31 INFO - 'tooltool_cache': '/builds/tooltool_cache', 13:34:31 INFO - 'use_talos_json': True, 13:34:31 INFO - 'verify': 'False', 13:34:31 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 13:34:31 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 13:34:31 INFO - 'work_dir': 'build'} 13:34:31 INFO - [mozharness: 2017-09-26 20:34:31.475539Z] Running clobber step. 13:34:31 INFO - Running pre-action listener: _resource_record_pre_action 13:34:31 INFO - Running main action method: clobber 13:34:31 INFO - rmtree: /builds/slave/test/build 13:34:31 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 13:34:32 INFO - Running post-action listener: _resource_record_post_action 13:34:32 INFO - [mozharness: 2017-09-26 20:34:32.971739Z] Finished clobber step (success) 13:34:32 INFO - [mozharness: 2017-09-26 20:34:32.971837Z] Running read-buildbot-config step. 13:34:32 INFO - Running pre-action listener: _resource_record_pre_action 13:34:32 INFO - Running main action method: read_buildbot_config 13:34:32 INFO - Using buildbot properties: 13:34:32 INFO - { 13:34:32 INFO - "project": "", 13:34:32 INFO - "product": "firefox", 13:34:32 INFO - "who": "ffxbld@noreply.mozilla.org", 13:34:32 INFO - "installer_path": "public/build/target.tar.bz2", 13:34:32 INFO - "builddir": "mozilla-beta_ubuntu64_hw_test-dromaeojs-e10s", 13:34:32 INFO - "repository": "https://hg.mozilla.org/releases/mozilla-beta", 13:34:32 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-beta talos dromaeojs-e10s", 13:34:32 INFO - "stage_platform": "linux64", 13:34:32 INFO - "basedir": "/builds/slave/test", 13:34:32 INFO - "buildnumber": 119, 13:34:32 INFO - "platform": "ubuntu64_hw", 13:34:32 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 13:34:32 INFO - "slavebuilddir": "test", 13:34:32 INFO - "taskId": "RLM5AX_xR6WBo9jyw5BEiw", 13:34:32 INFO - "branch": "mozilla-beta", 13:34:32 INFO - "script_repo_revision": "production", 13:34:32 INFO - "revision": "18235244bde0c69589b794f3959762beab1f6d8d", 13:34:32 INFO - "slavename": "talos-linux64-ix-055", 13:34:32 INFO - "repo_path": "releases/mozilla-beta" 13:34:32 INFO - } 13:34:32 INFO - Finding installer, test and symbols from parent task. 13:34:32 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/RLM5AX_xR6WBo9jyw5BEiw'}, attempt #1 13:34:33 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/RLM5AX_xR6WBo9jyw5BEiw'}, attempt #1 13:34:33 INFO - Task dependencies: Sh6aKoENTCqMYpxxdeGTwQ 13:34:33 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Sh6aKoENTCqMYpxxdeGTwQ'}, attempt #1 13:34:34 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/Sh6aKoENTCqMYpxxdeGTwQ/artifacts/public/build/target.tar.bz2 13:34:34 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/Sh6aKoENTCqMYpxxdeGTwQ/artifacts/public/build/target.test_packages.json 13:34:34 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/Sh6aKoENTCqMYpxxdeGTwQ/artifacts/public/build/target.crashreporter-symbols.zip 13:34:34 INFO - Running post-action listener: _resource_record_post_action 13:34:34 INFO - [mozharness: 2017-09-26 20:34:34.331335Z] Finished read-buildbot-config step (success) 13:34:34 INFO - [mozharness: 2017-09-26 20:34:34.331552Z] Running download-and-extract step. 13:34:34 INFO - Running pre-action listener: _resource_record_pre_action 13:34:34 INFO - Running main action method: download_and_extract 13:34:34 INFO - mkdir: /builds/slave/test/build/tests 13:34:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:34:34 INFO - trying https://queue.taskcluster.net/v1/task/Sh6aKoENTCqMYpxxdeGTwQ/artifacts/public/build/target.test_packages.json 13:34:34 INFO - Downloading https://queue.taskcluster.net/v1/task/Sh6aKoENTCqMYpxxdeGTwQ/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 13:34:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Sh6aKoENTCqMYpxxdeGTwQ/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 13:34:34 INFO - Downloaded 989 bytes. 13:34:34 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 13:34:34 INFO - Using the following test package requirements: 13:34:34 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 13:34:34 INFO - u'common': [u'target.common.tests.zip'], 13:34:34 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 13:34:34 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 13:34:34 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 13:34:34 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 13:34:34 INFO - u'mozbase': [u'target.common.tests.zip'], 13:34:34 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 13:34:34 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 13:34:34 INFO - u'web-platform': [u'target.common.tests.zip', 13:34:34 INFO - u'target.web-platform.tests.tar.gz'], 13:34:34 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 13:34:34 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite categories: ['common', 'talos'] 13:34:34 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Sh6aKoENTCqMYpxxdeGTwQ/artifacts/public/build/target.common.tests.zip 13:34:34 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Sh6aKoENTCqMYpxxdeGTwQ/artifacts/public/build/target.common.tests.zip'}, attempt #1 13:34:34 INFO - Fetch https://queue.taskcluster.net/v1/task/Sh6aKoENTCqMYpxxdeGTwQ/artifacts/public/build/target.common.tests.zip into memory 13:34:36 INFO - Content-Length response header: 55176981 13:34:36 INFO - Bytes received: 55176981 13:34:46 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Sh6aKoENTCqMYpxxdeGTwQ/artifacts/public/build/target.talos.tests.zip 13:34:46 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Sh6aKoENTCqMYpxxdeGTwQ/artifacts/public/build/target.talos.tests.zip'}, attempt #1 13:34:46 INFO - Fetch https://queue.taskcluster.net/v1/task/Sh6aKoENTCqMYpxxdeGTwQ/artifacts/public/build/target.talos.tests.zip into memory 13:34:47 INFO - Content-Length response header: 14509184 13:34:47 INFO - Bytes received: 14509184 13:34:47 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')]} 13:34:47 INFO - trying https://queue.taskcluster.net/v1/task/Sh6aKoENTCqMYpxxdeGTwQ/artifacts/public/build/target.tar.bz2 13:34:47 INFO - Downloading https://queue.taskcluster.net/v1/task/Sh6aKoENTCqMYpxxdeGTwQ/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 13:34:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Sh6aKoENTCqMYpxxdeGTwQ/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 13:34:48 INFO - Downloaded 53553921 bytes. 13:34:48 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Sh6aKoENTCqMYpxxdeGTwQ/artifacts/public/build/target.tar.bz2 13:34:48 INFO - mkdir: /builds/slave/test/properties 13:34:48 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 13:34:48 INFO - Writing to file /builds/slave/test/properties/build_url 13:34:48 INFO - Contents: 13:34:48 INFO - build_url:https://queue.taskcluster.net/v1/task/Sh6aKoENTCqMYpxxdeGTwQ/artifacts/public/build/target.tar.bz2 13:34:48 INFO - Running post-action listener: _resource_record_post_action 13:34:48 INFO - Running post-action listener: find_tests_for_verification 13:34:48 INFO - Running post-action listener: set_extra_try_arguments 13:34:48 INFO - [mozharness: 2017-09-26 20:34:48.817981Z] Finished download-and-extract step (success) 13:34:48 INFO - [mozharness: 2017-09-26 20:34:48.818079Z] Running populate-webroot step. 13:34:48 INFO - Running pre-action listener: _resource_record_pre_action 13:34:48 INFO - Running main action method: populate_webroot 13:34:48 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 13:34:48 INFO - 'chromez-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 13:34:48 INFO - 'tests': ['tresize', 13:34:48 INFO - 'tcanvasmark']}, 13:34:48 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 13:34:48 INFO - 'dromaeojs-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 13:34:48 INFO - 'tests': ['dromaeo_css', 13:34:48 INFO - 'kraken']}, 13:34:48 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 13:34:48 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:34:48 INFO - 'g1-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 13:34:48 INFO - 'talos_options': ['--disable-stylo'], 13:34:48 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:34:48 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 13:34:48 INFO - 'tests': ['damp', 'tps']}, 13:34:48 INFO - 'g2-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 13:34:48 INFO - 'talos_options': ['--disable-stylo'], 13:34:48 INFO - 'tests': ['damp', 'tps']}, 13:34:48 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 13:34:48 INFO - 'g3-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 13:34:48 INFO - 'tests': ['dromaeo_dom']}, 13:34:48 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 13:34:48 INFO - 'g4-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 13:34:48 INFO - 'tests': ['basic_compositor_video', 13:34:48 INFO - 'glvideo']}, 13:34:48 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 13:34:48 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 13:34:48 INFO - 'g5-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 13:34:48 INFO - 'talos_options': ['--disable-stylo'], 13:34:48 INFO - 'tests': ['ts_paint_webext', 13:34:48 INFO - 'tp5o_webext']}, 13:34:48 INFO - 'other-e10s': {'tests': ['a11yr', 13:34:48 INFO - 'ts_paint', 13:34:48 INFO - 'tpaint', 13:34:48 INFO - 'sessionrestore', 13:34:48 INFO - 'sessionrestore_many_windows', 13:34:48 INFO - 'sessionrestore_no_auto_restore', 13:34:48 INFO - 'tabpaint']}, 13:34:48 INFO - 'other-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 13:34:48 INFO - 'tests': ['a11yr', 13:34:48 INFO - 'ts_paint', 13:34:48 INFO - 'tpaint', 13:34:48 INFO - 'sessionrestore', 13:34:48 INFO - 'sessionrestore_many_windows', 13:34:48 INFO - 'sessionrestore_no_auto_restore', 13:34:48 INFO - 'tabpaint']}, 13:34:48 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 13:34:48 INFO - 'perf-reftest-singletons-e10s': {'tests': ['perf_reftest_singletons']}, 13:34:48 INFO - 'perf-reftest-singletons-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 13:34:48 INFO - 'tests': ['perf_reftest_singletons']}, 13:34:48 INFO - 'perf-reftest-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 13:34:48 INFO - 'tests': ['bloom_basic']}, 13:34:48 INFO - 'svgr-e10s': {'tests': ['tsvgx', 13:34:48 INFO - 'tsvgr_opacity', 13:34:48 INFO - 'tart', 13:34:48 INFO - 'tscrollx', 13:34:48 INFO - 'tsvg_static']}, 13:34:48 INFO - 'svgr-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 13:34:48 INFO - 'tests': ['tsvgx', 13:34:48 INFO - 'tsvgr_opacity', 13:34:48 INFO - 'tart', 13:34:48 INFO - 'tscrollx', 13:34:48 INFO - 'tsvg_static']}, 13:34:48 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 13:34:48 INFO - 'tp5o-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 13:34:48 INFO - 'talos_options': ['--disable-stylo'], 13:34:48 INFO - 'tests': ['tp5o']}, 13:34:48 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 13:34:48 INFO - 'talos_options': ['--mitmproxy', 13:34:48 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 13:34:48 INFO - '--firstNonBlankPaint'], 13:34:48 INFO - 'tests': ['tp6_google', 13:34:48 INFO - 'tp6_youtube', 13:34:48 INFO - 'tp6_amazon', 13:34:48 INFO - 'tp6_facebook']}, 13:34:48 INFO - 'tp6-stylo-disabled-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 13:34:48 INFO - 'talos_options': ['--disable-stylo', 13:34:48 INFO - '--mitmproxy', 13:34:48 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 13:34:48 INFO - '--firstNonBlankPaint'], 13:34:48 INFO - 'tests': ['tp6_google', 13:34:48 INFO - 'tp6_youtube', 13:34:48 INFO - 'tp6_amazon', 13:34:48 INFO - 'tp6_facebook']}, 13:34:48 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 13:34:48 INFO - 'talos_options': ['--stylo-threads=1', 13:34:48 INFO - '--mitmproxy', 13:34:48 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 13:34:48 INFO - '--firstNonBlankPaint'], 13:34:48 INFO - 'tests': ['tp6_google', 13:34:48 INFO - 'tp6_youtube', 13:34:48 INFO - 'tp6_amazon', 13:34:48 INFO - 'tp6_facebook']}, 13:34:48 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 13:34:48 INFO - 'talos_options': ['--xperf_path', 13:34:48 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:34:48 INFO - 'tests': ['tp5n']}, 13:34:48 INFO - 'xperf-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 13:34:48 INFO - 'talos_options': ['--disable-stylo', 13:34:48 INFO - '--xperf_path', 13:34:48 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:34:48 INFO - 'tests': ['tp5n']}}} 13:34:48 INFO - Running post-action listener: _resource_record_post_action 13:34:48 INFO - [mozharness: 2017-09-26 20:34:48.832944Z] Finished populate-webroot step (success) 13:34:48 INFO - [mozharness: 2017-09-26 20:34:48.833033Z] Running create-virtualenv step. 13:34:48 INFO - Running pre-action listener: _resource_record_pre_action 13:34:48 INFO - Running main action method: create_virtualenv 13:34:48 INFO - Creating virtualenv /builds/slave/test/build/venv 13:34:48 INFO - Running command: ['virtualenv', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 13:34:48 INFO - Copy/paste: virtualenv --no-site-packages --distribute /builds/slave/test/build/venv 13:34:48 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 13:34:48 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 13:34:48 INFO - New python executable in /builds/slave/test/build/venv/bin/python 13:34:49 INFO - Installing distribute.............................................................................................................................................................................................done. 13:34:49 INFO - Installing pip...............done. 13:34:49 INFO - Return code: 0 13:34:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 13:34:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 13:34:49 INFO - Reading from file tmpfile_stdout 13:34:49 INFO - Output received: 13:34:49 INFO - pip 1.1 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.1-py2.7.egg (python 2.7) 13:34:49 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 13:34:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:34:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:34:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:34:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:34:49 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 0x14261f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15eea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1791a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1795090>, '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 0x1795d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x178ff90>, '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': 'bb9b54edd4a927dc735d112f000001d9-1506457791.22431-788204233', '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 13:34:49 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 13:34:49 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 13:34:49 INFO - Using env: {'DISPLAY': ':0', 13:34:49 INFO - 'HOME': '/home/cltbld', 13:34:49 INFO - 'LANG': 'en_US.UTF-8', 13:34:49 INFO - 'LANGUAGE': 'en_US:en', 13:34:49 INFO - 'LOGNAME': 'cltbld', 13:34:49 INFO - 'MAIL': '/var/mail/cltbld', 13:34:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:34:49 INFO - 'MOZ_NO_REMOTE': '1', 13:34:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:34:49 INFO - 'NO_EM_RESTART': '1', 13:34:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:34:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:34:49 INFO - 'PWD': '/builds/slave/test', 13:34:49 INFO - 'SHELL': '/bin/bash', 13:34:49 INFO - 'SHLVL': '1', 13:34:49 INFO - 'TERM': 'linux', 13:34:49 INFO - 'TMOUT': '86400', 13:34:49 INFO - 'USER': 'cltbld', 13:34:49 INFO - 'XDG_SESSION_COOKIE': 'bb9b54edd4a927dc735d112f000001d9-1506457791.22431-788204233', 13:34:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:34:49 INFO - '_': '/tools/buildbot/bin/python'} 13:34:51 INFO - Ignoring indexes: http://pypi.python.org/simple/ 13:34:51 INFO - Downloading/unpacking pip>=1.5 13:34:51 INFO - Running setup.py egg_info for package pip 13:34:51 INFO - warning: no files found matching 'pip/cacert.pem' 13:34:51 INFO - warning: no files found matching '*.html' under directory 'docs' 13:34:51 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 13:34:51 INFO - no previously-included directories found matching 'docs/_build/_sources' 13:34:51 INFO - Installing collected packages: pip 13:34:51 INFO - Found existing installation: pip 1.1 13:34:51 INFO - Uninstalling pip: 13:34:51 INFO - Successfully uninstalled pip 13:34:51 INFO - Running setup.py install for pip 13:34:51 INFO - warning: no files found matching 'pip/cacert.pem' 13:34:51 INFO - warning: no files found matching '*.html' under directory 'docs' 13:34:51 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 13:34:51 INFO - no previously-included directories found matching 'docs/_build/_sources' 13:34:51 INFO - Installing pip script to /builds/slave/test/build/venv/bin 13:34:51 INFO - Installing pip2.7 script to /builds/slave/test/build/venv/bin 13:34:51 INFO - Installing pip2 script to /builds/slave/test/build/venv/bin 13:34:51 INFO - Successfully installed pip 13:34:51 INFO - Cleaning up... 13:34:51 INFO - Return code: 0 13:34:51 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 13:34:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:34:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:34:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:34:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:34:51 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 0x14261f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15eea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1791a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1795090>, '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 0x1795d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x178ff90>, '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': 'bb9b54edd4a927dc735d112f000001d9-1506457791.22431-788204233', '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 13:34:51 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 13:34:51 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 13:34:51 INFO - Using env: {'DISPLAY': ':0', 13:34:51 INFO - 'HOME': '/home/cltbld', 13:34:51 INFO - 'LANG': 'en_US.UTF-8', 13:34:51 INFO - 'LANGUAGE': 'en_US:en', 13:34:51 INFO - 'LOGNAME': 'cltbld', 13:34:51 INFO - 'MAIL': '/var/mail/cltbld', 13:34:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:34:51 INFO - 'MOZ_NO_REMOTE': '1', 13:34:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:34:51 INFO - 'NO_EM_RESTART': '1', 13:34:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:34:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:34:51 INFO - 'PWD': '/builds/slave/test', 13:34:51 INFO - 'SHELL': '/bin/bash', 13:34:51 INFO - 'SHLVL': '1', 13:34:51 INFO - 'TERM': 'linux', 13:34:51 INFO - 'TMOUT': '86400', 13:34:51 INFO - 'USER': 'cltbld', 13:34:51 INFO - 'XDG_SESSION_COOKIE': 'bb9b54edd4a927dc735d112f000001d9-1506457791.22431-788204233', 13:34:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:34:51 INFO - '_': '/tools/buildbot/bin/python'} 13:34:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:34:51 INFO - Downloading/unpacking psutil>=3.1.1 13:34:51 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 13:34:51 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 13:34:51 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 13:34:51 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 13:34:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 13:34:52 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:34:52 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:34:52 INFO - Installing collected packages: psutil 13:34:52 INFO - Running setup.py install for psutil 13:34:52 INFO - building 'psutil._psutil_linux' extension 13:34:52 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 13:34:52 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 13:34:52 INFO - building 'psutil._psutil_posix' extension 13:34:52 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 13:34:52 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 13:34:53 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:34:53 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:34:53 INFO - Successfully installed psutil 13:34:53 INFO - Cleaning up... 13:34:53 INFO - Return code: 0 13:34:53 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 13:34: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')]} 13:34:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:34: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')]} 13:34:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:34: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', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14261f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15eea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1791a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1795090>, '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 0x1795d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x178ff90>, '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': 'bb9b54edd4a927dc735d112f000001d9-1506457791.22431-788204233', '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 13:34: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', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 13:34: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 mozsystemmonitor==0.3 13:34:53 INFO - Using env: {'DISPLAY': ':0', 13:34:53 INFO - 'HOME': '/home/cltbld', 13:34:53 INFO - 'LANG': 'en_US.UTF-8', 13:34:53 INFO - 'LANGUAGE': 'en_US:en', 13:34:53 INFO - 'LOGNAME': 'cltbld', 13:34:53 INFO - 'MAIL': '/var/mail/cltbld', 13:34:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:34:53 INFO - 'MOZ_NO_REMOTE': '1', 13:34:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:34:53 INFO - 'NO_EM_RESTART': '1', 13:34:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:34:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:34:53 INFO - 'PWD': '/builds/slave/test', 13:34:53 INFO - 'SHELL': '/bin/bash', 13:34:53 INFO - 'SHLVL': '1', 13:34:53 INFO - 'TERM': 'linux', 13:34:53 INFO - 'TMOUT': '86400', 13:34:53 INFO - 'USER': 'cltbld', 13:34:53 INFO - 'XDG_SESSION_COOKIE': 'bb9b54edd4a927dc735d112f000001d9-1506457791.22431-788204233', 13:34:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:34:53 INFO - '_': '/tools/buildbot/bin/python'} 13:34:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:34:53 INFO - Downloading/unpacking mozsystemmonitor==0.3 13:34: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 13:34: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 13:34: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 13:34: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 13:34:54 INFO - Downloading mozsystemmonitor-0.3.tar.gz 13:34:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 13:34:54 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 13:34:54 INFO - Installing collected packages: mozsystemmonitor 13:34:54 INFO - Running setup.py install for mozsystemmonitor 13:34:54 INFO - Successfully installed mozsystemmonitor 13:34:54 INFO - Cleaning up... 13:34:55 INFO - Return code: 0 13:34:55 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 13:34:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:34:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:34:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:34:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:34:55 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 0x14261f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15eea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1791a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1795090>, '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 0x1795d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x178ff90>, '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': 'bb9b54edd4a927dc735d112f000001d9-1506457791.22431-788204233', '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 13:34:55 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 13:34:55 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 13:34:55 INFO - Using env: {'DISPLAY': ':0', 13:34:55 INFO - 'HOME': '/home/cltbld', 13:34:55 INFO - 'LANG': 'en_US.UTF-8', 13:34:55 INFO - 'LANGUAGE': 'en_US:en', 13:34:55 INFO - 'LOGNAME': 'cltbld', 13:34:55 INFO - 'MAIL': '/var/mail/cltbld', 13:34:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:34:55 INFO - 'MOZ_NO_REMOTE': '1', 13:34:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:34:55 INFO - 'NO_EM_RESTART': '1', 13:34:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:34:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:34:55 INFO - 'PWD': '/builds/slave/test', 13:34:55 INFO - 'SHELL': '/bin/bash', 13:34:55 INFO - 'SHLVL': '1', 13:34:55 INFO - 'TERM': 'linux', 13:34:55 INFO - 'TMOUT': '86400', 13:34:55 INFO - 'USER': 'cltbld', 13:34:55 INFO - 'XDG_SESSION_COOKIE': 'bb9b54edd4a927dc735d112f000001d9-1506457791.22431-788204233', 13:34:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:34:55 INFO - '_': '/tools/buildbot/bin/python'} 13:34:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:34:55 INFO - Downloading/unpacking jsonschema==2.5.1 13:34:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:34:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:34:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:34:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:34:56 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 13:34:57 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 13:34: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 13:34: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 13:34: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 13:34: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 13:34:57 INFO - Downloading functools32-3.2.3-2.tar.gz 13:34:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 13:34:57 INFO - warning: no files found matching '*.txt' 13:34:57 INFO - no previously-included directories found matching 'build' 13:34:57 INFO - no previously-included directories found matching 'dist' 13:34:57 INFO - no previously-included directories found matching '.git*' 13:34:57 INFO - Installing collected packages: jsonschema, functools32 13:34:57 INFO - Running setup.py install for functools32 13:34:57 INFO - warning: no files found matching '*.txt' 13:34:57 INFO - no previously-included directories found matching 'build' 13:34:57 INFO - no previously-included directories found matching 'dist' 13:34:57 INFO - no previously-included directories found matching '.git*' 13:34:57 INFO - Successfully installed jsonschema functools32 13:34:57 INFO - Cleaning up... 13:34:57 INFO - Return code: 0 13:34:57 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 13:34: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')]} 13:34:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:34: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')]} 13:34:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:34: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', '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 0x14261f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15eea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1791a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1795090>, '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 0x1795d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x178ff90>, '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': 'bb9b54edd4a927dc735d112f000001d9-1506457791.22431-788204233', '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 13:34: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', 'functools32==3.2.3-2'] in /builds/slave/test/build 13:34: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 functools32==3.2.3-2 13:34:57 INFO - Using env: {'DISPLAY': ':0', 13:34:57 INFO - 'HOME': '/home/cltbld', 13:34:57 INFO - 'LANG': 'en_US.UTF-8', 13:34:57 INFO - 'LANGUAGE': 'en_US:en', 13:34:57 INFO - 'LOGNAME': 'cltbld', 13:34:57 INFO - 'MAIL': '/var/mail/cltbld', 13:34:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:34:57 INFO - 'MOZ_NO_REMOTE': '1', 13:34:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:34:57 INFO - 'NO_EM_RESTART': '1', 13:34:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:34:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:34:57 INFO - 'PWD': '/builds/slave/test', 13:34:57 INFO - 'SHELL': '/bin/bash', 13:34:57 INFO - 'SHLVL': '1', 13:34:57 INFO - 'TERM': 'linux', 13:34:57 INFO - 'TMOUT': '86400', 13:34:57 INFO - 'USER': 'cltbld', 13:34:57 INFO - 'XDG_SESSION_COOKIE': 'bb9b54edd4a927dc735d112f000001d9-1506457791.22431-788204233', 13:34:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:34:57 INFO - '_': '/tools/buildbot/bin/python'} 13:34:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:34:58 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 13:34:58 INFO - Cleaning up... 13:34:58 INFO - Return code: 0 13:34:58 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 13:34:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:34:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:34:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:34:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:34:58 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x14261f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15eea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1791a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1795090>, '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 0x1795d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x178ff90>, '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': 'bb9b54edd4a927dc735d112f000001d9-1506457791.22431-788204233', '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 13:34:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 13:34:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 13:34:58 INFO - Using env: {'DISPLAY': ':0', 13:34:58 INFO - 'HOME': '/home/cltbld', 13:34:58 INFO - 'LANG': 'en_US.UTF-8', 13:34:58 INFO - 'LANGUAGE': 'en_US:en', 13:34:58 INFO - 'LOGNAME': 'cltbld', 13:34:58 INFO - 'MAIL': '/var/mail/cltbld', 13:34:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:34:58 INFO - 'MOZ_NO_REMOTE': '1', 13:34:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:34:58 INFO - 'NO_EM_RESTART': '1', 13:34:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:34:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:34:58 INFO - 'PWD': '/builds/slave/test', 13:34:58 INFO - 'SHELL': '/bin/bash', 13:34:58 INFO - 'SHLVL': '1', 13:34:58 INFO - 'TERM': 'linux', 13:34:58 INFO - 'TMOUT': '86400', 13:34:58 INFO - 'USER': 'cltbld', 13:34:58 INFO - 'XDG_SESSION_COOKIE': 'bb9b54edd4a927dc735d112f000001d9-1506457791.22431-788204233', 13:34:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:34:58 INFO - '_': '/tools/buildbot/bin/python'} 13:34:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:34:58 INFO - Downloading/unpacking blobuploader==1.2.4 13:34:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:34:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:34:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:34:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:34:59 INFO - Downloading blobuploader-1.2.4.tar.gz 13:34:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 13:34:59 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 13:34:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:34:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:34:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:34:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:34:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 13:34:59 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 13:34:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:34:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:34:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:34:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:34:59 INFO - Downloading docopt-0.6.1.tar.gz 13:34:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 13:34:59 INFO - Installing collected packages: blobuploader, requests, docopt 13:34:59 INFO - Running setup.py install for blobuploader 13:35:00 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 13:35:00 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 13:35:00 INFO - Running setup.py install for requests 13:35:00 INFO - Running setup.py install for docopt 13:35:00 INFO - Successfully installed blobuploader requests docopt 13:35:00 INFO - Cleaning up... 13:35:00 INFO - Return code: 0 13:35:00 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:35: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')]} 13:35:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:35: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')]} 13:35:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:35:00 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 0x14261f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15eea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1791a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1795090>, '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 0x1795d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x178ff90>, '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': 'bb9b54edd4a927dc735d112f000001d9-1506457791.22431-788204233', '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 13:35:00 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 13:35:00 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 13:35:00 INFO - Using env: {'DISPLAY': ':0', 13:35:00 INFO - 'HOME': '/home/cltbld', 13:35:00 INFO - 'LANG': 'en_US.UTF-8', 13:35:00 INFO - 'LANGUAGE': 'en_US:en', 13:35:00 INFO - 'LOGNAME': 'cltbld', 13:35:00 INFO - 'MAIL': '/var/mail/cltbld', 13:35:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:35:00 INFO - 'MOZ_NO_REMOTE': '1', 13:35:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:35:00 INFO - 'NO_EM_RESTART': '1', 13:35:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:35:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:35:00 INFO - 'PWD': '/builds/slave/test', 13:35:00 INFO - 'SHELL': '/bin/bash', 13:35:00 INFO - 'SHLVL': '1', 13:35:00 INFO - 'TERM': 'linux', 13:35:00 INFO - 'TMOUT': '86400', 13:35:00 INFO - 'USER': 'cltbld', 13:35:00 INFO - 'XDG_SESSION_COOKIE': 'bb9b54edd4a927dc735d112f000001d9-1506457791.22431-788204233', 13:35:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:35:00 INFO - '_': '/tools/buildbot/bin/python'} 13:35:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:35:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:35:00 INFO - Running setup.py (path:/tmp/pip-q9ZyzR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:35:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:35:00 INFO - Running setup.py (path:/tmp/pip-Bm_CUY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:35:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:35:00 INFO - Running setup.py (path:/tmp/pip-KlKpLY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:35:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:35:00 INFO - Running setup.py (path:/tmp/pip-nUnCLZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:35:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:35:01 INFO - Running setup.py (path:/tmp/pip-CtUUYJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:35:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:35:01 INFO - Running setup.py (path:/tmp/pip-hs47uG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:35:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:35:01 INFO - Running setup.py (path:/tmp/pip-XlYADy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:35:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:35:01 INFO - Running setup.py (path:/tmp/pip-BtFcm2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:35:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:35:01 INFO - Running setup.py (path:/tmp/pip-iszTqQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:35:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:35:01 INFO - Running setup.py (path:/tmp/pip-UojohS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:35:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:35:01 INFO - Running setup.py (path:/tmp/pip-OIh7CM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:35:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:35:01 INFO - Running setup.py (path:/tmp/pip-iVFuHC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:35:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:35:01 INFO - Running setup.py (path:/tmp/pip-_PzsBK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:35:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:35:01 INFO - Running setup.py (path:/tmp/pip-KfUSrP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:35:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:35:01 INFO - Running setup.py (path:/tmp/pip-51EXpY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:35:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:35:01 INFO - Running setup.py (path:/tmp/pip-X7SkQU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:35:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:35:01 INFO - Running setup.py (path:/tmp/pip-FzSG12-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:35:01 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 13:35:01 INFO - Running setup.py install for manifestparser 13:35:02 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 13:35:02 INFO - Running setup.py install for mozcrash 13:35:02 INFO - Running setup.py install for mozdebug 13:35:02 INFO - Running setup.py install for mozdevice 13:35:02 INFO - Installing dm script to /builds/slave/test/build/venv/bin 13:35:02 INFO - Running setup.py install for mozfile 13:35:02 INFO - Running setup.py install for mozhttpd 13:35:02 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 13:35:02 INFO - Running setup.py install for mozinfo 13:35:02 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 13:35:02 INFO - Running setup.py install for mozInstall 13:35:02 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 13:35:02 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 13:35:02 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 13:35:02 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 13:35:02 INFO - Running setup.py install for mozleak 13:35:02 INFO - Running setup.py install for mozlog 13:35:02 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 13:35:02 INFO - Running setup.py install for moznetwork 13:35:03 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 13:35:03 INFO - Running setup.py install for mozprocess 13:35:03 INFO - Running setup.py install for mozprofile 13:35:03 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 13:35:03 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 13:35:03 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 13:35:03 INFO - Running setup.py install for mozrunner 13:35:03 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 13:35:03 INFO - Running setup.py install for mozscreenshot 13:35:03 INFO - Running setup.py install for moztest 13:35:03 INFO - Running setup.py install for mozversion 13:35:03 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 13:35:03 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 13:35:03 INFO - Cleaning up... 13:35:03 INFO - Return code: 0 13:35:03 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:35: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')]} 13:35:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:35: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')]} 13:35:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:35:03 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 0x14261f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15eea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1791a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1795090>, '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 0x1795d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x178ff90>, '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': 'bb9b54edd4a927dc735d112f000001d9-1506457791.22431-788204233', '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 13:35:03 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 13:35:03 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 13:35:03 INFO - Using env: {'DISPLAY': ':0', 13:35:03 INFO - 'HOME': '/home/cltbld', 13:35:03 INFO - 'LANG': 'en_US.UTF-8', 13:35:03 INFO - 'LANGUAGE': 'en_US:en', 13:35:03 INFO - 'LOGNAME': 'cltbld', 13:35:03 INFO - 'MAIL': '/var/mail/cltbld', 13:35:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:35:03 INFO - 'MOZ_NO_REMOTE': '1', 13:35:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:35:03 INFO - 'NO_EM_RESTART': '1', 13:35:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:35:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:35:03 INFO - 'PWD': '/builds/slave/test', 13:35:03 INFO - 'SHELL': '/bin/bash', 13:35:03 INFO - 'SHLVL': '1', 13:35:03 INFO - 'TERM': 'linux', 13:35:03 INFO - 'TMOUT': '86400', 13:35:03 INFO - 'USER': 'cltbld', 13:35:03 INFO - 'XDG_SESSION_COOKIE': 'bb9b54edd4a927dc735d112f000001d9-1506457791.22431-788204233', 13:35:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:35:03 INFO - '_': '/tools/buildbot/bin/python'} 13:35:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:35:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:35:03 INFO - Running setup.py (path:/tmp/pip-GvFt2_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:35:04 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)) 13:35:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:35:04 INFO - Running setup.py (path:/tmp/pip-DmZkQI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:35:04 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)) 13:35:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:35:04 INFO - Running setup.py (path:/tmp/pip-X8NvdP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:35:04 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)) 13:35:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:35:04 INFO - Running setup.py (path:/tmp/pip-MPruZ3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:35:04 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)) 13:35:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:35:04 INFO - Running setup.py (path:/tmp/pip-fuwdbi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:35:04 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)) 13:35:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:35:04 INFO - Running setup.py (path:/tmp/pip-noGGVD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:35:04 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)) 13:35:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:35:04 INFO - Running setup.py (path:/tmp/pip-WvFF32-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:35:04 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)) 13:35:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:35:04 INFO - Running setup.py (path:/tmp/pip-E0PxLW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:35:04 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)) 13:35:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:35:04 INFO - Running setup.py (path:/tmp/pip-_9hKhC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:35:04 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)) 13:35:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:35:04 INFO - Running setup.py (path:/tmp/pip-2oLI5l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:35:04 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)) 13:35:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:35:04 INFO - Running setup.py (path:/tmp/pip-wt_Qi1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:35:04 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)) 13:35:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:35:04 INFO - Running setup.py (path:/tmp/pip-W5Qnzp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:35:04 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)) 13:35:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:35:04 INFO - Running setup.py (path:/tmp/pip-gbM8q9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:35:04 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)) 13:35:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:35:04 INFO - Running setup.py (path:/tmp/pip-EquhZI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:35:04 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)) 13:35:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:35:04 INFO - Running setup.py (path:/tmp/pip-tOmGyg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:35:05 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)) 13:35:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:35:05 INFO - Running setup.py (path:/tmp/pip-EWMHS8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:35:05 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)) 13:35:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:35:05 INFO - Running setup.py (path:/tmp/pip-Z5Tk1A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:35:05 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)) 13:35:05 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)) 13:35:05 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)) 13:35:05 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)) 13:35:05 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)) 13:35:05 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)) 13:35:05 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)) 13:35:05 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 13:35:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:35:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:35:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:35:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:35:06 INFO - Downloading blessings-1.6.tar.gz 13:35:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 13:35:06 INFO - Installing collected packages: blessings 13:35:06 INFO - Running setup.py install for blessings 13:35:06 INFO - Successfully installed blessings 13:35:06 INFO - Cleaning up... 13:35:06 INFO - Return code: 0 13:35:06 INFO - Done creating virtualenv /builds/slave/test/build/venv. 13:35:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:35:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:35:06 INFO - Reading from file tmpfile_stdout 13:35:06 INFO - Current package versions: 13:35:06 INFO - argparse == 1.2.1 13:35:06 INFO - blessings == 1.6 13:35:06 INFO - blobuploader == 1.2.4 13:35:06 INFO - docopt == 0.6.1 13:35:06 INFO - functools32 == 3.2.3-2 13:35:06 INFO - jsonschema == 2.5.1 13:35:06 INFO - manifestparser == 1.1 13:35:06 INFO - mozInstall == 1.13 13:35:06 INFO - mozcrash == 1.0 13:35:06 INFO - mozdebug == 0.1 13:35:06 INFO - mozdevice == 0.51 13:35:06 INFO - mozfile == 1.2 13:35:06 INFO - mozhttpd == 0.7 13:35:06 INFO - mozinfo == 0.10 13:35:06 INFO - mozleak == 0.1 13:35:06 INFO - mozlog == 3.5 13:35:06 INFO - moznetwork == 0.27 13:35:06 INFO - mozprocess == 0.25 13:35:06 INFO - mozprofile == 0.28 13:35:06 INFO - mozrunner == 6.13 13:35:06 INFO - mozscreenshot == 0.1 13:35:06 INFO - mozsystemmonitor == 0.3 13:35:06 INFO - moztest == 0.8 13:35:06 INFO - mozversion == 1.4 13:35:06 INFO - psutil == 3.1.1 13:35:06 INFO - requests == 1.2.3 13:35:06 INFO - wsgiref == 0.1.2 13:35:06 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:35:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:35:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:35:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:35:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:35:06 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 0x14261f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15eea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1791a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1795090>, '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 0x1795d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x178ff90>, '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': 'bb9b54edd4a927dc735d112f000001d9-1506457791.22431-788204233', '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 13:35:06 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 13:35:06 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 13:35:06 INFO - Using env: {'DISPLAY': ':0', 13:35:06 INFO - 'HOME': '/home/cltbld', 13:35:06 INFO - 'LANG': 'en_US.UTF-8', 13:35:06 INFO - 'LANGUAGE': 'en_US:en', 13:35:06 INFO - 'LOGNAME': 'cltbld', 13:35:06 INFO - 'MAIL': '/var/mail/cltbld', 13:35:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:35:06 INFO - 'MOZ_NO_REMOTE': '1', 13:35:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:35:06 INFO - 'NO_EM_RESTART': '1', 13:35:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:35:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:35:06 INFO - 'PWD': '/builds/slave/test', 13:35:06 INFO - 'SHELL': '/bin/bash', 13:35:06 INFO - 'SHLVL': '1', 13:35:06 INFO - 'TERM': 'linux', 13:35:06 INFO - 'TMOUT': '86400', 13:35:06 INFO - 'USER': 'cltbld', 13:35:06 INFO - 'XDG_SESSION_COOKIE': 'bb9b54edd4a927dc735d112f000001d9-1506457791.22431-788204233', 13:35:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:35:06 INFO - '_': '/tools/buildbot/bin/python'} 13:35:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:35:06 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)) 13:35:06 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)) 13:35:06 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)) 13:35:06 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)) 13:35:06 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)) 13:35:06 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)) 13:35:06 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)) 13:35:06 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)) 13:35:06 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)) 13:35:06 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 13:35:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:35:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:35:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:35:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:35:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 13:35:08 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)) 13:35:08 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)) 13:35:08 INFO - Installing collected packages: simplejson 13:35:08 INFO - Running setup.py install for simplejson 13:35:08 INFO - building 'simplejson._speedups' extension 13:35:08 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 13:35:09 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 13:35:09 INFO - Successfully installed simplejson 13:35:09 INFO - Cleaning up... 13:35:09 INFO - Return code: 0 13:35:09 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 13:35:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:35:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:35:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:35:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:35:09 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 0x14261f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15eea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1791a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1795090>, '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 0x1795d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x178ff90>, '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': 'bb9b54edd4a927dc735d112f000001d9-1506457791.22431-788204233', '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 13:35:09 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 13:35:09 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 13:35:09 INFO - Using env: {'DISPLAY': ':0', 13:35:09 INFO - 'HOME': '/home/cltbld', 13:35:09 INFO - 'LANG': 'en_US.UTF-8', 13:35:09 INFO - 'LANGUAGE': 'en_US:en', 13:35:09 INFO - 'LOGNAME': 'cltbld', 13:35:09 INFO - 'MAIL': '/var/mail/cltbld', 13:35:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:35:09 INFO - 'MOZ_NO_REMOTE': '1', 13:35:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:35:09 INFO - 'NO_EM_RESTART': '1', 13:35:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:35:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:35:09 INFO - 'PWD': '/builds/slave/test', 13:35:09 INFO - 'SHELL': '/bin/bash', 13:35:09 INFO - 'SHLVL': '1', 13:35:09 INFO - 'TERM': 'linux', 13:35:09 INFO - 'TMOUT': '86400', 13:35:09 INFO - 'USER': 'cltbld', 13:35:09 INFO - 'XDG_SESSION_COOKIE': 'bb9b54edd4a927dc735d112f000001d9-1506457791.22431-788204233', 13:35:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:35:09 INFO - '_': '/tools/buildbot/bin/python'} 13:35:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:35:09 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 13:35:09 INFO - Cleaning up... 13:35:09 INFO - Return code: 0 13:35:09 INFO - Running post-action listener: _resource_record_post_action 13:35:09 INFO - Running post-action listener: _start_resource_monitoring 13:35:09 INFO - Starting resource monitoring. 13:35:09 INFO - [mozharness: 2017-09-26 20:35:09.457460Z] Finished create-virtualenv step (success) 13:35:09 INFO - [mozharness: 2017-09-26 20:35:09.458008Z] Running install step. 13:35:09 INFO - Running pre-action listener: _resource_record_pre_action 13:35:09 INFO - Running main action method: install 13:35:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:35:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:35:09 INFO - Reading from file tmpfile_stdout 13:35:09 INFO - Detecting whether we're running mozinstall >=1.0... 13:35:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 13:35:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 13:35:09 INFO - Reading from file tmpfile_stdout 13:35:09 INFO - Output received: 13:35:09 INFO - Usage: mozinstall [options] installer 13:35:09 INFO - Options: 13:35:09 INFO - -h, --help show this help message and exit 13:35:09 INFO - -d DEST, --destination=DEST 13:35:09 INFO - Directory to install application into. [default: 13:35:09 INFO - "/builds/slave/test"] 13:35:09 INFO - --app=APP Application being installed. [default: firefox] 13:35:09 INFO - mkdir: /builds/slave/test/build/application 13:35:09 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'] 13:35:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 13:35:24 INFO - Reading from file tmpfile_stdout 13:35:24 INFO - Output received: 13:35:24 INFO - /builds/slave/test/build/application/firefox/firefox 13:35:24 INFO - Running post-action listener: _resource_record_post_action 13:35:24 INFO - [mozharness: 2017-09-26 20:35:24.386127Z] Finished install step (success) 13:35:24 INFO - [mozharness: 2017-09-26 20:35:24.386472Z] Running setup-mitmproxy step. 13:35:24 INFO - Running pre-action listener: _resource_record_pre_action 13:35:24 INFO - Running main action method: setup_mitmproxy 13:35:24 INFO - Skipping: mitmproxy is not required 13:35:24 INFO - Running post-action listener: _resource_record_post_action 13:35:24 INFO - [mozharness: 2017-09-26 20:35:24.388091Z] Finished setup-mitmproxy step (success) 13:35:24 INFO - [mozharness: 2017-09-26 20:35:24.388404Z] Running run-tests step. 13:35:24 INFO - Running pre-action listener: _resource_record_pre_action 13:35:24 INFO - Running pre-action listener: _set_gcov_prefix 13:35:24 INFO - Running main action method: run_tests 13:35:24 WARNING - Try message not found. 13:35:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 13:35:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 13:35:24 INFO - Python 2.7.3 13:35:24 INFO - Return code: 0 13:35:24 INFO - grabbing minidump binary from tooltool 13:35:24 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')]} 13:35:24 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 0x1795090>, '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 0x1795d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x178ff90>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 13:35:24 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 13:35:24 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 13:35:24 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 13:35:24 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 13:35:24 INFO - Return code: 0 13:35:24 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 13:35:24 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 13:35:24 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 13:35:24 INFO - ENV: RUST_BACKTRACE is now full 13:35:24 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 13:35:24 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 13:35:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Sh6aKoENTCqMYpxxdeGTwQ/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-055', '--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 13:35:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Beta-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Sh6aKoENTCqMYpxxdeGTwQ/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-055 --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 13:35:24 INFO - Using env: {'DISPLAY': ':0', 13:35:24 INFO - 'HOME': '/home/cltbld', 13:35:24 INFO - 'LANG': 'en_US.UTF-8', 13:35:24 INFO - 'LANGUAGE': 'en_US:en', 13:35:24 INFO - 'LOGNAME': 'cltbld', 13:35:24 INFO - 'MAIL': '/var/mail/cltbld', 13:35:24 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 13:35:24 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 13:35:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:35:24 INFO - 'MOZ_NO_REMOTE': '1', 13:35:24 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 13:35:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:35:24 INFO - 'NO_EM_RESTART': '1', 13:35:24 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:35:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:35:24 INFO - 'PWD': '/builds/slave/test', 13:35:24 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 13:35:24 INFO - 'RUST_BACKTRACE': 'full', 13:35:24 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 13:35:24 INFO - 'SHELL': '/bin/bash', 13:35:24 INFO - 'SHLVL': '1', 13:35:24 INFO - 'TERM': 'linux', 13:35:24 INFO - 'TMOUT': '86400', 13:35:24 INFO - 'USER': 'cltbld', 13:35:24 INFO - 'XDG_SESSION_COOKIE': 'bb9b54edd4a927dc735d112f000001d9-1506457791.22431-788204233', 13:35:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:35:24 INFO - '_': '/tools/buildbot/bin/python'} 13:35:24 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Sh6aKoENTCqMYpxxdeGTwQ/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-055', '--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 13:35:24 INFO - mozversion application_buildid: 20170926191514 13:35:24 INFO - mozversion application_changeset: 18235244bde0c69589b794f3959762beab1f6d8d 13:35:24 INFO - mozversion application_display_name: Firefox 13:35:24 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 13:35:24 INFO - mozversion application_name: Firefox 13:35:24 INFO - mozversion application_remotingname: firefox 13:35:24 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 13:35:24 INFO - mozversion application_vendor: Mozilla 13:35:24 INFO - mozversion application_version: 57.0 13:35:24 INFO - mozversion platform_buildid: 20170926191514 13:35:24 INFO - mozversion platform_changeset: 18235244bde0c69589b794f3959762beab1f6d8d 13:35:24 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 13:35:24 INFO - mozversion platform_version: 57.0 13:35:24 INFO - using testdate: 1506458124 13:35:24 INFO - actual date: 1506458124 13:35:24 INFO - starting webserver on 'localhost:54356' 13:35:24 INFO - SUITE-START | Running 2 tests 13:35:24 INFO - TEST-START | dromaeo_css 13:35:24 INFO - Initialising browser for dromaeo_css test... 13:35:24 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:54356/getInfo.html -profile /tmp/tmp8YzYKw/profile 13:35:24 INFO - TEST-INFO | started process 12867 (/builds/slave/test/build/application/firefox/firefox http://localhost:54356/getInfo.html) 13:35:29 INFO - TEST-INFO | 12867: exit 0 13:35:30 INFO - Browser initialized. 13:35:30 INFO - Running cycle 1/1 for dromaeo_css test... 13:35:30 INFO - Using env: {'DISPLAY': ':0', 13:35:30 INFO - 'HOME': '/home/cltbld', 13:35:30 INFO - 'JSGC_DISABLE_POISONING': '1', 13:35:30 INFO - 'LANG': 'en_US.UTF-8', 13:35:30 INFO - 'LANGUAGE': 'en_US:en', 13:35:30 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 13:35:30 INFO - 'LOGNAME': 'cltbld', 13:35:30 INFO - 'MAIL': '/var/mail/cltbld', 13:35:30 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 13:35:30 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 13:35:30 INFO - 'MOZ_CRASHREPORTER': '1', 13:35:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:35:30 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 13:35:30 INFO - 'MOZ_NO_REMOTE': '1', 13:35:30 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 13:35:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:35:30 INFO - 'NO_EM_RESTART': '1', 13:35:30 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:35:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:35:30 INFO - 'PWD': '/builds/slave/test', 13:35:30 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 13:35:30 INFO - 'RUST_BACKTRACE': 'full', 13:35:30 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 13:35:30 INFO - 'SHELL': '/bin/bash', 13:35:30 INFO - 'SHLVL': '1', 13:35:30 INFO - 'TERM': 'linux', 13:35:30 INFO - 'TMOUT': '86400', 13:35:30 INFO - 'USER': 'cltbld', 13:35:30 INFO - 'XDG_SESSION_COOKIE': 'bb9b54edd4a927dc735d112f000001d9-1506457791.22431-788204233', 13:35:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:35:30 INFO - '_': '/tools/buildbot/bin/python'} 13:35:30 INFO - TEST-INFO | started process 13055 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp8YzYKw/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 13:35:30 INFO - PID 13055 | 13:35:30 INFO - PID 13055 | (/builds/slave/test/build/application/firefox/firefox:13103): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 13:35:30 INFO - PID 13055 | 13:35:41 INFO - PID 13055 | RSS: Main: 141455360 13:35:41 INFO - PID 13055 | 13:38:38 INFO - PID 13055 | Cycle 1(1): loaded http://localhost:54356/tests/dromaeo/cssquery-dojo.html (next: http://localhost:54356/tests/dromaeo/cssquery-ext.html) 13:38:39 INFO - PID 13055 | RSS: Main: 144949248 13:38:39 INFO - PID 13055 | 13:41:41 INFO - PID 13055 | Cycle 1(1): loaded http://localhost:54356/tests/dromaeo/cssquery-ext.html (next: http://localhost:54356/tests/dromaeo/cssquery-jquery.html) 13:41:41 INFO - PID 13055 | RSS: Main: 143593472 13:41:41 INFO - PID 13055 | 13:44:43 INFO - PID 13055 | Cycle 1(1): loaded http://localhost:54356/tests/dromaeo/cssquery-jquery.html (next: http://localhost:54356/tests/dromaeo/cssquery-mootools.html) 13:44:43 INFO - PID 13055 | RSS: Main: 144863232 13:44:43 INFO - PID 13055 | 13:47:45 INFO - PID 13055 | Cycle 1(1): loaded http://localhost:54356/tests/dromaeo/cssquery-mootools.html (next: http://localhost:54356/tests/dromaeo/cssquery-prototype.html) 13:47:45 INFO - PID 13055 | RSS: Main: 144580608 13:47:45 INFO - PID 13055 | 13:50:48 INFO - PID 13055 | Cycle 1(1): loaded http://localhost:54356/tests/dromaeo/cssquery-prototype.html (next: http://localhost:54356/tests/dromaeo/cssquery-yui.html) 13:50:49 INFO - PID 13055 | RSS: Main: 146305024 13:50:49 INFO - PID 13055 | 13:53:50 INFO - PID 13055 | Cycle 1(1): loaded http://localhost:54356/tests/dromaeo/cssquery-yui.html (next: http://localhost:54356/tests/dromaeo/cssquery-dojo.html) 13:53:50 INFO - PID 13055 | RSS: Main: 148480000 13:53:50 INFO - PID 13055 | 13:53:50 INFO - PID 13055 | __start_tp_report 13:53:50 INFO - PID 13055 | _x_x_mozilla_page_load 13:53:50 INFO - PID 13055 | _x_x_mozilla_page_load_details 13:53:50 INFO - PID 13055 | |i|pagename|runs| 13:53:51 INFO - PID 13055 | |0;dojo.html;3928.351821949378;3937.370020796672;3973.8211780469874;3977.463042489261;3992.7803970781597;6336.144620476234;6357.777477788279;6380.202474690664;6400.167978162838;6477.255115661706;6376.617402955826;6380.680965951696;6445.32324105968;6448.903266450995;6468.902966455507;5598.300212473441;5615.691136987464;5624.831255062334;5684.8294551163535;5717.285339332583;5611.551075913938;5655.745491452874;5663.3204015518195;5673.602847800656;5734.053881109612;5713.971430142843;5798.739056742435;5811.157382179603;5815.912761308563;5820.214271073414;5654.660720356792;5657;5669.518090962273;5735.369109397963;5749.195112684228;5529.30883639545;5563.527100196488;5608.298962629671;5633.746481408347;5661;6272;6314.87370252597;6330.3669633036325;6341.682915854189;6346.904796428057;7031.402330801888;7039.084918960553;7048.612326322051;7056.188538318108;7058.223595404502;6927.792166234971;7016.614086225256;7067.363937245621;7136.536125151901;7144.642767861586;6406.327335629739;6485.319041500622;6509.739610415625;6529.118568993173;6632.038354438628;7221;7239.058922340062;7244.818879528054;7250.564966102051;7254.818629534304;6840;6841.931580684229;6850.21222559412;6916.930830691729;6941;6933.237343892168;6981.89527157093;6985.476089293324;7064.08166938305;7080.079589653312;6906.551074180162;6921.584704917721;6921.965390173017;6940.167179938439;6944.791656250321;6843.349881761224;6861.725530978705;6935.479839012094;6948;6950.582965022115;4981.352424184833;5026.095302845523;5042.42012168598;5121.718305493234;5135.460776618476;4686.086213188396;4690.437147542249;4690.484046754854;4690.742009189527;4765.928511072337;6663.300353462817;6681.33186681328;6682.899756503656;6687.899681504781;6698.531102822755;6999.930000700029;7008.684609192598;7023.33278338557;7090.787276381717;7095.432365410858;6597.406233439014;6626.635535045522;6627.768028118992;6705.6982435790505;6707.396334329934;5827.650340979555;5841.912371314434;5846.473817356458;5851.590388672752;5891.234139561915;7255.310745479171;7264;7357.153927298429;7357.227491113463;7362.631868406558;6761.323867613396;6839.726410943506;6848.109745733223;7001.439884809203;7100.431965442752;7208.783736487913;7239.927600723925;7247.166575843846;7255.52839065459;7257.310555497219;6839.589624622538;6904.033435318959;6904.723811047502;6915.377616014382;6916;6988.126484189476;7070.116235470567;7102.857942841218;7104.893426598708;7109.680064397011;6712.899306510309;6721.529492935643;6723.731050757915;6801.693923773343;6815.965920170367;6623.867522649616;6709.161354830646;6733.663316834237;6754.054432379373;6826.249112597709;6779.18649762012;6785.89821152693;6787.830304242433;6791.185057793096;6792.456603471612;6783.626900520519;6918.377346038881;6926.792196234121;6946.548474349152;6961.234264231032;6614.966925165343;6639.136912201383;6663.167104111986;6736.7642132525125;6740.831479213059 13:53:51 INFO - PID 13055 | |1;ext.html;961.5480724059689;998.8052329795693;1007.8387458006721;1008.9697309080727;1032.1226957086478;45838.541614583846;46049.30926036112;46278;46325.53674463255;46520.76739616301;42864.57135428645;43141;43276.134477310436;43435.565644343544;43487.130257394834;8131.512109273463;8148.877766833502;8230.341572674171;8255.545944973024;8255.711050113217;8134.674613015502;8155.918440815605;8200.630971606262;8212.260896519312;8215.137410571893;8675.826483470326;8735.825283494327;8776;8784.824303513959;8803.29573634111;8664.350173736995;8673.69642062528;8711.08533603975;8734.51960142192;8746.693865714702;8489.915100848973;8571.742847714579;8575.485470871705;8576.44253123545;8583.399162058658;42213;42565.1486970262;42645.57354426447;42704.35943460851;42732;3807.0672685192303;3822.503074600312;3828.636279553438;3842.4044273137706;3842.6733727633186;33921.66078339209;34117.82941085303;34135.658643413495;34185.14537136567;34245.14387140317;5234.476552344773;5287.391949925769;5295.126304159809;5314.627976041678;5345;231049.84475077686;231859;232756;234010;234985.99999999828;53010.46989530132;53630;53745.46254537483;53747;53785.731071344395;56090.43909560934;56541.43458565362;56693;56772.716136419054;56851.71574142185;17086.658266834595;17529.474115776546;17538.649227015645;17554.38559650406;17559.473215803548;14348.928255358865;14362.138271703523;14391;14396.640083997983;14519.637009074857;15353.539393818204;15410.537683869501;15584.766228506582;15638.843611563967;15705.921470392803;5934.287885453773;5959.738786767482;5974.3726908674835;6063.484603808637;6163.137160797492;1095.2333366643381;1102.08526922654;1103.6302838549016;1106.4025426269884;1106.9667909962714;26248.86875565648;26318.73681263163;26422.47155056888;26548.203553893414;26609.600855987177;1188.8811118888043;1200.4297958469658;1218.7684339975376;1221.908356873238;1223.7124275795181;13669.179849209078;13683.24742139172;13883.097598656055;13940.86059139416;14187.503437379642;322930;325554;327726;329505;332378;66095.33904660988;66447.33552664412;66524.33475665278;66585.33414665888;66809.6659516709;1518.2257048905137;1527.88540859436;1539.2534620708948;1547.1877264436262;1567.2242240091;31198;31406.842965785938;31989.520157198127;32069.83965080253;32382;43688.126237475706;43738;43863.78068109639;43987.12025759531;44027.33958990554;275740;277271;277726;278093;278318;36715.81642091773;38313.233735325695;38929;38975;39011.2197756049;47860;49257.50742492673;49497.50502495073;49724.751376242886;49793;36371.63628363788;36607.08482287964;36867.446988295735;37027.81486092552;37538;35973.28053438969;36055.63944360523;36286.63713362833;36882.8155859219;37312.253754925296;42301.78849105735;42334.153316932876;42557.5744242566;43363;43452.56547434612;34275.314493709484;34708.82645586756;35079.298414031065;35197.472037919964;35415.291694165455;26056.74290713661;26630.46739065169;26773.062942796907;27284.727152729014;27326.45347093087 13:53:51 INFO - PID 13055 | |2;jquery.html;642.3343605546996;649.4147371745522;652.9257433614249;654.6123809286939;658.7760161545075;24466.633000505008;25209.369765755866;25323.999999999978;25348.11281605144;25369.74630253697;27292;27403.588946165823;27462;27505.724942750567;27591;6498.44763195129;6925.065116209323;6966.9303306966785;6982.7905162844945;6989.126359205099;6874.209465911409;6989.9301006990045;6990.440764738834;6990.510664253505;6995.545289556188;6827.897581536281;6960;6963.79108626742;6968.268331825161;7038.683259253346;6965.3731164195215;7004.64976751163;7005.159380874327;7006;7006.859862802716;6490.967545162292;6510.18622672166;6510.316416776218;6532.869342613121;6554.3117972613145;31308.843455782804;31819.363612727615;31824.204394890083;31845.14921658797;31867.52198717021;2262.637977923541;2317.8029867461287;2318.119114736406;2318.6869772580653;2321.5472982768365;20243.089060992144;20959.16163353464;20995.160193592237;20998.265060722802;21031.789682103135;2580.251726999168;2622.6721659792524;2669.7597216250438;2724.2508310214653;2733.3030077330354;146786;152100.2394988018;166648;171728;172877;16559.25483353252;17315;17421.39025134114;17490.21294041771;17698;27442.17673469799;27478;27521;27561.173164805088;27573.172804815888;11626.186166968231;11774.470148843322;11796.94101529487;11802.996745276576;11939.76120477603;10577.259591828652;10767.138628909668;10785.191110666732;10854.403007834488;10894.72763180911;9962.252831037556;10215.540300686487;10379.792404151875;10385.2211084169;10392.272540922062;2858.857057147134;2897.246715853893;2948.9557656635166;3026.3947210557976;3063.3566950940553;1058.9046985771317;1059.2902755154066;1059.502034043998;1063.186662203415;1079.1582565598846;21099.26152584683;21893.233736819453;22093;22142.22502212415;22469;1123.556195302867;1132.1282612388416;1132.9603463878889;1139.2310190621297;1149.0807354116673;11780.88219117815;11819.349935753617;11971.880281197251;12062.939685301693;12069.456874440672;610211;615150;615282;617565;703389;132029;134839.3258033723;135230;136002;139640;1239.0954603139758;1249.9187552809037;1281.833361662978;1283.550757234979;1286.671898665853;19067.332643357415;19520.707189391887;19557.022148892782;19577.51056223549;19834.801651983296;61203.38796611977;61407.38592614196;62339.6883015582;62634;62863.37136628575;74723;75073;77461.61269193619;77732;78745.60627196827;15862.920685396499;16225.269862855963;16263.837361626705;16360.509184724477;16411.507654770376;24161.879190603933;24262.514749704555;24565.263042108767;24790;24888.875555622108;18412.171452284412;18657.90671046636;18719.719204211677;18739;19470.707939381206;17903.820961790738;18005.549861253574;18256.17847196906;18278.360257390927;18328.358507452176;20314.695279570522;20396.184152634323;20453.693194601794;20507.4873128173;20567.074481648662;15753.291101900213;15829.366825327319;15855.52433426999;15860.603484912508;15876.047437153808;20471.8976405123;20540.589188215854;20585.691214632094;20736.68894966607;20802.27192048271 13:53:51 INFO - PID 13055 | |3;mootools.html;1419.6592817723745;1473.1529370611902;1477.0546850015985;1480.7926890235362;1487.1374602730418;17869.642607147867;18509.259629614815;18582.535436614075;18605.255789768395;18605.81394186058;17987.19057642406;18110.81889181108;18110.909445452755;18126.09369531525;18141.90929045356;3042.224232820633;3114.579531763217;3152.858121384543;3160.0361889623655;3162.5572419861123;3082.306481041759;3152.511360739089;3165.683431656839;3168.2871353945407;3168.762342824286;2902.840343781091;2912.097249852542;2913;2916.7520760735365;2928.03374886287;2934.295769015421;2939.4855900217485;2949.3806300676883;2950.247686839853;2951.217927249281;2570.4216551276;2598.493293807708;2602.1152808045354;2602.9479410411686;2607.3351295419734;17147.39984100563;17546.473605791718;17554.38559650406;17579.472615821545;17658.205380757896;9140.862887056699;9498.287628427826;9508.809823803485;9512.28657850664;9520.90479095207;5678.432156784289;5758.596898217126;5786.652800831964;5814.97092514539;6037.094435834616;1993.4418362858423;2046.9385918422472;2052.98973505133;2087.425957861585;2087.5407410369694;28535.57196642052;29346.85326573375;32648.183795405068;33178.66821331756;33266.83366583176;8340.249377556049;8345.332373410112;8532.530710810965;8658.696945606873;8836.11638836124;23982.40043998914;24077.51844963091;24098.277051688478;24111;24139.63790543143;9359;9748.512574371252;9767.51162441875;9783.706488805346;9814.969428209935;8364.205400486944;8380.832383352299;8451.830963380698;8453;8461.661533538712;6519.185101862267;6700.128983232246;6734.427573656294;6752.561083529653;6796.72813087471;2116.788321167902;2133.818625416826;2143.0463443767376;2143.5712857428575;2149.709789178441;1020.2959957629212;1025.8717660292464;1028.2699283508643;1034.0900007992918;1046.5813674530098;9928.950355248322;9971.750706232257;10007.849882251772;10157.39055656663;10162.796744065225;831.2560258568548;831.3058596072226;832.9250367466835;839.0602525171724;843.4433274039105;5504.779808807602;5675.829725108253;5736.282964629421;5740.827775166752;5827.038538641162;25272.873635631706;27350.316242094108;27566;27597.448051038868;27662;25585.48829023409;26949.844012478956;27050.323741906217;27256;27372.31569210746;12767.93616031914;12883.549075782303;12919.677008074874;12947;13269.402876870565;9943.30396872212;10140.29017968735;10197.184225261813;10222.795544089226;10237.74405639865;22513.172600989576;22989.310320690405;23291.650625240298;23369.883150584817;23502.647460288452;24142.63786043246;24438.14466493664;24491.142810001566;24738.25785226446;24924.62613060842;14071;14498.275086245856;14532.782008270096;14543.854561454673;14574.417023319373;16379.262933168275;16496.67006659884;16536.421225257058;16628.3348666052;16656.250468728693;11823.527058917547;11870.525178992744;11959.402029898296;12037.638870833889;12184.329861857683;12838.486460541473;13052.738945221232;13090.738185236432;13424.93287533556;13609.659758506117;10448.268621196443;10534.473276336306;10547.947260263649;10613.575456981634;10658.626948057092;8190.836183276182;8212.260896519341;8299.29455996247;8326.12575679569;8381.58092095405;8813.779655508408;8863.335249856158;8880.111988801069;8951.104889510996;8959.372843900865 13:53:51 INFO - PID 13055 | |4;prototype.html;583.9795607153751;605.184312907121;616.3312805605917;618.5113760129498;629.0532748213934;6234.407731265528;6320.810375688737;6320.905186422207;6329.873402531953;6354.396332348431;6315.589486683362;6317.52618553608;6364.904526432108;6375.617462952227;6394.360563943615;5103.3875934887865;5149.253358263049;5157.123289040854;5161.690298582097;5187.144121219994;4909.116359055369;5004.749762511878;5135.332406787113;5191.506806853343;5209.843704688866;4953.900921981576;4969.478204788481;5008.674436161656;5012.774425150877;5016.172331565305;4880.8047678092835;4939.185034469308;4954.2568614707725;4971.577415919651;4992.475790042048;4546.795394207235;4570.2687569988975;4579.58033009768;4600.95399046012;4620.3993480847275;6244.2819075805955;6270.717817698214;6282.900492413855;6294.402031806971;6320.778772742932;5939.13882487037;5943.910841337383;5955.255593050869;5976.073708575134;6025.096235564656;6663.267550436873;6698.765543205965;6730.932690673079;6776.966115169442;6794.694238759268;5171.405288391846;5176.327077479941;5183.481651834824;5187.170052791535;5206.609504287156;6745.494087943423;6861.416779573692;6920.273371296042;6982.822815618882;7059.788206353766;5287.894242115136;5325;5352.57179425645;5361.865953351197;5376.274202982626;5441;5449.237106805051;5452.91820622691;5466.72666366688;5472.972635136799;5969.701514924236;6000.729967151488;6025.15647809307;6038.18484504595;6049.304330002106;6700.631465269457;6724.93275067243;6764.594124352456;6766.594004359656;6817.590944543244;1817.8818376805466;1835.7613510243582;1841.1070630744077;1866.1415748755724;1867.346428749954;1291.8901893338984;1331.6537700197825;1344.28080976677;1355.8779709825965;1364.6315494816345;6244.406781355764;6306.180196574416;6374.808755737336;6414.711337989802;6438.903416448757;6728.596284222962;6760.256371799098;6825.317468253234;6839.461121247679;6888.517803753689;6253.812385628438;6319.273283572356;6362.554621176473;6368.267649220399;6427.389398007182;3603.000334814151;3606.422972324468;3622.5290712207243;3638.8362523686496;3667.706583473369;7155.855063189864;7159.176694680178;7170.892436613455;7194.704953108386;7210.567365958059;6955.339242771928;6972;6999.475039372068;7010.158780946217;7033.366996970195;7033.613151276729;7040.225575186725;7060.54106483077;7075.018994681394;7084.752033678797;6727.865442691021;6794;6805.149356330458;6812.14848143982;6830.419414349836;6713.496487763339;6782.152230971129;6803.897941530782;6809.829754256183;6869.587824730532;7001.614911179934;7008.5094043416475;7038.331358520933;7118.786436406916;7137.607431591312;5236.738163091906;5285.022270879899;5297.311349524537;5345.251664766858;5358.571314294925;6666.400023997863;6666.83332916681;6686.058134420839;6710.563813352116;6779.220389655055;6492.513061520499;6506.41442270198;6522.804315870531;6547.836304092436;6649.9692547655195;6483.578567393104;6524.401521627042;6580.539362244597;6635.502337324623;6645.966770166118;6433.292337842927;6482.319356467503;6521.934780652323;6581.44057755077;6644.800655980328;6624.171978502687;6642.634655094016;6731;6757.533500272463;6763.830904227434;6476.5466417350335;6479.384458476437;6516.543841931019;6518.185226846645;6531.216254049545 13:53:51 INFO - PID 13055 | |5;yui.html;889.0975659705396;921.5208091792268;924.5423515359894;1014.4876837197216;1035.9640359640362;21195.364139075835;21971.890140549276;21978.560428791414;21990.340289791333;21991.450213744665;19779.078879721274;20387.49031274219;20787.480312992182;20804.583908321823;21027.158913643438;1053.6101642392307;1078.1051727066556;1079.7192729890207;1080.5893760371048;1080.637986274599;1038.5015192707506;1080.4327727942853;1081.9296745711504;1090.0298734126634;1106.8837772033942;1158.044613194114;1162.848829652144;1162.9418529073555;1162.9767404651902;1163.0172504233908;1140.8402823604702;1144.4335054148166;1154.393943179829;1155.514683832788;1162.2677713040773;856.601680218695;856.7558245899951;857.4812238595684;857.6226460357423;859.6948083430354;21469.355919322446;22451.32646020622;22765.31704048881;22788.31635050951;22817.315480535446;23643;23805.28584142461;24216.757832421627;24240.636390454158;24327.756722432725;18870.245190192374;19059.90470047655;19091.23635054596;19164.71252931207;19277.132529036226;4082.408050832613;4145.316022856225;4146.398772178018;4149.149424368027;4149.3775933609895;168941;172535;174371;175572;176316;18097.457076287734;18150.273989040554;18238.17928193208;18254.726179107325;18326.450206493828;35077;35262.647373525935;35541.111472212884;35879;35914.46128308025;9646.469444180637;9773.46245956465;9776.266779991387;9798.069183427562;9808.313418060667;4972.57733092684;5018.5232402921665;5049.772760225798;5053.0399224147295;5070.391553013662;6400.967995159995;6410.134631824737;6447.871042579122;6491.642959637171;6494.9350506495275;1157.988420115805;1163.8719740828672;1165.5046605192758;1173.8180582009802;1216.8783121687761;709.3722055980494;709.5210732755472;714.5212707485997;731.8938753880764;746.4066067476369;13011.024173187048;13846.238456884766;14423.350949207312;14858.777118343234;14872.776908346383;772.737269328431;783.3380793229826;786.0488808541728;788.8106854354913;796.7171654062724;6349.6507692077375;6355.396237357536;6386.552941294065;6441.840468715676;6504.447121994589;161922;163106;164125;164604.17697911433;168825;139746;140474;144333;145597.27201363925;148385;120355;121271.36185914437;122019;122554.38722806507;124300.37849810693;12058.819117713067;12189;12274.877251227374;12381.75236495247;12482.126251162332;58885;59067.40932590619;59827.205183844555;60419.39580604138;60554;73464.63267683628;74563;74625.62687186529;74738.62630686811;76528.61735691286;17392.82607173912;17397.565060873072;17456.91271543634;17489.125543723017;17614.11929403499;19247.807521925162;19298.32455864038;19345.322913697953;19400.12699428501;19542;17789.822101778816;18065.909670451565;18099.909500452413;18122.72815907736;18138.365157219436;15245.3901843925;15381.538553843402;15425.768613470582;15527.922360388126;15555.066695998275;17425.47723568295;17635.470935871945;17819.910900445415;17841.197146128714;17876.55308617243;12557.623271301876;12847.614571562868;12935.159214651394;12951.093423460645;13013.414396352377;12036.75926481483;12143.392830358624;12191.695207619525;12330.136890417585;12372.319522425993 13:53:51 INFO - PID 13055 | __end_tp_report 13:53:51 INFO - PID 13055 | __start_cc_report 13:53:51 INFO - PID 13055 | _x_x_mozilla_cycle_collect,232 13:53:51 INFO - PID 13055 | __end_cc_report 13:53:51 INFO - PID 13055 | __startTimestamp1506459230993__endTimestamp 13:53:51 INFO - PID 13055 | 13:53:51 INFO - PID 13055 | ------- Summary: start ------- 13:53:51 INFO - PID 13055 | Number of tests: 6 13:53:51 INFO - PID 13055 | 13:53:51 INFO - PID 13055 | [#0] dojo.html Cycles:165 Average:6435.67 Median:6723.73 stddev:782.15 (11.6%) stddev-sans-first:759.41 13:53:51 INFO - PID 13055 | Values: 3928.4 3937.4 3973.8 3977.5 3992.8 6336.1 6357.8 6380.2 6400.2 6477.3 6376.6 6380.7 6445.3 6448.9 6468.9 5598.3 5615.7 5624.8 5684.8 5717.3 5611.6 5655.7 5663.3 5673.6 5734.1 5714.0 5798.7 5811.2 5815.9 5820.2 5654.7 5657.0 5669.5 5735.4 5749.2 5529.3 5563.5 5608.3 5633.7 5661.0 6272.0 6314.9 6330.4 6341.7 6346.9 7031.4 7039.1 7048.6 7056.2 7058.2 6927.8 7016.6 7067.4 7136.5 7144.6 6406.3 6485.3 6509.7 6529.1 6632.0 7221.0 7239.1 7244.8 7250.6 7254.8 6840.0 6841.9 6850.2 6916.9 6941.0 6933.2 6981.9 6985.5 7064.1 7080.1 6906.6 6921.6 6922.0 6940.2 6944.8 6843.3 6861.7 6935.5 6948.0 6950.6 4981.4 5026.1 5042.4 5121.7 5135.5 4686.1 4690.4 4690.5 4690.7 4765.9 6663.3 6681.3 6682.9 6687.9 6698.5 6999.9 7008.7 7023.3 7090.8 7095.4 6597.4 6626.6 6627.8 6705.7 6707.4 5827.7 5841.9 5846.5 5851.6 5891.2 7255.3 7264.0 7357.2 7357.2 7362.6 6761.3 6839.7 6848.1 7001.4 7100.4 7208.8 7239.9 7247.2 7255.5 7257.3 6839.6 6904.0 6904.7 6915.4 6916.0 6988.1 7070.1 7102.9 7104.9 7109.7 6712.9 6721.5 6723.7 6801.7 6816.0 6623.9 6709.2 6733.7 6754.1 6826.2 6779.2 6785.9 6787.8 6791.2 6792.5 6783.6 6918.4 6926.8 6946.5 6961.2 6615.0 6639.1 6663.2 6736.8 6740.8 13:53:51 INFO - PID 13055 | 13:53:51 INFO - PID 13055 | [#1] ext.html Cycles:180 Average:46447.49 Median:3825.57 stddev:73570.51 (1923.1%) stddev-sans-first:73697.62 13:53:51 INFO - PID 13055 | Values: 961.5 998.8 1007.8 1009.0 1032.1 45838.5 46049.3 46278.0 46325.5 46520.8 42864.6 43141.0 43276.1 43435.6 43487.1 8131.5 8148.9 8230.3 8255.5 8255.7 8134.7 8155.9 8200.6 8212.3 8215.1 8675.8 8735.8 8776.0 8784.8 8803.3 8664.4 8673.7 8711.1 8734.5 8746.7 8489.9 8571.7 8575.5 8576.4 8583.4 42213.0 42565.1 42645.6 42704.4 42732.0 3807.1 3822.5 3828.6 3842.4 3842.7 33921.7 34117.8 34135.7 34185.1 34245.1 5234.5 5287.4 5295.1 5314.6 5345.0 231049.8 231859.0 232756.0 234010.0 234986.0 53010.5 53630.0 53745.5 53747.0 53785.7 56090.4 56541.4 56693.0 56772.7 56851.7 17086.7 17529.5 17538.6 17554.4 17559.5 14348.9 14362.1 14391.0 14396.6 14519.6 15353.5 15410.5 15584.8 15638.8 15705.9 5934.3 5959.7 5974.4 6063.5 6163.1 1095.2 1102.1 1103.6 1106.4 1107.0 26248.9 26318.7 26422.5 26548.2 26609.6 1188.9 1200.4 1218.8 1221.9 1223.7 13669.2 13683.2 13883.1 13940.9 14187.5 322930.0 325554.0 327726.0 329505.0 332378.0 66095.3 66447.3 66524.3 66585.3 66809.7 1518.2 1527.9 1539.3 1547.2 1567.2 31198.0 31406.8 31989.5 32069.8 32382.0 43688.1 43738.0 43863.8 43987.1 44027.3 275740.0 277271.0 277726.0 278093.0 278318.0 36715.8 38313.2 38929.0 38975.0 39011.2 47860.0 49257.5 49497.5 49724.8 49793.0 36371.6 36607.1 36867.4 37027.8 37538.0 35973.3 36055.6 36286.6 36882.8 37312.3 42301.8 42334.2 42557.6 43363.0 43452.6 34275.3 34708.8 35079.3 35197.5 35415.3 26056.7 26630.5 26773.1 27284.7 27326.5 13:53:51 INFO - PID 13055 | 13:53:51 INFO - PID 13055 | [#2] jquery.html Cycles:180 Average:41275.67 Median:21993.12 stddev:106021.31 (482.1%) stddev-sans-first:106274.83 13:53:51 INFO - PID 13055 | Values: 642.3 649.4 652.9 654.6 658.8 24466.6 25209.4 25324.0 25348.1 25369.7 27292.0 27403.6 27462.0 27505.7 27591.0 6498.4 6925.1 6966.9 6982.8 6989.1 6874.2 6989.9 6990.4 6990.5 6995.5 6827.9 6960.0 6963.8 6968.3 7038.7 6965.4 7004.6 7005.2 7006.0 7006.9 6491.0 6510.2 6510.3 6532.9 6554.3 31308.8 31819.4 31824.2 31845.1 31867.5 2262.6 2317.8 2318.1 2318.7 2321.5 20243.1 20959.2 20995.2 20998.3 21031.8 2580.3 2622.7 2669.8 2724.3 2733.3 146786.0 152100.2 166648.0 171728.0 172877.0 16559.3 17315.0 17421.4 17490.2 17698.0 27442.2 27478.0 27521.0 27561.2 27573.2 11626.2 11774.5 11796.9 11803.0 11939.8 10577.3 10767.1 10785.2 10854.4 10894.7 9962.3 10215.5 10379.8 10385.2 10392.3 2858.9 2897.2 2949.0 3026.4 3063.4 1058.9 1059.3 1059.5 1063.2 1079.2 21099.3 21893.2 22093.0 22142.2 22469.0 1123.6 1132.1 1133.0 1139.2 1149.1 11780.9 11819.3 11971.9 12062.9 12069.5 610211.0 615150.0 615282.0 617565.0 703389.0 132029.0 134839.3 135230.0 136002.0 139640.0 1239.1 1249.9 1281.8 1283.6 1286.7 19067.3 19520.7 19557.0 19577.5 19834.8 61203.4 61407.4 62339.7 62634.0 62863.4 74723.0 75073.0 77461.6 77732.0 78745.6 15862.9 16225.3 16263.8 16360.5 16411.5 24161.9 24262.5 24565.3 24790.0 24888.9 18412.2 18657.9 18719.7 18739.0 19470.7 17903.8 18005.5 18256.2 18278.4 18328.4 20314.7 20396.2 20453.7 20507.5 20567.1 15753.3 15829.4 15855.5 15860.6 15876.0 20471.9 20540.6 20585.7 20736.7 20802.3 13:53:51 INFO - PID 13055 | 13:53:51 INFO - PID 13055 | [#3] mootools.html Cycles:180 Average:11242.50 Median:2600.30 stddev:8377.09 (322.2%) stddev-sans-first:8368.08 13:53:51 INFO - PID 13055 | Values: 1419.7 1473.2 1477.1 1480.8 1487.1 17869.6 18509.3 18582.5 18605.3 18605.8 17987.2 18110.8 18110.9 18126.1 18141.9 3042.2 3114.6 3152.9 3160.0 3162.6 3082.3 3152.5 3165.7 3168.3 3168.8 2902.8 2912.1 2913.0 2916.8 2928.0 2934.3 2939.5 2949.4 2950.2 2951.2 2570.4 2598.5 2602.1 2602.9 2607.3 17147.4 17546.5 17554.4 17579.5 17658.2 9140.9 9498.3 9508.8 9512.3 9520.9 5678.4 5758.6 5786.7 5815.0 6037.1 1993.4 2046.9 2053.0 2087.4 2087.5 28535.6 29346.9 32648.2 33178.7 33266.8 8340.2 8345.3 8532.5 8658.7 8836.1 23982.4 24077.5 24098.3 24111.0 24139.6 9359.0 9748.5 9767.5 9783.7 9815.0 8364.2 8380.8 8451.8 8453.0 8461.7 6519.2 6700.1 6734.4 6752.6 6796.7 2116.8 2133.8 2143.0 2143.6 2149.7 1020.3 1025.9 1028.3 1034.1 1046.6 9929.0 9971.8 10007.8 10157.4 10162.8 831.3 831.3 832.9 839.1 843.4 5504.8 5675.8 5736.3 5740.8 5827.0 25272.9 27350.3 27566.0 27597.4 27662.0 25585.5 26949.8 27050.3 27256.0 27372.3 12767.9 12883.5 12919.7 12947.0 13269.4 9943.3 10140.3 10197.2 10222.8 10237.7 22513.2 22989.3 23291.7 23369.9 23502.6 24142.6 24438.1 24491.1 24738.3 24924.6 14071.0 14498.3 14532.8 14543.9 14574.4 16379.3 16496.7 16536.4 16628.3 16656.3 11823.5 11870.5 11959.4 12037.6 12184.3 12838.5 13052.7 13090.7 13424.9 13609.7 10448.3 10534.5 10547.9 10613.6 10658.6 8190.8 8212.3 8299.3 8326.1 8381.6 8813.8 8863.3 8880.1 8951.1 8959.4 13:53:51 INFO - PID 13055 | 13:53:51 INFO - PID 13055 | [#4] prototype.html Cycles:180 Average:5715.59 Median:6358.48 stddev:1581.82 (24.9%) stddev-sans-first:1538.65 13:53:51 INFO - PID 13055 | Values: 584.0 605.2 616.3 618.5 629.1 6234.4 6320.8 6320.9 6329.9 6354.4 6315.6 6317.5 6364.9 6375.6 6394.4 5103.4 5149.3 5157.1 5161.7 5187.1 4909.1 5004.7 5135.3 5191.5 5209.8 4953.9 4969.5 5008.7 5012.8 5016.2 4880.8 4939.2 4954.3 4971.6 4992.5 4546.8 4570.3 4579.6 4601.0 4620.4 6244.3 6270.7 6282.9 6294.4 6320.8 5939.1 5943.9 5955.3 5976.1 6025.1 6663.3 6698.8 6730.9 6777.0 6794.7 5171.4 5176.3 5183.5 5187.2 5206.6 6745.5 6861.4 6920.3 6982.8 7059.8 5287.9 5325.0 5352.6 5361.9 5376.3 5441.0 5449.2 5452.9 5466.7 5473.0 5969.7 6000.7 6025.2 6038.2 6049.3 6700.6 6724.9 6764.6 6766.6 6817.6 1817.9 1835.8 1841.1 1866.1 1867.3 1291.9 1331.7 1344.3 1355.9 1364.6 6244.4 6306.2 6374.8 6414.7 6438.9 6728.6 6760.3 6825.3 6839.5 6888.5 6253.8 6319.3 6362.6 6368.3 6427.4 3603.0 3606.4 3622.5 3638.8 3667.7 7155.9 7159.2 7170.9 7194.7 7210.6 6955.3 6972.0 6999.5 7010.2 7033.4 7033.6 7040.2 7060.5 7075.0 7084.8 6727.9 6794.0 6805.1 6812.1 6830.4 6713.5 6782.2 6803.9 6809.8 6869.6 7001.6 7008.5 7038.3 7118.8 7137.6 5236.7 5285.0 5297.3 5345.3 5358.6 6666.4 6666.8 6686.1 6710.6 6779.2 6492.5 6506.4 6522.8 6547.8 6650.0 6483.6 6524.4 6580.5 6635.5 6646.0 6433.3 6482.3 6521.9 6581.4 6644.8 6624.2 6642.6 6731.0 6757.5 6763.8 6476.5 6479.4 6516.5 6518.2 6531.2 13:53:51 INFO - PID 13055 | 13:53:51 INFO - PID 13055 | [#5] yui.html Cycles:180 Average:30012.97 Median:18290.59 stddev:46045.12 (251.7%) stddev-sans-first:46122.37 13:53:51 INFO - PID 13055 | Values: 889.1 921.5 924.5 1014.5 1036.0 21195.4 21971.9 21978.6 21990.3 21991.5 19779.1 20387.5 20787.5 20804.6 21027.2 1053.6 1078.1 1079.7 1080.6 1080.6 1038.5 1080.4 1081.9 1090.0 1106.9 1158.0 1162.8 1162.9 1163.0 1163.0 1140.8 1144.4 1154.4 1155.5 1162.3 856.6 856.8 857.5 857.6 859.7 21469.4 22451.3 22765.3 22788.3 22817.3 23643.0 23805.3 24216.8 24240.6 24327.8 18870.2 19059.9 19091.2 19164.7 19277.1 4082.4 4145.3 4146.4 4149.1 4149.4 168941.0 172535.0 174371.0 175572.0 176316.0 18097.5 18150.3 18238.2 18254.7 18326.5 35077.0 35262.6 35541.1 35879.0 35914.5 9646.5 9773.5 9776.3 9798.1 9808.3 4972.6 5018.5 5049.8 5053.0 5070.4 6401.0 6410.1 6447.9 6491.6 6494.9 1158.0 1163.9 1165.5 1173.8 1216.9 709.4 709.5 714.5 731.9 746.4 13011.0 13846.2 14423.4 14858.8 14872.8 772.7 783.3 786.0 788.8 796.7 6349.7 6355.4 6386.6 6441.8 6504.4 161922.0 163106.0 164125.0 164604.2 168825.0 139746.0 140474.0 144333.0 145597.3 148385.0 120355.0 121271.4 122019.0 122554.4 124300.4 12058.8 12189.0 12274.9 12381.8 12482.1 58885.0 59067.4 59827.2 60419.4 60554.0 73464.6 74563.0 74625.6 74738.6 76528.6 17392.8 17397.6 17456.9 17489.1 17614.1 19247.8 19298.3 19345.3 19400.1 19542.0 17789.8 18065.9 18099.9 18122.7 18138.4 15245.4 15381.5 15425.8 15527.9 15555.1 17425.5 17635.5 17819.9 17841.2 17876.6 12557.6 12847.6 12935.2 12951.1 13013.4 12036.8 12143.4 12191.7 12330.1 12372.3 13:53:51 INFO - PID 13055 | -------- Summary: end -------- 13:53:51 INFO - PID 13055 | 13:53:51 INFO - TEST-INFO | 13055: exit 0 13:53:51 INFO - TEST-OK | dromaeo_css | took 1106828ms 13:53:51 INFO - TEST-START | kraken 13:53:51 INFO - Initialising browser for kraken test... 13:53:51 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:54356/getInfo.html -profile /tmp/tmpkDaCzn/profile 13:53:51 INFO - TEST-INFO | started process 13419 (/builds/slave/test/build/application/firefox/firefox http://localhost:54356/getInfo.html) 13:53:56 INFO - TEST-INFO | 13419: exit 0 13:53:56 INFO - Browser initialized. 13:53:56 INFO - Running cycle 1/1 for kraken test... 13:53:56 INFO - Using env: {'DISPLAY': ':0', 13:53:56 INFO - 'HOME': '/home/cltbld', 13:53:56 INFO - 'JSGC_DISABLE_POISONING': '1', 13:53:56 INFO - 'LANG': 'en_US.UTF-8', 13:53:56 INFO - 'LANGUAGE': 'en_US:en', 13:53:56 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 13:53:56 INFO - 'LOGNAME': 'cltbld', 13:53:56 INFO - 'MAIL': '/var/mail/cltbld', 13:53:56 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 13:53:56 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 13:53:56 INFO - 'MOZ_CRASHREPORTER': '1', 13:53:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:53:56 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 13:53:56 INFO - 'MOZ_NO_REMOTE': '1', 13:53:56 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 13:53:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:53:56 INFO - 'NO_EM_RESTART': '1', 13:53:56 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:53:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:53:56 INFO - 'PWD': '/builds/slave/test', 13:53:56 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 13:53:56 INFO - 'RUST_BACKTRACE': 'full', 13:53:56 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 13:53:56 INFO - 'SHELL': '/bin/bash', 13:53:56 INFO - 'SHLVL': '1', 13:53:56 INFO - 'TERM': 'linux', 13:53:56 INFO - 'TMOUT': '86400', 13:53:56 INFO - 'USER': 'cltbld', 13:53:56 INFO - 'XDG_SESSION_COOKIE': 'bb9b54edd4a927dc735d112f000001d9-1506457791.22431-788204233', 13:53:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:53:56 INFO - '_': '/tools/buildbot/bin/python'} 13:53:56 INFO - TEST-INFO | started process 13606 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpkDaCzn/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 13:53:57 INFO - PID 13606 | 13:53:57 INFO - PID 13606 | (/builds/slave/test/build/application/firefox/firefox:13655): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 13:53:57 INFO - PID 13606 | 13:54:07 INFO - PID 13606 | RSS: Main: 142807040 13:54:07 INFO - PID 13606 | 13:54:09 INFO - PID 13606 | Cycle 1(1): loaded http://localhost:54356/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:54356/tests/kraken/driver.html?testName=audio-beat-detection) 13:54:10 INFO - PID 13606 | RSS: Main: 148557824 13:54:10 INFO - PID 13606 | 13:54:13 INFO - PID 13606 | Cycle 1(1): loaded http://localhost:54356/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:54356/tests/kraken/driver.html?testName=audio-dft) 13:54:13 INFO - PID 13606 | RSS: Main: 149626880 13:54:13 INFO - PID 13606 | 13:54:16 INFO - PID 13606 | Cycle 1(1): loaded http://localhost:54356/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:54356/tests/kraken/driver.html?testName=audio-fft) 13:54:17 INFO - PID 13606 | RSS: Main: 151089152 13:54:17 INFO - PID 13606 | 13:54:19 INFO - PID 13606 | Cycle 1(1): loaded http://localhost:54356/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:54356/tests/kraken/driver.html?testName=audio-oscillator) 13:54:19 INFO - PID 13606 | RSS: Main: 150695936 13:54:19 INFO - PID 13606 | 13:54:21 INFO - PID 13606 | Cycle 1(1): loaded http://localhost:54356/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:54356/tests/kraken/driver.html?testName=imaging-gaussian-blur) 13:54:22 INFO - PID 13606 | RSS: Main: 150548480 13:54:22 INFO - PID 13606 | 13:54:25 INFO - PID 13606 | Cycle 1(1): loaded http://localhost:54356/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:54356/tests/kraken/driver.html?testName=imaging-darkroom) 13:54:26 INFO - PID 13606 | RSS: Main: 150441984 13:54:26 INFO - PID 13606 | 13:54:29 INFO - PID 13606 | Cycle 1(1): loaded http://localhost:54356/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:54356/tests/kraken/driver.html?testName=imaging-desaturate) 13:54:30 INFO - PID 13606 | RSS: Main: 153112576 13:54:30 INFO - PID 13606 | 13:54:33 INFO - PID 13606 | Cycle 1(1): loaded http://localhost:54356/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:54356/tests/kraken/driver.html?testName=json-parse-financial) 13:54:33 INFO - PID 13606 | RSS: Main: 153735168 13:54:33 INFO - PID 13606 | 13:54:35 INFO - PID 13606 | Cycle 1(1): loaded http://localhost:54356/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:54356/tests/kraken/driver.html?testName=json-stringify-tinderbox) 13:54:35 INFO - PID 13606 | RSS: Main: 154050560 13:54:35 INFO - PID 13606 | 13:54:37 INFO - PID 13606 | Cycle 1(1): loaded http://localhost:54356/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:54356/tests/kraken/driver.html?testName=stanford-crypto-aes) 13:54:38 INFO - PID 13606 | RSS: Main: 153735168 13:54:38 INFO - PID 13606 | 13:54:39 INFO - PID 13606 | Cycle 1(1): loaded http://localhost:54356/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:54356/tests/kraken/driver.html?testName=stanford-crypto-ccm) 13:54:40 INFO - PID 13606 | RSS: Main: 150388736 13:54:40 INFO - PID 13606 | 13:54:43 INFO - PID 13606 | Cycle 1(1): loaded http://localhost:54356/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:54356/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 13:54:43 INFO - PID 13606 | RSS: Main: 150294528 13:54:43 INFO - PID 13606 | 13:54:46 INFO - PID 13606 | Cycle 1(1): loaded http://localhost:54356/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:54356/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 13:54:46 INFO - PID 13606 | RSS: Main: 150511616 13:54:46 INFO - PID 13606 | 13:54:48 INFO - PID 13606 | Cycle 1(1): loaded http://localhost:54356/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:54356/tests/kraken/driver.html?testName=ai-astar) 13:54:48 INFO - PID 13606 | RSS: Main: 152211456 13:54:48 INFO - PID 13606 | 13:54:48 INFO - PID 13606 | __start_tp_report 13:54:48 INFO - PID 13606 | _x_x_mozilla_page_load 13:54:48 INFO - PID 13606 | _x_x_mozilla_page_load_details 13:54:48 INFO - PID 13606 | |i|pagename|runs| 13:54:48 INFO - PID 13606 | |0;ai-astar;103;104;104;106;105;107;108;105;104;105 13:54:48 INFO - PID 13606 | |1;audio-beat-detection;112;110;122;116;115;110;112;120;111;115 13:54:48 INFO - PID 13606 | |2;audio-dft;162;162;162;161;160;163;161;162;164;162 13:54:48 INFO - PID 13606 | |3;audio-fft;72;73;72;73;72;73;73;73;74;74 13:54:48 INFO - PID 13606 | |4;audio-oscillator;78;77;77;76;76;77;77;78;78;78 13:54:48 INFO - PID 13606 | |5;imaging-gaussian-blur;113;113;113;114;114;113;113;114;118;113 13:54:48 INFO - PID 13606 | |6;imaging-darkroom;148;149;150;149;148;148;149;148;148;150 13:54:48 INFO - PID 13606 | |7;imaging-desaturate;93;95;94;94;95;95;94;94;94;93 13:54:48 INFO - PID 13606 | |8;json-parse-financial;43;45;44;43;45;45;48;43;43;42 13:54:48 INFO - PID 13606 | |9;json-stringify-tinderbox;38;39;39;38;39;39;38;38;39;38 13:54:48 INFO - PID 13606 | |10;stanford-crypto-aes;70;75;68;71;69;72;69;69;68;71 13:54:48 INFO - PID 13606 | |11;stanford-crypto-ccm;102;101;107;105;105;106;112;117;103;103 13:54:48 INFO - PID 13606 | |12;stanford-crypto-pbkdf2;152;154;156;149;151;149;151;148;150;149 13:54:48 INFO - PID 13606 | |13;stanford-crypto-sha256-iterative;56;60;57;60;61;57;60;57;59;60 13:54:48 INFO - PID 13606 | __end_tp_report 13:54:48 INFO - PID 13606 | __start_cc_report 13:54:48 INFO - PID 13606 | _x_x_mozilla_cycle_collect,691 13:54:48 INFO - PID 13606 | __end_cc_report 13:54:48 INFO - PID 13606 | __startTimestamp1506459288780__endTimestamp 13:54:48 INFO - PID 13606 | 13:54:48 INFO - PID 13606 | ------- Summary: start ------- 13:54:48 INFO - PID 13606 | Number of tests: 14 13:54:48 INFO - PID 13606 | 13:54:48 INFO - PID 13606 | [#0] ai-astar Cycles:10 Average:105.10 Median:105.00 stddev:1.52 (1.5%) stddev-sans-first:1.41 13:54:48 INFO - PID 13606 | Values: 103.0 104.0 104.0 106.0 105.0 107.0 108.0 105.0 104.0 105.0 13:54:48 INFO - PID 13606 | 13:54:48 INFO - PID 13606 | [#1] audio-beat-detection Cycles:10 Average:114.30 Median:115.00 stddev:4.14 (3.6%) stddev-sans-first:4.30 13:54:48 INFO - PID 13606 | Values: 112.0 110.0 122.0 116.0 115.0 110.0 112.0 120.0 111.0 115.0 13:54:48 INFO - PID 13606 | 13:54:48 INFO - PID 13606 | [#2] audio-dft Cycles:10 Average:161.90 Median:162.00 stddev:1.10 (0.7%) stddev-sans-first:1.17 13:54:48 INFO - PID 13606 | Values: 162.0 162.0 162.0 161.0 160.0 163.0 161.0 162.0 164.0 162.0 13:54:48 INFO - PID 13606 | 13:54:48 INFO - PID 13606 | [#3] audio-fft Cycles:10 Average:72.90 Median:73.00 stddev:0.74 (1.0%) stddev-sans-first:0.71 13:54:48 INFO - PID 13606 | Values: 72.0 73.0 72.0 73.0 72.0 73.0 73.0 73.0 74.0 74.0 13:54:48 INFO - PID 13606 | 13:54:48 INFO - PID 13606 | [#4] audio-oscillator Cycles:10 Average:77.20 Median:77.50 stddev:0.79 (1.0%) stddev-sans-first:0.78 13:54:48 INFO - PID 13606 | Values: 78.0 77.0 77.0 76.0 76.0 77.0 77.0 78.0 78.0 78.0 13:54:48 INFO - PID 13606 | 13:54:48 INFO - PID 13606 | [#5] imaging-gaussian-blur Cycles:10 Average:113.80 Median:113.50 stddev:1.55 (1.4%) stddev-sans-first:1.62 13:54:48 INFO - PID 13606 | Values: 113.0 113.0 113.0 114.0 114.0 113.0 113.0 114.0 118.0 113.0 13:54:48 INFO - PID 13606 | 13:54:48 INFO - PID 13606 | [#6] imaging-darkroom Cycles:10 Average:148.70 Median:149.00 stddev:0.82 (0.6%) stddev-sans-first:0.83 13:54:48 INFO - PID 13606 | Values: 148.0 149.0 150.0 149.0 148.0 148.0 149.0 148.0 148.0 150.0 13:54:48 INFO - PID 13606 | 13:54:48 INFO - PID 13606 | [#7] imaging-desaturate Cycles:10 Average:94.10 Median:94.00 stddev:0.74 (0.8%) stddev-sans-first:0.67 13:54:48 INFO - PID 13606 | Values: 93.0 95.0 94.0 94.0 95.0 95.0 94.0 94.0 94.0 93.0 13:54:48 INFO - PID 13606 | 13:54:48 INFO - PID 13606 | [#8] json-parse-financial Cycles:10 Average:44.10 Median:44.50 stddev:1.73 (3.9%) stddev-sans-first:1.79 13:54:48 INFO - PID 13606 | Values: 43.0 45.0 44.0 43.0 45.0 45.0 48.0 43.0 43.0 42.0 13:54:48 INFO - PID 13606 | 13:54:48 INFO - PID 13606 | [#9] json-stringify-tinderbox Cycles:10 Average:38.50 Median:39.00 stddev:0.53 (1.4%) stddev-sans-first:0.53 13:54:48 INFO - PID 13606 | Values: 38.0 39.0 39.0 38.0 39.0 39.0 38.0 38.0 39.0 38.0 13:54:48 INFO - PID 13606 | 13:54:48 INFO - PID 13606 | [#10] stanford-crypto-aes Cycles:10 Average:70.20 Median:70.50 stddev:2.15 (3.0%) stddev-sans-first:2.28 13:54:48 INFO - PID 13606 | Values: 70.0 75.0 68.0 71.0 69.0 72.0 69.0 69.0 68.0 71.0 13:54:48 INFO - PID 13606 | 13:54:48 INFO - PID 13606 | [#11] stanford-crypto-ccm Cycles:10 Average:106.10 Median:105.50 stddev:4.93 (4.7%) stddev-sans-first:5.00 13:54:48 INFO - PID 13606 | Values: 102.0 101.0 107.0 105.0 105.0 106.0 112.0 117.0 103.0 103.0 13:54:48 INFO - PID 13606 | 13:54:48 INFO - PID 13606 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:150.90 Median:151.00 stddev:2.51 (1.7%) stddev-sans-first:2.64 13:54:48 INFO - PID 13606 | Values: 152.0 154.0 156.0 149.0 151.0 149.0 151.0 148.0 150.0 149.0 13:54:48 INFO - PID 13606 | 13:54:48 INFO - PID 13606 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:58.70 Median:60.00 stddev:1.77 (2.9%) stddev-sans-first:1.58 13:54:48 INFO - PID 13606 | Values: 56.0 60.0 57.0 60.0 61.0 57.0 60.0 57.0 59.0 60.0 13:54:48 INFO - PID 13606 | -------- Summary: end -------- 13:54:48 INFO - PID 13606 | 13:54:49 INFO - PID 13606 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 13:54:49 INFO - TEST-INFO | 13606: exit 0 13:54:49 INFO - TEST-OK | kraken | took 57733ms 13:54:49 INFO - SUITE-END | took 1164s 13:54:49 INFO - Completed test suite (00:19:24) 13:54:49 INFO - javascript benchmark 13:54:49 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 9403.92740247133, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3928.351821949378, 3937.370020796672, 3973.8211780469874, 3977.463042489261, 3992.7803970781597, 6336.144620476234, 6357.777477788279, 6380.202474690664, 6400.167978162838, 6477.255115661706, 6376.617402955826, 6380.680965951696, 6445.32324105968, 6448.903266450995, 6468.902966455507, 5598.300212473441, 5615.691136987464, 5624.831255062334, 5684.8294551163535, 5717.285339332583, 5611.551075913938, 5655.745491452874, 5663.3204015518195, 5673.602847800656, 5734.053881109612, 5713.971430142843, 5798.739056742435, 5811.157382179603, 5815.912761308563, 5820.214271073414, 5654.660720356792, 5657.0, 5669.518090962273, 5735.369109397963, 5749.195112684228, 5529.30883639545, 5563.527100196488, 5608.298962629671, 5633.746481408347, 5661.0, 6272.0, 6314.87370252597, 6330.3669633036325, 6341.682915854189, 6346.904796428057, 7031.402330801888, 7039.084918960553, 7048.612326322051, 7056.188538318108, 7058.223595404502, 6927.792166234971, 7016.614086225256, 7067.363937245621, 7136.536125151901, 7144.642767861586, 6406.327335629739, 6485.319041500622, 6509.739610415625, 6529.118568993173, 6632.038354438628, 7221.0, 7239.058922340062, 7244.818879528054, 7250.564966102051, 7254.818629534304, 6840.0, 6841.931580684229, 6850.21222559412, 6916.930830691729, 6941.0, 6933.237343892168, 6981.89527157093, 6985.476089293324, 7064.08166938305, 7080.079589653312, 6906.551074180162, 6921.584704917721, 6921.965390173017, 6940.167179938439, 6944.791656250321, 6843.349881761224, 6861.725530978705, 6935.479839012094, 6948.0, 6950.582965022115, 4981.352424184833, 5026.095302845523, 5042.42012168598, 5121.718305493234, 5135.460776618476, 4686.086213188396, 4690.437147542249, 4690.484046754854, 4690.742009189527, 4765.928511072337, 6663.300353462817, 6681.33186681328, 6682.899756503656, 6687.899681504781, 6698.531102822755, 6999.930000700029, 7008.684609192598, 7023.33278338557, 7090.787276381717, 7095.432365410858, 6597.406233439014, 6626.635535045522, 6627.768028118992, 6705.6982435790505, 6707.396334329934, 5827.650340979555, 5841.912371314434, 5846.473817356458, 5851.590388672752, 5891.234139561915, 7255.310745479171, 7264.0, 7357.153927298429, 7357.227491113463, 7362.631868406558, 6761.323867613396, 6839.726410943506, 6848.109745733223, 7001.439884809203, 7100.431965442752, 7208.783736487913, 7239.927600723925, 7247.166575843846, 7255.52839065459, 7257.310555497219, 6839.589624622538, 6904.033435318959, 6904.723811047502, 6915.377616014382, 6916.0, 6988.126484189476, 7070.116235470567, 7102.857942841218, 7104.893426598708, 7109.680064397011, 6712.899306510309, 6721.529492935643, 6723.731050757915, 6801.693923773343, 6815.965920170367, 6623.867522649616, 6709.161354830646, 6733.663316834237, 6754.054432379373, 6826.249112597709, 6779.18649762012, 6785.89821152693, 6787.830304242433, 6791.185057793096, 6792.456603471612, 6783.626900520519, 6918.377346038881, 6926.792196234121, 6946.548474349152, 6961.234264231032, 6614.966925165343, 6639.136912201383, 6663.167104111986, 6736.7642132525125, 6740.831479213059], "value": 6381.442294386136, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [961.5480724059689, 998.8052329795693, 1007.8387458006721, 1008.9697309080727, 1032.1226957086478, 45838.541614583846, 46049.30926036112, 46278.0, 46325.53674463255, 46520.76739616301, 42864.57135428645, 43141.0, 43276.134477310436, 43435.565644343544, 43487.130257394834, 8131.512109273463, 8148.877766833502, 8230.341572674171, 8255.545944973024, 8255.711050113217, 8134.674613015502, 8155.918440815605, 8200.630971606262, 8212.260896519312, 8215.137410571893, 8675.826483470326, 8735.825283494327, 8776.0, 8784.824303513959, 8803.29573634111, 8664.350173736995, 8673.69642062528, 8711.08533603975, 8734.51960142192, 8746.693865714702, 8489.915100848973, 8571.742847714579, 8575.485470871705, 8576.44253123545, 8583.399162058658, 42213.0, 42565.1486970262, 42645.57354426447, 42704.35943460851, 42732.0, 3807.0672685192303, 3822.503074600312, 3828.636279553438, 3842.4044273137706, 3842.6733727633186, 33921.66078339209, 34117.82941085303, 34135.658643413495, 34185.14537136567, 34245.14387140317, 5234.476552344773, 5287.391949925769, 5295.126304159809, 5314.627976041678, 5345.0, 231049.84475077686, 231859.0, 232756.0, 234010.0, 234985.99999999828, 53010.46989530132, 53630.0, 53745.46254537483, 53747.0, 53785.731071344395, 56090.43909560934, 56541.43458565362, 56693.0, 56772.716136419054, 56851.71574142185, 17086.658266834595, 17529.474115776546, 17538.649227015645, 17554.38559650406, 17559.473215803548, 14348.928255358865, 14362.138271703523, 14391.0, 14396.640083997983, 14519.637009074857, 15353.539393818204, 15410.537683869501, 15584.766228506582, 15638.843611563967, 15705.921470392803, 5934.287885453773, 5959.738786767482, 5974.3726908674835, 6063.484603808637, 6163.137160797492, 1095.2333366643381, 1102.08526922654, 1103.6302838549016, 1106.4025426269884, 1106.9667909962714, 26248.86875565648, 26318.73681263163, 26422.47155056888, 26548.203553893414, 26609.600855987177, 1188.8811118888043, 1200.4297958469658, 1218.7684339975376, 1221.908356873238, 1223.7124275795181, 13669.179849209078, 13683.24742139172, 13883.097598656055, 13940.86059139416, 14187.503437379642, 322930.0, 325554.0, 327726.0, 329505.0, 332378.0, 66095.33904660988, 66447.33552664412, 66524.33475665278, 66585.33414665888, 66809.6659516709, 1518.2257048905137, 1527.88540859436, 1539.2534620708948, 1547.1877264436262, 1567.2242240091, 31198.0, 31406.842965785938, 31989.520157198127, 32069.83965080253, 32382.0, 43688.126237475706, 43738.0, 43863.78068109639, 43987.12025759531, 44027.33958990554, 275740.0, 277271.0, 277726.0, 278093.0, 278318.0, 36715.81642091773, 38313.233735325695, 38929.0, 38975.0, 39011.2197756049, 47860.0, 49257.50742492673, 49497.50502495073, 49724.751376242886, 49793.0, 36371.63628363788, 36607.08482287964, 36867.446988295735, 37027.81486092552, 37538.0, 35973.28053438969, 36055.63944360523, 36286.63713362833, 36882.8155859219, 37312.253754925296, 42301.78849105735, 42334.153316932876, 42557.5744242566, 43363.0, 43452.56547434612, 34275.314493709484, 34708.82645586756, 35079.298414031065, 35197.472037919964, 35415.291694165455, 26056.74290713661, 26630.46739065169, 26773.062942796907, 27284.727152729014, 27326.45347093087], "value": 19505.516927993267, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [642.3343605546996, 649.4147371745522, 652.9257433614249, 654.6123809286939, 658.7760161545075, 24466.633000505008, 25209.369765755866, 25323.999999999978, 25348.11281605144, 25369.74630253697, 27292.0, 27403.588946165823, 27462.0, 27505.724942750567, 27591.0, 6498.44763195129, 6925.065116209323, 6966.9303306966785, 6982.7905162844945, 6989.126359205099, 6874.209465911409, 6989.9301006990045, 6990.440764738834, 6990.510664253505, 6995.545289556188, 6827.897581536281, 6960.0, 6963.79108626742, 6968.268331825161, 7038.683259253346, 6965.3731164195215, 7004.64976751163, 7005.159380874327, 7006.0, 7006.859862802716, 6490.967545162292, 6510.18622672166, 6510.316416776218, 6532.869342613121, 6554.3117972613145, 31308.843455782804, 31819.363612727615, 31824.204394890083, 31845.14921658797, 31867.52198717021, 2262.637977923541, 2317.8029867461287, 2318.119114736406, 2318.6869772580653, 2321.5472982768365, 20243.089060992144, 20959.16163353464, 20995.160193592237, 20998.265060722802, 21031.789682103135, 2580.251726999168, 2622.6721659792524, 2669.7597216250438, 2724.2508310214653, 2733.3030077330354, 146786.0, 152100.2394988018, 166648.0, 171728.0, 172877.0, 16559.25483353252, 17315.0, 17421.39025134114, 17490.21294041771, 17698.0, 27442.17673469799, 27478.0, 27521.0, 27561.173164805088, 27573.172804815888, 11626.186166968231, 11774.470148843322, 11796.94101529487, 11802.996745276576, 11939.76120477603, 10577.259591828652, 10767.138628909668, 10785.191110666732, 10854.403007834488, 10894.72763180911, 9962.252831037556, 10215.540300686487, 10379.792404151875, 10385.2211084169, 10392.272540922062, 2858.857057147134, 2897.246715853893, 2948.9557656635166, 3026.3947210557976, 3063.3566950940553, 1058.9046985771317, 1059.2902755154066, 1059.502034043998, 1063.186662203415, 1079.1582565598846, 21099.26152584683, 21893.233736819453, 22093.0, 22142.22502212415, 22469.0, 1123.556195302867, 1132.1282612388416, 1132.9603463878889, 1139.2310190621297, 1149.0807354116673, 11780.88219117815, 11819.349935753617, 11971.880281197251, 12062.939685301693, 12069.456874440672, 610211.0, 615150.0, 615282.0, 617565.0, 703389.0, 132029.0, 134839.3258033723, 135230.0, 136002.0, 139640.0, 1239.0954603139758, 1249.9187552809037, 1281.833361662978, 1283.550757234979, 1286.671898665853, 19067.332643357415, 19520.707189391887, 19557.022148892782, 19577.51056223549, 19834.801651983296, 61203.38796611977, 61407.38592614196, 62339.6883015582, 62634.0, 62863.37136628575, 74723.0, 75073.0, 77461.61269193619, 77732.0, 78745.60627196827, 15862.920685396499, 16225.269862855963, 16263.837361626705, 16360.509184724477, 16411.507654770376, 24161.879190603933, 24262.514749704555, 24565.263042108767, 24790.0, 24888.875555622108, 18412.171452284412, 18657.90671046636, 18719.719204211677, 18739.0, 19470.707939381206, 17903.820961790738, 18005.549861253574, 18256.17847196906, 18278.360257390927, 18328.358507452176, 20314.695279570522, 20396.184152634323, 20453.693194601794, 20507.4873128173, 20567.074481648662, 15753.291101900213, 15829.366825327319, 15855.52433426999, 15860.603484912508, 15876.047437153808, 20471.8976405123, 20540.589188215854, 20585.691214632094, 20736.68894966607, 20802.27192048271], "value": 13235.208692112312, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1419.6592817723745, 1473.1529370611902, 1477.0546850015985, 1480.7926890235362, 1487.1374602730418, 17869.642607147867, 18509.259629614815, 18582.535436614075, 18605.255789768395, 18605.81394186058, 17987.19057642406, 18110.81889181108, 18110.909445452755, 18126.09369531525, 18141.90929045356, 3042.224232820633, 3114.579531763217, 3152.858121384543, 3160.0361889623655, 3162.5572419861123, 3082.306481041759, 3152.511360739089, 3165.683431656839, 3168.2871353945407, 3168.762342824286, 2902.840343781091, 2912.097249852542, 2913.0, 2916.7520760735365, 2928.03374886287, 2934.295769015421, 2939.4855900217485, 2949.3806300676883, 2950.247686839853, 2951.217927249281, 2570.4216551276, 2598.493293807708, 2602.1152808045354, 2602.9479410411686, 2607.3351295419734, 17147.39984100563, 17546.473605791718, 17554.38559650406, 17579.472615821545, 17658.205380757896, 9140.862887056699, 9498.287628427826, 9508.809823803485, 9512.28657850664, 9520.90479095207, 5678.432156784289, 5758.596898217126, 5786.652800831964, 5814.97092514539, 6037.094435834616, 1993.4418362858423, 2046.9385918422472, 2052.98973505133, 2087.425957861585, 2087.5407410369694, 28535.57196642052, 29346.85326573375, 32648.183795405068, 33178.66821331756, 33266.83366583176, 8340.249377556049, 8345.332373410112, 8532.530710810965, 8658.696945606873, 8836.11638836124, 23982.40043998914, 24077.51844963091, 24098.277051688478, 24111.0, 24139.63790543143, 9359.0, 9748.512574371252, 9767.51162441875, 9783.706488805346, 9814.969428209935, 8364.205400486944, 8380.832383352299, 8451.830963380698, 8453.0, 8461.661533538712, 6519.185101862267, 6700.128983232246, 6734.427573656294, 6752.561083529653, 6796.72813087471, 2116.788321167902, 2133.818625416826, 2143.0463443767376, 2143.5712857428575, 2149.709789178441, 1020.2959957629212, 1025.8717660292464, 1028.2699283508643, 1034.0900007992918, 1046.5813674530098, 9928.950355248322, 9971.750706232257, 10007.849882251772, 10157.39055656663, 10162.796744065225, 831.2560258568548, 831.3058596072226, 832.9250367466835, 839.0602525171724, 843.4433274039105, 5504.779808807602, 5675.829725108253, 5736.282964629421, 5740.827775166752, 5827.038538641162, 25272.873635631706, 27350.316242094108, 27566.0, 27597.448051038868, 27662.0, 25585.48829023409, 26949.844012478956, 27050.323741906217, 27256.0, 27372.31569210746, 12767.93616031914, 12883.549075782303, 12919.677008074874, 12947.0, 13269.402876870565, 9943.30396872212, 10140.29017968735, 10197.184225261813, 10222.795544089226, 10237.74405639865, 22513.172600989576, 22989.310320690405, 23291.650625240298, 23369.883150584817, 23502.647460288452, 24142.63786043246, 24438.14466493664, 24491.142810001566, 24738.25785226446, 24924.62613060842, 14071.0, 14498.275086245856, 14532.782008270096, 14543.854561454673, 14574.417023319373, 16379.262933168275, 16496.67006659884, 16536.421225257058, 16628.3348666052, 16656.250468728693, 11823.527058917547, 11870.525178992744, 11959.402029898296, 12037.638870833889, 12184.329861857683, 12838.486460541473, 13052.738945221232, 13090.738185236432, 13424.93287533556, 13609.659758506117, 10448.268621196443, 10534.473276336306, 10547.947260263649, 10613.575456981634, 10658.626948057092, 8190.836183276182, 8212.260896519341, 8299.29455996247, 8326.12575679569, 8381.58092095405, 8813.779655508408, 8863.335249856158, 8880.111988801069, 8951.104889510996, 8959.372843900865], "value": 7792.749615382508, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [583.9795607153751, 605.184312907121, 616.3312805605917, 618.5113760129498, 629.0532748213934, 6234.407731265528, 6320.810375688737, 6320.905186422207, 6329.873402531953, 6354.396332348431, 6315.589486683362, 6317.52618553608, 6364.904526432108, 6375.617462952227, 6394.360563943615, 5103.3875934887865, 5149.253358263049, 5157.123289040854, 5161.690298582097, 5187.144121219994, 4909.116359055369, 5004.749762511878, 5135.332406787113, 5191.506806853343, 5209.843704688866, 4953.900921981576, 4969.478204788481, 5008.674436161656, 5012.774425150877, 5016.172331565305, 4880.8047678092835, 4939.185034469308, 4954.2568614707725, 4971.577415919651, 4992.475790042048, 4546.795394207235, 4570.2687569988975, 4579.58033009768, 4600.95399046012, 4620.3993480847275, 6244.2819075805955, 6270.717817698214, 6282.900492413855, 6294.402031806971, 6320.778772742932, 5939.13882487037, 5943.910841337383, 5955.255593050869, 5976.073708575134, 6025.096235564656, 6663.267550436873, 6698.765543205965, 6730.932690673079, 6776.966115169442, 6794.694238759268, 5171.405288391846, 5176.327077479941, 5183.481651834824, 5187.170052791535, 5206.609504287156, 6745.494087943423, 6861.416779573692, 6920.273371296042, 6982.822815618882, 7059.788206353766, 5287.894242115136, 5325.0, 5352.57179425645, 5361.865953351197, 5376.274202982626, 5441.0, 5449.237106805051, 5452.91820622691, 5466.72666366688, 5472.972635136799, 5969.701514924236, 6000.729967151488, 6025.15647809307, 6038.18484504595, 6049.304330002106, 6700.631465269457, 6724.93275067243, 6764.594124352456, 6766.594004359656, 6817.590944543244, 1817.8818376805466, 1835.7613510243582, 1841.1070630744077, 1866.1415748755724, 1867.346428749954, 1291.8901893338984, 1331.6537700197825, 1344.28080976677, 1355.8779709825965, 1364.6315494816345, 6244.406781355764, 6306.180196574416, 6374.808755737336, 6414.711337989802, 6438.903416448757, 6728.596284222962, 6760.256371799098, 6825.317468253234, 6839.461121247679, 6888.517803753689, 6253.812385628438, 6319.273283572356, 6362.554621176473, 6368.267649220399, 6427.389398007182, 3603.000334814151, 3606.422972324468, 3622.5290712207243, 3638.8362523686496, 3667.706583473369, 7155.855063189864, 7159.176694680178, 7170.892436613455, 7194.704953108386, 7210.567365958059, 6955.339242771928, 6972.0, 6999.475039372068, 7010.158780946217, 7033.366996970195, 7033.613151276729, 7040.225575186725, 7060.54106483077, 7075.018994681394, 7084.752033678797, 6727.865442691021, 6794.0, 6805.149356330458, 6812.14848143982, 6830.419414349836, 6713.496487763339, 6782.152230971129, 6803.897941530782, 6809.829754256183, 6869.587824730532, 7001.614911179934, 7008.5094043416475, 7038.331358520933, 7118.786436406916, 7137.607431591312, 5236.738163091906, 5285.022270879899, 5297.311349524537, 5345.251664766858, 5358.571314294925, 6666.400023997863, 6666.83332916681, 6686.058134420839, 6710.563813352116, 6779.220389655055, 6492.513061520499, 6506.41442270198, 6522.804315870531, 6547.836304092436, 6649.9692547655195, 6483.578567393104, 6524.401521627042, 6580.539362244597, 6635.502337324623, 6645.966770166118, 6433.292337842927, 6482.319356467503, 6521.934780652323, 6581.44057755077, 6644.800655980328, 6624.171978502687, 6642.634655094016, 6731.0, 6757.533500272463, 6763.830904227434, 6476.5466417350335, 6479.384458476437, 6516.543841931019, 6518.185226846645, 6531.216254049545], "value": 5269.962335497352, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [889.0975659705396, 921.5208091792268, 924.5423515359894, 1014.4876837197216, 1035.9640359640362, 21195.364139075835, 21971.890140549276, 21978.560428791414, 21990.340289791333, 21991.450213744665, 19779.078879721274, 20387.49031274219, 20787.480312992182, 20804.583908321823, 21027.158913643438, 1053.6101642392307, 1078.1051727066556, 1079.7192729890207, 1080.5893760371048, 1080.637986274599, 1038.5015192707506, 1080.4327727942853, 1081.9296745711504, 1090.0298734126634, 1106.8837772033942, 1158.044613194114, 1162.848829652144, 1162.9418529073555, 1162.9767404651902, 1163.0172504233908, 1140.8402823604702, 1144.4335054148166, 1154.393943179829, 1155.514683832788, 1162.2677713040773, 856.601680218695, 856.7558245899951, 857.4812238595684, 857.6226460357423, 859.6948083430354, 21469.355919322446, 22451.32646020622, 22765.31704048881, 22788.31635050951, 22817.315480535446, 23643.0, 23805.28584142461, 24216.757832421627, 24240.636390454158, 24327.756722432725, 18870.245190192374, 19059.90470047655, 19091.23635054596, 19164.71252931207, 19277.132529036226, 4082.408050832613, 4145.316022856225, 4146.398772178018, 4149.149424368027, 4149.3775933609895, 168941.0, 172535.0, 174371.0, 175572.0, 176316.0, 18097.457076287734, 18150.273989040554, 18238.17928193208, 18254.726179107325, 18326.450206493828, 35077.0, 35262.647373525935, 35541.111472212884, 35879.0, 35914.46128308025, 9646.469444180637, 9773.46245956465, 9776.266779991387, 9798.069183427562, 9808.313418060667, 4972.57733092684, 5018.5232402921665, 5049.772760225798, 5053.0399224147295, 5070.391553013662, 6400.967995159995, 6410.134631824737, 6447.871042579122, 6491.642959637171, 6494.9350506495275, 1157.988420115805, 1163.8719740828672, 1165.5046605192758, 1173.8180582009802, 1216.8783121687761, 709.3722055980494, 709.5210732755472, 714.5212707485997, 731.8938753880764, 746.4066067476369, 13011.024173187048, 13846.238456884766, 14423.350949207312, 14858.777118343234, 14872.776908346383, 772.737269328431, 783.3380793229826, 786.0488808541728, 788.8106854354913, 796.7171654062724, 6349.6507692077375, 6355.396237357536, 6386.552941294065, 6441.840468715676, 6504.447121994589, 161922.0, 163106.0, 164125.0, 164604.17697911433, 168825.0, 139746.0, 140474.0, 144333.0, 145597.27201363925, 148385.0, 120355.0, 121271.36185914437, 122019.0, 122554.38722806507, 124300.37849810693, 12058.819117713067, 12189.0, 12274.877251227374, 12381.75236495247, 12482.126251162332, 58885.0, 59067.40932590619, 59827.205183844555, 60419.39580604138, 60554.0, 73464.63267683628, 74563.0, 74625.62687186529, 74738.62630686811, 76528.61735691286, 17392.82607173912, 17397.565060873072, 17456.91271543634, 17489.125543723017, 17614.11929403499, 19247.807521925162, 19298.32455864038, 19345.322913697953, 19400.12699428501, 19542.0, 17789.822101778816, 18065.909670451565, 18099.909500452413, 18122.72815907736, 18138.365157219436, 15245.3901843925, 15381.538553843402, 15425.768613470582, 15527.922360388126, 15555.066695998275, 17425.47723568295, 17635.470935871945, 17819.910900445415, 17841.197146128714, 17876.55308617243, 12557.623271301876, 12847.614571562868, 12935.159214651394, 12951.093423460645, 13013.414396352377, 12036.75926481483, 12143.392830358624, 12191.695207619525, 12330.136890417585, 12372.319522425993], "value": 10221.711184214317, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1356.5, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [103.0, 104.0, 104.0, 106.0, 105.0, 107.0, 108.0, 105.0, 104.0, 105.0], "value": 105.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 110.0, 122.0, 116.0, 115.0, 110.0, 112.0, 120.0, 111.0, 115.0], "value": 114.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 162.0, 162.0, 161.0, 160.0, 163.0, 161.0, 162.0, 164.0, 162.0], "value": 161.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 73.0, 72.0, 73.0, 72.0, 73.0, 73.0, 73.0, 74.0, 74.0], "value": 72.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 77.0, 77.0, 76.0, 76.0, 77.0, 77.0, 78.0, 78.0, 78.0], "value": 77.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 113.0, 113.0, 114.0, 114.0, 113.0, 113.0, 114.0, 118.0, 113.0], "value": 113.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 149.0, 150.0, 149.0, 148.0, 148.0, 149.0, 148.0, 148.0, 150.0], "value": 148.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 95.0, 94.0, 94.0, 95.0, 95.0, 94.0, 94.0, 94.0, 93.0], "value": 94.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [43.0, 45.0, 44.0, 43.0, 45.0, 45.0, 48.0, 43.0, 43.0, 42.0], "value": 44.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [38.0, 39.0, 39.0, 38.0, 39.0, 39.0, 38.0, 38.0, 39.0, 38.0], "value": 38.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 75.0, 68.0, 71.0, 69.0, 72.0, 69.0, 69.0, 68.0, 71.0], "value": 70.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [102.0, 101.0, 107.0, 105.0, 105.0, 106.0, 112.0, 117.0, 103.0, 103.0], "value": 106.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 154.0, 156.0, 149.0, 151.0, 149.0, 151.0, 148.0, 150.0, 149.0], "value": 150.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 60.0, 57.0, 60.0, 61.0, 57.0, 60.0, 57.0, 59.0, 60.0], "value": 58.7, "unit": "score"}]}]} 13:54:49 INFO - Return code: 0 13:54:49 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 13:54:49 INFO - # TBPL SUCCESS # 13:54:49 INFO - Running post-action listener: _package_coverage_data 13:54:49 INFO - Running post-action listener: _resource_record_post_action 13:54:49 INFO - [mozharness: 2017-09-26 20:54:49.574898Z] Finished run-tests step (success) 13:54:49 INFO - Running post-run listener: _resource_record_post_run 13:54:49 INFO - Total resource usage - Wall time: 1180s; CPU: 13.0%; Read bytes: 8192; Write bytes: 289398784; Read time: 180; Write time: 140920 13:54:49 INFO - TinderboxPrint: CPU usage
13.1% 13:54:49 INFO - TinderboxPrint: I/O read bytes / time
8,192 / 180 13:54:49 INFO - TinderboxPrint: I/O write bytes / time
289,398,784 / 140,920 13:54:49 INFO - TinderboxPrint: CPU idle
8,180.7 (86.9%) 13:54:49 INFO - TinderboxPrint: CPU user
1,179.0 (12.5%) 13:54:49 INFO - TinderboxPrint: Swap in / out
0 / 0 13:54:49 INFO - install - Wall time: 15s; CPU: 13.0%; Read bytes: 0; Write bytes: 9465856; Read time: 0; Write time: 912 13:54:49 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 13:54:49 INFO - run-tests - Wall time: 1165s; CPU: 13.0%; Read bytes: 8192; Write bytes: 279932928; Read time: 180; Write time: 140008 13:54:50 INFO - Running post-run listener: _upload_blobber_files 13:54:50 INFO - Blob upload gear active. 13:54:50 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 13:54:50 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 13:54:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Beta-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 13:54:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Beta-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 13:54:50 INFO - (blobuploader) - INFO - Open directory for files ... 13:54:50 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 13:54:50 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:54:50 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:54:51 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 13:54:51 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:54:51 INFO - (blobuploader) - INFO - Done attempting. 13:54:51 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 13:54:51 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:54:51 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:54:59 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 13:54:59 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:54:59 INFO - (blobuploader) - INFO - Done attempting. 13:54:59 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 13:54:59 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:54:59 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:55:00 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 13:55:00 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:55:00 INFO - (blobuploader) - INFO - Done attempting. 13:55:00 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 13:55:00 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:55:00 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:55:01 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 13:55:01 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:55:01 INFO - (blobuploader) - INFO - Done attempting. 13:55:01 INFO - (blobuploader) - INFO - Iteration through files over. 13:55:01 INFO - Return code: 0 13:55:01 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 13:55:01 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 13:55:01 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/e6b433162882909703111f6eefd4f869a58da8559da4fad986ed62490c793a0670adbfd8f341542f52b8b3ed37f5dbed348e09b38c2bef3514b00dd7f732b909", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/c7a71a1dc78908eef66c8b854fdb5c433b4373b5002ef5ac4ba092173611f2ffc15cd0243635141793f8b1d04cf084d6373707c979abac03666fcbefcb43be3c", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/24d0126fb8b24473e5478f55fff1aacc7cc75f510ee04ba06d3f5b6aafe921f1dbbde1bbb8fa5c84b954be78fafe65398c87e6ac6b39e07566c285076beb4850", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/d1114181f38141d29772ac6206a7b07461cbe00629fbea999b71c63c5bde3a8a341b6a40e1fba094b9b16e038a9c16dfdcc52648fa1aef866be5cbdbf432f6cd"} 13:55:01 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 13:55:01 INFO - Writing to file /builds/slave/test/properties/blobber_files 13:55:01 INFO - Contents: 13:55:01 INFO - blobber_files:{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/e6b433162882909703111f6eefd4f869a58da8559da4fad986ed62490c793a0670adbfd8f341542f52b8b3ed37f5dbed348e09b38c2bef3514b00dd7f732b909", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/c7a71a1dc78908eef66c8b854fdb5c433b4373b5002ef5ac4ba092173611f2ffc15cd0243635141793f8b1d04cf084d6373707c979abac03666fcbefcb43be3c", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/24d0126fb8b24473e5478f55fff1aacc7cc75f510ee04ba06d3f5b6aafe921f1dbbde1bbb8fa5c84b954be78fafe65398c87e6ac6b39e07566c285076beb4850", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/d1114181f38141d29772ac6206a7b07461cbe00629fbea999b71c63c5bde3a8a341b6a40e1fba094b9b16e038a9c16dfdcc52648fa1aef866be5cbdbf432f6cd"} 13:55:01 INFO - Running post-run listener: copy_logs_to_upload_dir 13:55:01 INFO - Copying logs to upload dir... 13:55:01 INFO - mkdir: /builds/slave/test/build/upload/logs 13:55:01 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1230.297877 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 30 secs) (at 2017-09-26 13:55:01.615612) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-26 13:55:01.619106) ========= 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=bb9b54edd4a927dc735d112f000001d9-1506457791.22431-788204233 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/e6b433162882909703111f6eefd4f869a58da8559da4fad986ed62490c793a0670adbfd8f341542f52b8b3ed37f5dbed348e09b38c2bef3514b00dd7f732b909", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/c7a71a1dc78908eef66c8b854fdb5c433b4373b5002ef5ac4ba092173611f2ffc15cd0243635141793f8b1d04cf084d6373707c979abac03666fcbefcb43be3c", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/24d0126fb8b24473e5478f55fff1aacc7cc75f510ee04ba06d3f5b6aafe921f1dbbde1bbb8fa5c84b954be78fafe65398c87e6ac6b39e07566c285076beb4850", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/d1114181f38141d29772ac6206a7b07461cbe00629fbea999b71c63c5bde3a8a341b6a40e1fba094b9b16e038a9c16dfdcc52648fa1aef866be5cbdbf432f6cd"} build_url:https://queue.taskcluster.net/v1/task/Sh6aKoENTCqMYpxxdeGTwQ/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011260 build_url: 'https://queue.taskcluster.net/v1/task/Sh6aKoENTCqMYpxxdeGTwQ/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/e6b433162882909703111f6eefd4f869a58da8559da4fad986ed62490c793a0670adbfd8f341542f52b8b3ed37f5dbed348e09b38c2bef3514b00dd7f732b909", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/c7a71a1dc78908eef66c8b854fdb5c433b4373b5002ef5ac4ba092173611f2ffc15cd0243635141793f8b1d04cf084d6373707c979abac03666fcbefcb43be3c", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/24d0126fb8b24473e5478f55fff1aacc7cc75f510ee04ba06d3f5b6aafe921f1dbbde1bbb8fa5c84b954be78fafe65398c87e6ac6b39e07566c285076beb4850", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/d1114181f38141d29772ac6206a7b07461cbe00629fbea999b71c63c5bde3a8a341b6a40e1fba094b9b16e038a9c16dfdcc52648fa1aef866be5cbdbf432f6cd"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-26 13:55:01.650285) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-26 13:55:01.650786) ========= 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=bb9b54edd4a927dc735d112f000001d9-1506457791.22431-788204233 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004591 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-26 13:55:01.734664) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-26 13:55:01.734981) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-26 13:55:01.735365) ========= ========= Total master_lag: 0.21 =========