builder: mozilla-central_ubuntu64_hw_qr_test-dromaeojs-e10s slave: talos-linux64-ix-016 starttime: 1504787243.16 results: success (0) revision: 6469a2cb7df662afb23493b5566f99b6802fcb5a ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-09-07 05:27:23.163787) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-09-07 05:27:23.164286) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-07 05:27:23.164592) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-07 05:27:23.200012) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-07 05:27:23.200422) ========= 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=00204705a9daa57ed339a427000001b9-1504787241.684952-1206371513 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-09-07 05:27:23-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 54.6M=0s 2017-09-07 05:27:23 (54.6 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.201536 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-07 05:27:23.422337) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-07 05:27:23.422759) ========= 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=00204705a9daa57ed339a427000001b9-1504787241.684952-1206371513 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.037361 ========= master_lag: 0.01 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-07 05:27:23.474353) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-07 05:27:23.474898) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 6469a2cb7df662afb23493b5566f99b6802fcb5a --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'python archiver_client.py mozharness --repo mozilla-central --rev 6469a2cb7df662afb23493b5566f99b6802fcb5a --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=00204705a9daa57ed339a427000001b9-1504787241.684952-1206371513 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-09-07 05:27:23,527 truncating revision to first 12 chars 2017-09-07 05:27:23,528 Setting DEBUG logging. 2017-09-07 05:27:23,528 attempt 1/10 2017-09-07 05:27:23,528 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/6469a2cb7df6?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-09-07 05:27:23,831 unpacking tar archive at: mozilla-central-6469a2cb7df6/testing/mozharness/ program finished with exit code 0 elapsedTime=0.651695 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-07 05:27:24.144577) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-07 05:27:24.144952) ========= script_repo_revision: 6469a2cb7df662afb23493b5566f99b6802fcb5a ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-07 05:27:24.145476) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-07 05:27:24.145790) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-07 05:27:24.159095) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 59 secs) (at 2017-09-07 05:27:24.159448) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=00204705a9daa57ed339a427000001b9-1504787241.684952-1206371513 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 05:27:24 INFO - MultiFileLogger online at 20170907 05:27:24 in /builds/slave/test 05:27:24 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 05:27:24 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:27:24 INFO - {'append_to_log': False, 05:27:24 INFO - 'base_work_dir': '/builds/slave/test', 05:27:24 INFO - 'blob_upload_branch': 'Firefox', 05:27:24 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:27:24 INFO - 'branch': 'Firefox', 05:27:24 INFO - 'buildbot_json_path': 'buildprops.json', 05:27:24 INFO - 'code_coverage': False, 05:27:24 INFO - 'config_files': ('talos/linux_config.py',), 05:27:24 INFO - 'default_actions': ('clobber', 05:27:24 INFO - 'read-buildbot-config', 05:27:24 INFO - 'download-and-extract', 05:27:24 INFO - 'populate-webroot', 05:27:24 INFO - 'create-virtualenv', 05:27:24 INFO - 'install', 05:27:24 INFO - 'setup-mitmproxy', 05:27:24 INFO - 'run-tests'), 05:27:24 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:27:24 INFO - 'disable_ccov_upload': False, 05:27:24 INFO - 'disable_stylo': False, 05:27:24 INFO - 'download_minidump_stackwalk': True, 05:27:24 INFO - 'download_symbols': 'ondemand', 05:27:24 INFO - 'enable_stylo': False, 05:27:24 INFO - 'enable_webrender': False, 05:27:24 INFO - 'exes': {'tooltool.py': '/tools/tooltool.py'}, 05:27:24 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:27:24 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:27:24 INFO - 'gecko_profile': False, 05:27:24 INFO - 'gecko_profile_interval': 0, 05:27:24 INFO - 'installer_path': 'installer.exe', 05:27:24 INFO - 'log_level': 'info', 05:27:24 INFO - 'log_name': 'talos', 05:27:24 INFO - 'log_to_console': True, 05:27:24 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 05:27:24 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 05:27:24 INFO - 'opt_config_files': (), 05:27:24 INFO - 'pip_index': False, 05:27:24 INFO - 'suite': 'dromaeojs-e10s', 05:27:24 INFO - 'system_bits': '32', 05:27:24 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:27:24 INFO - 'title': 'talos-linux64-ix-016', 05:27:24 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:27:24 INFO - 'use_talos_json': True, 05:27:24 INFO - 'verify': 'False', 05:27:24 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:27:24 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:27:24 INFO - 'work_dir': 'build'} 05:27:24 INFO - [mozharness: 2017-09-07 12:27:24.458348Z] Running clobber step. 05:27:24 INFO - Running pre-action listener: _resource_record_pre_action 05:27:24 INFO - Running main action method: clobber 05:27:24 INFO - rmtree: /builds/slave/test/build 05:27:24 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:27:26 INFO - Running post-action listener: _resource_record_post_action 05:27:26 INFO - [mozharness: 2017-09-07 12:27:26.514284Z] Finished clobber step (success) 05:27:26 INFO - [mozharness: 2017-09-07 12:27:26.514380Z] Running read-buildbot-config step. 05:27:26 INFO - Running pre-action listener: _resource_record_pre_action 05:27:26 INFO - Running main action method: read_buildbot_config 05:27:26 INFO - Using buildbot properties: 05:27:26 INFO - { 05:27:26 INFO - "project": "", 05:27:26 INFO - "product": "firefox", 05:27:26 INFO - "who": "archaeopteryx@coole-files.de", 05:27:26 INFO - "installer_path": "public/build/target.tar.bz2", 05:27:26 INFO - "builddir": "mozilla-central_ubuntu64_hw_qr_test-dromaeojs-e10s", 05:27:26 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 05:27:26 INFO - "buildername": "Ubuntu HW 12.04 x64 qr mozilla-central talos dromaeojs-e10s", 05:27:26 INFO - "stage_platform": "linux64-qr", 05:27:26 INFO - "basedir": "/builds/slave/test", 05:27:26 INFO - "buildnumber": 33, 05:27:26 INFO - "platform": "ubuntu64_hw_qr", 05:27:26 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 05:27:26 INFO - "slavebuilddir": "test", 05:27:26 INFO - "taskId": "T-2t-8MTSLKm3wHq8uCsKQ", 05:27:26 INFO - "branch": "mozilla-central", 05:27:26 INFO - "script_repo_revision": "production", 05:27:26 INFO - "revision": "6469a2cb7df662afb23493b5566f99b6802fcb5a", 05:27:26 INFO - "slavename": "talos-linux64-ix-016", 05:27:26 INFO - "repo_path": "mozilla-central" 05:27:26 INFO - } 05:27:26 INFO - Finding installer, test and symbols from parent task. 05:27:26 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/T-2t-8MTSLKm3wHq8uCsKQ'}, attempt #1 05:27:26 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/T-2t-8MTSLKm3wHq8uCsKQ'}, attempt #1 05:27:27 INFO - Task dependencies: BaAK-As6Q66QQapQlMtaJw 05:27:27 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/BaAK-As6Q66QQapQlMtaJw'}, attempt #1 05:27:27 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/BaAK-As6Q66QQapQlMtaJw/artifacts/public/build/target.tar.bz2 05:27:27 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/BaAK-As6Q66QQapQlMtaJw/artifacts/public/build/target.test_packages.json 05:27:27 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/BaAK-As6Q66QQapQlMtaJw/artifacts/public/build/target.crashreporter-symbols.zip 05:27:27 INFO - Running post-action listener: _resource_record_post_action 05:27:27 INFO - [mozharness: 2017-09-07 12:27:27.874765Z] Finished read-buildbot-config step (success) 05:27:27 INFO - [mozharness: 2017-09-07 12:27:27.874985Z] Running download-and-extract step. 05:27:27 INFO - Running pre-action listener: _resource_record_pre_action 05:27:27 INFO - Running main action method: download_and_extract 05:27:27 INFO - mkdir: /builds/slave/test/build/tests 05:27:27 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')]} 05:27:27 INFO - trying https://queue.taskcluster.net/v1/task/BaAK-As6Q66QQapQlMtaJw/artifacts/public/build/target.test_packages.json 05:27:27 INFO - Downloading https://queue.taskcluster.net/v1/task/BaAK-As6Q66QQapQlMtaJw/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 05:27:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/BaAK-As6Q66QQapQlMtaJw/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 05:27:28 INFO - Downloaded 989 bytes. 05:27:28 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 05:27:28 INFO - Using the following test package requirements: 05:27:28 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 05:27:28 INFO - u'common': [u'target.common.tests.zip'], 05:27:28 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 05:27:28 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 05:27:28 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 05:27:28 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 05:27:28 INFO - u'mozbase': [u'target.common.tests.zip'], 05:27:28 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 05:27:28 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 05:27:28 INFO - u'web-platform': [u'target.common.tests.zip', 05:27:28 INFO - u'target.web-platform.tests.tar.gz'], 05:27:28 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 05:27:28 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 05:27:28 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/BaAK-As6Q66QQapQlMtaJw/artifacts/public/build/target.common.tests.zip 05:27:28 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/BaAK-As6Q66QQapQlMtaJw/artifacts/public/build/target.common.tests.zip'}, attempt #1 05:27:28 INFO - Fetch https://queue.taskcluster.net/v1/task/BaAK-As6Q66QQapQlMtaJw/artifacts/public/build/target.common.tests.zip into memory 05:27:29 INFO - Content-Length response header: 55021200 05:27:29 INFO - Bytes received: 55021200 05:27:40 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 05:27:40 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/BaAK-As6Q66QQapQlMtaJw/artifacts/public/build/target.common.tests.zip 05:27:40 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/BaAK-As6Q66QQapQlMtaJw/artifacts/public/build/target.common.tests.zip'}, attempt #1 05:27:40 INFO - Fetch https://queue.taskcluster.net/v1/task/BaAK-As6Q66QQapQlMtaJw/artifacts/public/build/target.common.tests.zip into memory 05:27:41 INFO - Content-Length response header: 55021200 05:27:41 INFO - Bytes received: 55021200 05:27:57 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/BaAK-As6Q66QQapQlMtaJw/artifacts/public/build/target.talos.tests.zip 05:27:57 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/BaAK-As6Q66QQapQlMtaJw/artifacts/public/build/target.talos.tests.zip'}, attempt #1 05:27:57 INFO - Fetch https://queue.taskcluster.net/v1/task/BaAK-As6Q66QQapQlMtaJw/artifacts/public/build/target.talos.tests.zip into memory 05:27:58 INFO - Content-Length response header: 14496665 05:27:58 INFO - Bytes received: 14496665 05:27: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')]} 05:27:58 INFO - trying https://queue.taskcluster.net/v1/task/BaAK-As6Q66QQapQlMtaJw/artifacts/public/build/target.tar.bz2 05:27:58 INFO - Downloading https://queue.taskcluster.net/v1/task/BaAK-As6Q66QQapQlMtaJw/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 05:27:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/BaAK-As6Q66QQapQlMtaJw/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 05:27:59 INFO - Downloaded 62783660 bytes. 05:27:59 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/BaAK-As6Q66QQapQlMtaJw/artifacts/public/build/target.tar.bz2 05:27:59 INFO - mkdir: /builds/slave/test/properties 05:27:59 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:27:59 INFO - Writing to file /builds/slave/test/properties/build_url 05:27:59 INFO - Contents: 05:27:59 INFO - build_url:https://queue.taskcluster.net/v1/task/BaAK-As6Q66QQapQlMtaJw/artifacts/public/build/target.tar.bz2 05:27:59 INFO - Running post-action listener: _resource_record_post_action 05:27:59 INFO - Running post-action listener: find_tests_for_verification 05:27:59 INFO - Running post-action listener: set_extra_try_arguments 05:27:59 INFO - [mozharness: 2017-09-07 12:27:59.542144Z] Finished download-and-extract step (success) 05:27:59 INFO - [mozharness: 2017-09-07 12:27:59.542239Z] Running populate-webroot step. 05:27:59 INFO - Running pre-action listener: _resource_record_pre_action 05:27:59 INFO - Running main action method: populate_webroot 05:27:59 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 05:27:59 INFO - 'chromez-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 05:27:59 INFO - 'tests': ['tresize', 05:27:59 INFO - 'tcanvasmark']}, 05:27:59 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 05:27:59 INFO - 'dromaeojs-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 05:27:59 INFO - 'tests': ['dromaeo_css', 05:27:59 INFO - 'kraken']}, 05:27:59 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 05:27:59 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:27:59 INFO - 'g1-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 05:27:59 INFO - 'talos_options': ['--disable-stylo'], 05:27:59 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:27:59 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 05:27:59 INFO - 'tests': ['damp', 'tps']}, 05:27:59 INFO - 'g2-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 05:27:59 INFO - 'talos_options': ['--disable-stylo'], 05:27:59 INFO - 'tests': ['damp', 'tps']}, 05:27:59 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:27:59 INFO - 'g3-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 05:27:59 INFO - 'tests': ['dromaeo_dom']}, 05:27:59 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 05:27:59 INFO - 'g4-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 05:27:59 INFO - 'tests': ['basic_compositor_video', 05:27:59 INFO - 'glvideo']}, 05:27:59 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 05:27:59 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 05:27:59 INFO - 'g5-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 05:27:59 INFO - 'talos_options': ['--disable-stylo'], 05:27:59 INFO - 'tests': ['ts_paint_webext', 05:27:59 INFO - 'tp5o_webext']}, 05:27:59 INFO - 'other-e10s': {'tests': ['a11yr', 05:27:59 INFO - 'ts_paint', 05:27:59 INFO - 'tpaint', 05:27:59 INFO - 'sessionrestore', 05:27:59 INFO - 'sessionrestore_many_windows', 05:27:59 INFO - 'sessionrestore_no_auto_restore', 05:27:59 INFO - 'tabpaint']}, 05:27:59 INFO - 'other-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 05:27:59 INFO - 'tests': ['a11yr', 05:27:59 INFO - 'ts_paint', 05:27:59 INFO - 'tpaint', 05:27:59 INFO - 'sessionrestore', 05:27:59 INFO - 'sessionrestore_many_windows', 05:27:59 INFO - 'sessionrestore_no_auto_restore', 05:27:59 INFO - 'tabpaint']}, 05:27:59 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 05:27:59 INFO - 'perf-reftest-singletons-e10s': {'tests': ['bloom_basic_singleton']}, 05:27:59 INFO - 'perf-reftest-singletons-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 05:27:59 INFO - 'tests': ['bloom_basic_singleton']}, 05:27:59 INFO - 'perf-reftest-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 05:27:59 INFO - 'tests': ['bloom_basic']}, 05:27:59 INFO - 'svgr-e10s': {'tests': ['tsvgx', 05:27:59 INFO - 'tsvgr_opacity', 05:27:59 INFO - 'tart', 05:27:59 INFO - 'tscrollx', 05:27:59 INFO - 'tsvg_static']}, 05:27:59 INFO - 'svgr-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 05:27:59 INFO - 'tests': ['tsvgx', 05:27:59 INFO - 'tsvgr_opacity', 05:27:59 INFO - 'tart', 05:27:59 INFO - 'tscrollx', 05:27:59 INFO - 'tsvg_static']}, 05:27:59 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 05:27:59 INFO - 'tp5o-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 05:27:59 INFO - 'talos_options': ['--disable-stylo'], 05:27:59 INFO - 'tests': ['tp5o']}, 05:27:59 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 05:27:59 INFO - 'talos_options': ['--mitmproxy', 05:27:59 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 05:27:59 INFO - '--firstNonBlankPaint'], 05:27:59 INFO - 'tests': ['tp6_google', 05:27:59 INFO - 'tp6_youtube', 05:27:59 INFO - 'tp6_amazon', 05:27:59 INFO - 'tp6_facebook']}, 05:27:59 INFO - 'tp6-stylo-disabled-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 05:27:59 INFO - 'talos_options': ['--disable-stylo', 05:27:59 INFO - '--mitmproxy', 05:27:59 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 05:27:59 INFO - '--firstNonBlankPaint'], 05:27:59 INFO - 'tests': ['tp6_google', 05:27:59 INFO - 'tp6_youtube', 05:27:59 INFO - 'tp6_amazon', 05:27:59 INFO - 'tp6_facebook']}, 05:27:59 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 05:27:59 INFO - 'talos_options': ['--stylo-threads=1', 05:27:59 INFO - '--mitmproxy', 05:27:59 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 05:27:59 INFO - '--firstNonBlankPaint'], 05:27:59 INFO - 'tests': ['tp6_google', 05:27:59 INFO - 'tp6_youtube', 05:27:59 INFO - 'tp6_amazon', 05:27:59 INFO - 'tp6_facebook']}, 05:27:59 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 05:27:59 INFO - 'talos_options': ['--xperf_path', 05:27:59 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:27:59 INFO - 'tests': ['tp5n']}, 05:27:59 INFO - 'xperf-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 05:27:59 INFO - 'talos_options': ['--disable-stylo', 05:27:59 INFO - '--xperf_path', 05:27:59 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:27:59 INFO - 'tests': ['tp5n']}}} 05:27:59 INFO - Running post-action listener: _resource_record_post_action 05:27:59 INFO - [mozharness: 2017-09-07 12:27:59.557313Z] Finished populate-webroot step (success) 05:27:59 INFO - [mozharness: 2017-09-07 12:27:59.557403Z] Running create-virtualenv step. 05:27:59 INFO - Running pre-action listener: _resource_record_pre_action 05:27:59 INFO - Running main action method: create_virtualenv 05:27:59 INFO - Creating virtualenv /builds/slave/test/build/venv 05:27:59 INFO - Running command: ['virtualenv', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 05:27:59 INFO - Copy/paste: virtualenv --no-site-packages --distribute /builds/slave/test/build/venv 05:27:59 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 05:27:59 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:27:59 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:28:00 INFO - Installing distribute.............................................................................................................................................................................................done. 05:28:00 INFO - Installing pip...............done. 05:28:00 INFO - Return code: 0 05:28:00 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 05:28:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 05:28:00 INFO - Reading from file tmpfile_stdout 05:28:00 INFO - Output received: 05:28:00 INFO - pip 1.1 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.1-py2.7.egg (python 2.7) 05:28:00 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:28: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')]} 05:28:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:28: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')]} 05:28:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:28:00 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15201f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16e9a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x188ca60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1890090>, '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 0x1890d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x188af90>, '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': '00204705a9daa57ed339a427000001b9-1504787241.684952-1206371513', '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 05:28:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 05:28:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 05:28:00 INFO - Using env: {'DISPLAY': ':0', 05:28:00 INFO - 'HOME': '/home/cltbld', 05:28:00 INFO - 'LANG': 'en_US.UTF-8', 05:28:00 INFO - 'LANGUAGE': 'en_US:en', 05:28:00 INFO - 'LOGNAME': 'cltbld', 05:28:00 INFO - 'MAIL': '/var/mail/cltbld', 05:28:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:28:00 INFO - 'MOZ_NO_REMOTE': '1', 05:28:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:28:00 INFO - 'NO_EM_RESTART': '1', 05:28:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:28:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:28:00 INFO - 'PWD': '/builds/slave/test', 05:28:00 INFO - 'SHELL': '/bin/bash', 05:28:00 INFO - 'SHLVL': '1', 05:28:00 INFO - 'TERM': 'linux', 05:28:00 INFO - 'TMOUT': '86400', 05:28:00 INFO - 'USER': 'cltbld', 05:28:00 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1504787241.684952-1206371513', 05:28:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:28:00 INFO - '_': '/tools/buildbot/bin/python'} 05:28:02 INFO - Ignoring indexes: http://pypi.python.org/simple/ 05:28:02 INFO - Downloading/unpacking pip>=1.5 05:28:02 INFO - Running setup.py egg_info for package pip 05:28:02 INFO - warning: no files found matching 'pip/cacert.pem' 05:28:02 INFO - warning: no files found matching '*.html' under directory 'docs' 05:28:02 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 05:28:02 INFO - no previously-included directories found matching 'docs/_build/_sources' 05:28:02 INFO - Installing collected packages: pip 05:28:02 INFO - Found existing installation: pip 1.1 05:28:02 INFO - Uninstalling pip: 05:28:02 INFO - Successfully uninstalled pip 05:28:02 INFO - Running setup.py install for pip 05:28:02 INFO - warning: no files found matching 'pip/cacert.pem' 05:28:02 INFO - warning: no files found matching '*.html' under directory 'docs' 05:28:02 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 05:28:02 INFO - no previously-included directories found matching 'docs/_build/_sources' 05:28:02 INFO - Installing pip script to /builds/slave/test/build/venv/bin 05:28:02 INFO - Installing pip2.7 script to /builds/slave/test/build/venv/bin 05:28:02 INFO - Installing pip2 script to /builds/slave/test/build/venv/bin 05:28:02 INFO - Successfully installed pip 05:28:02 INFO - Cleaning up... 05:28:02 INFO - Return code: 0 05:28:02 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 05:28:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:28:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:28:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:28:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:28:02 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x15201f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16e9a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x188ca60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1890090>, '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 0x1890d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x188af90>, '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': '00204705a9daa57ed339a427000001b9-1504787241.684952-1206371513', '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 05:28:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 05:28:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 05:28:02 INFO - Using env: {'DISPLAY': ':0', 05:28:02 INFO - 'HOME': '/home/cltbld', 05:28:02 INFO - 'LANG': 'en_US.UTF-8', 05:28:02 INFO - 'LANGUAGE': 'en_US:en', 05:28:02 INFO - 'LOGNAME': 'cltbld', 05:28:02 INFO - 'MAIL': '/var/mail/cltbld', 05:28:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:28:02 INFO - 'MOZ_NO_REMOTE': '1', 05:28:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:28:02 INFO - 'NO_EM_RESTART': '1', 05:28:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:28:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:28:02 INFO - 'PWD': '/builds/slave/test', 05:28:02 INFO - 'SHELL': '/bin/bash', 05:28:02 INFO - 'SHLVL': '1', 05:28:02 INFO - 'TERM': 'linux', 05:28:02 INFO - 'TMOUT': '86400', 05:28:02 INFO - 'USER': 'cltbld', 05:28:02 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1504787241.684952-1206371513', 05:28:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:28:02 INFO - '_': '/tools/buildbot/bin/python'} 05:28:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:28:02 INFO - Downloading/unpacking psutil>=3.1.1 05:28:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:28:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:28:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:28:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:28:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:28:03 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:28:03 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:28:03 INFO - Installing collected packages: psutil 05:28:03 INFO - Running setup.py install for psutil 05:28:03 INFO - building 'psutil._psutil_linux' extension 05:28:03 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 05:28:04 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 05:28:04 INFO - building 'psutil._psutil_posix' extension 05:28:04 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 05:28:04 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 05:28:05 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:28:05 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:28:05 INFO - Successfully installed psutil 05:28:05 INFO - Cleaning up... 05:28:05 INFO - Return code: 0 05:28:05 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 05:28:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:28:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:28:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:28:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:28:05 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 0x15201f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16e9a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x188ca60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1890090>, '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 0x1890d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x188af90>, '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': '00204705a9daa57ed339a427000001b9-1504787241.684952-1206371513', '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 05:28:05 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 05:28:05 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 05:28:05 INFO - Using env: {'DISPLAY': ':0', 05:28:05 INFO - 'HOME': '/home/cltbld', 05:28:05 INFO - 'LANG': 'en_US.UTF-8', 05:28:05 INFO - 'LANGUAGE': 'en_US:en', 05:28:05 INFO - 'LOGNAME': 'cltbld', 05:28:05 INFO - 'MAIL': '/var/mail/cltbld', 05:28:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:28:05 INFO - 'MOZ_NO_REMOTE': '1', 05:28:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:28:05 INFO - 'NO_EM_RESTART': '1', 05:28:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:28:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:28:05 INFO - 'PWD': '/builds/slave/test', 05:28:05 INFO - 'SHELL': '/bin/bash', 05:28:05 INFO - 'SHLVL': '1', 05:28:05 INFO - 'TERM': 'linux', 05:28:05 INFO - 'TMOUT': '86400', 05:28:05 INFO - 'USER': 'cltbld', 05:28:05 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1504787241.684952-1206371513', 05:28:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:28:05 INFO - '_': '/tools/buildbot/bin/python'} 05:28:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:28:05 INFO - Downloading/unpacking mozsystemmonitor==0.3 05:28: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 05:28: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 05:28: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 05:28: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 05:28:06 INFO - Downloading mozsystemmonitor-0.3.tar.gz 05:28:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:28:06 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 05:28:06 INFO - Installing collected packages: mozsystemmonitor 05:28:06 INFO - Running setup.py install for mozsystemmonitor 05:28:06 INFO - Successfully installed mozsystemmonitor 05:28:06 INFO - Cleaning up... 05:28:06 INFO - Return code: 0 05:28:06 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 05:28: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')]} 05:28:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:28: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')]} 05:28:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:28:06 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x15201f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16e9a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x188ca60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1890090>, '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 0x1890d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x188af90>, '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': '00204705a9daa57ed339a427000001b9-1504787241.684952-1206371513', '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 05:28:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 05:28:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 05:28:06 INFO - Using env: {'DISPLAY': ':0', 05:28:06 INFO - 'HOME': '/home/cltbld', 05:28:06 INFO - 'LANG': 'en_US.UTF-8', 05:28:06 INFO - 'LANGUAGE': 'en_US:en', 05:28:06 INFO - 'LOGNAME': 'cltbld', 05:28:06 INFO - 'MAIL': '/var/mail/cltbld', 05:28:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:28:06 INFO - 'MOZ_NO_REMOTE': '1', 05:28:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:28:06 INFO - 'NO_EM_RESTART': '1', 05:28:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:28:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:28:06 INFO - 'PWD': '/builds/slave/test', 05:28:06 INFO - 'SHELL': '/bin/bash', 05:28:06 INFO - 'SHLVL': '1', 05:28:06 INFO - 'TERM': 'linux', 05:28:06 INFO - 'TMOUT': '86400', 05:28:06 INFO - 'USER': 'cltbld', 05:28:06 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1504787241.684952-1206371513', 05:28:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:28:06 INFO - '_': '/tools/buildbot/bin/python'} 05:28:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:28:06 INFO - Downloading/unpacking jsonschema==2.5.1 05:28: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 05:28: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 05:28: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 05:28: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 05:28:07 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:28:07 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 05:28:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:28:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:28:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:28:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:28:08 INFO - Downloading functools32-3.2.3-2.tar.gz 05:28:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:28:08 INFO - warning: no files found matching '*.txt' 05:28:08 INFO - no previously-included directories found matching 'build' 05:28:08 INFO - no previously-included directories found matching 'dist' 05:28:08 INFO - no previously-included directories found matching '.git*' 05:28:08 INFO - Installing collected packages: jsonschema, functools32 05:28:08 INFO - Running setup.py install for functools32 05:28:08 INFO - warning: no files found matching '*.txt' 05:28:08 INFO - no previously-included directories found matching 'build' 05:28:08 INFO - no previously-included directories found matching 'dist' 05:28:08 INFO - no previously-included directories found matching '.git*' 05:28:08 INFO - Successfully installed jsonschema functools32 05:28:08 INFO - Cleaning up... 05:28:08 INFO - Return code: 0 05:28:08 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 05:28:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:28:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:28:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:28:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:28:08 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 0x15201f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16e9a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x188ca60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1890090>, '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 0x1890d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x188af90>, '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': '00204705a9daa57ed339a427000001b9-1504787241.684952-1206371513', '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 05:28:08 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 05:28:08 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 05:28:08 INFO - Using env: {'DISPLAY': ':0', 05:28:08 INFO - 'HOME': '/home/cltbld', 05:28:08 INFO - 'LANG': 'en_US.UTF-8', 05:28:08 INFO - 'LANGUAGE': 'en_US:en', 05:28:08 INFO - 'LOGNAME': 'cltbld', 05:28:08 INFO - 'MAIL': '/var/mail/cltbld', 05:28:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:28:08 INFO - 'MOZ_NO_REMOTE': '1', 05:28:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:28:08 INFO - 'NO_EM_RESTART': '1', 05:28:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:28:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:28:08 INFO - 'PWD': '/builds/slave/test', 05:28:08 INFO - 'SHELL': '/bin/bash', 05:28:08 INFO - 'SHLVL': '1', 05:28:08 INFO - 'TERM': 'linux', 05:28:08 INFO - 'TMOUT': '86400', 05:28:08 INFO - 'USER': 'cltbld', 05:28:08 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1504787241.684952-1206371513', 05:28:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:28:08 INFO - '_': '/tools/buildbot/bin/python'} 05:28:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:28:08 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 05:28:08 INFO - Cleaning up... 05:28:08 INFO - Return code: 0 05:28:08 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:28:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:28:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:28:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:28:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:28:08 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 0x15201f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16e9a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x188ca60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1890090>, '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 0x1890d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x188af90>, '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': '00204705a9daa57ed339a427000001b9-1504787241.684952-1206371513', '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 05:28:08 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 05:28:08 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 05:28:08 INFO - Using env: {'DISPLAY': ':0', 05:28:08 INFO - 'HOME': '/home/cltbld', 05:28:08 INFO - 'LANG': 'en_US.UTF-8', 05:28:08 INFO - 'LANGUAGE': 'en_US:en', 05:28:08 INFO - 'LOGNAME': 'cltbld', 05:28:08 INFO - 'MAIL': '/var/mail/cltbld', 05:28:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:28:08 INFO - 'MOZ_NO_REMOTE': '1', 05:28:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:28:08 INFO - 'NO_EM_RESTART': '1', 05:28:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:28:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:28:08 INFO - 'PWD': '/builds/slave/test', 05:28:08 INFO - 'SHELL': '/bin/bash', 05:28:08 INFO - 'SHLVL': '1', 05:28:08 INFO - 'TERM': 'linux', 05:28:08 INFO - 'TMOUT': '86400', 05:28:08 INFO - 'USER': 'cltbld', 05:28:08 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1504787241.684952-1206371513', 05:28:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:28:08 INFO - '_': '/tools/buildbot/bin/python'} 05:28:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:28:08 INFO - Downloading/unpacking blobuploader==1.2.4 05:28:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:28:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:28:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:28:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:28:09 INFO - Downloading blobuploader-1.2.4.tar.gz 05:28:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:28:09 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:28:09 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 05:28:09 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 05:28:09 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 05:28:09 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 05:28:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:28:10 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:28:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:28:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:28:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:28:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:28:10 INFO - Downloading docopt-0.6.1.tar.gz 05:28:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:28:10 INFO - Installing collected packages: blobuploader, requests, docopt 05:28:10 INFO - Running setup.py install for blobuploader 05:28:10 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:28:10 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:28:10 INFO - Running setup.py install for requests 05:28:10 INFO - Running setup.py install for docopt 05:28:10 INFO - Successfully installed blobuploader requests docopt 05:28:10 INFO - Cleaning up... 05:28:10 INFO - Return code: 0 05:28:10 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:28:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:28:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:28:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:28:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:28:10 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 0x15201f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16e9a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x188ca60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1890090>, '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 0x1890d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x188af90>, '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': '00204705a9daa57ed339a427000001b9-1504787241.684952-1206371513', '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 05:28:10 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 05:28:10 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 05:28:10 INFO - Using env: {'DISPLAY': ':0', 05:28:10 INFO - 'HOME': '/home/cltbld', 05:28:10 INFO - 'LANG': 'en_US.UTF-8', 05:28:10 INFO - 'LANGUAGE': 'en_US:en', 05:28:10 INFO - 'LOGNAME': 'cltbld', 05:28:10 INFO - 'MAIL': '/var/mail/cltbld', 05:28:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:28:10 INFO - 'MOZ_NO_REMOTE': '1', 05:28:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:28:10 INFO - 'NO_EM_RESTART': '1', 05:28:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:28:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:28:10 INFO - 'PWD': '/builds/slave/test', 05:28:10 INFO - 'SHELL': '/bin/bash', 05:28:10 INFO - 'SHLVL': '1', 05:28:10 INFO - 'TERM': 'linux', 05:28:10 INFO - 'TMOUT': '86400', 05:28:10 INFO - 'USER': 'cltbld', 05:28:10 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1504787241.684952-1206371513', 05:28:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:28:10 INFO - '_': '/tools/buildbot/bin/python'} 05:28:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:28:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:28:11 INFO - Running setup.py (path:/tmp/pip-MPgLMA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:28:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:28:11 INFO - Running setup.py (path:/tmp/pip-Iy2yZj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:28:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:28:11 INFO - Running setup.py (path:/tmp/pip-K_45VX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:28:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:28:11 INFO - Running setup.py (path:/tmp/pip-WYFBjE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:28:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:28:11 INFO - Running setup.py (path:/tmp/pip-azQnEq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:28:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:28:11 INFO - Running setup.py (path:/tmp/pip-MtLaps-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:28:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:28:11 INFO - Running setup.py (path:/tmp/pip-SCet_G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:28:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:28:11 INFO - Running setup.py (path:/tmp/pip-JWNGB3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:28:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:28:11 INFO - Running setup.py (path:/tmp/pip-At43gE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:28:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:28:11 INFO - Running setup.py (path:/tmp/pip-72kV3C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:28:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:28:11 INFO - Running setup.py (path:/tmp/pip-9cuoEs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:28:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:28:11 INFO - Running setup.py (path:/tmp/pip-6emRZt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:28:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:28:12 INFO - Running setup.py (path:/tmp/pip-YveGpo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:28:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:28:12 INFO - Running setup.py (path:/tmp/pip-bkRKht-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:28:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:28:12 INFO - Running setup.py (path:/tmp/pip-ASQF0M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:28:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:28:12 INFO - Running setup.py (path:/tmp/pip-AG6tyI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:28:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:28:12 INFO - Running setup.py (path:/tmp/pip-GJF6GA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:28:12 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:28:12 INFO - Running setup.py install for manifestparser 05:28:12 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:28:12 INFO - Running setup.py install for mozcrash 05:28:12 INFO - Running setup.py install for mozdebug 05:28:12 INFO - Running setup.py install for mozdevice 05:28:12 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:28:12 INFO - Running setup.py install for mozfile 05:28:12 INFO - Running setup.py install for mozhttpd 05:28:12 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:28:12 INFO - Running setup.py install for mozinfo 05:28:13 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:28:13 INFO - Running setup.py install for mozInstall 05:28:13 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:28:13 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:28:13 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:28:13 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:28:13 INFO - Running setup.py install for mozleak 05:28:13 INFO - Running setup.py install for mozlog 05:28:13 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:28:13 INFO - Running setup.py install for moznetwork 05:28:13 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:28:13 INFO - Running setup.py install for mozprocess 05:28:13 INFO - Running setup.py install for mozprofile 05:28:13 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:28:13 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:28:13 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:28:13 INFO - Running setup.py install for mozrunner 05:28:13 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:28:13 INFO - Running setup.py install for mozscreenshot 05:28:13 INFO - Running setup.py install for moztest 05:28:14 INFO - Running setup.py install for mozversion 05:28:14 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:28:14 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:28:14 INFO - Cleaning up... 05:28:14 INFO - Return code: 0 05:28:14 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:28:14 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')]} 05:28:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:28:14 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')]} 05:28:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:28:14 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 0x15201f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16e9a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x188ca60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1890090>, '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 0x1890d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x188af90>, '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': '00204705a9daa57ed339a427000001b9-1504787241.684952-1206371513', '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 05:28:14 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 05:28:14 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 05:28:14 INFO - Using env: {'DISPLAY': ':0', 05:28:14 INFO - 'HOME': '/home/cltbld', 05:28:14 INFO - 'LANG': 'en_US.UTF-8', 05:28:14 INFO - 'LANGUAGE': 'en_US:en', 05:28:14 INFO - 'LOGNAME': 'cltbld', 05:28:14 INFO - 'MAIL': '/var/mail/cltbld', 05:28:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:28:14 INFO - 'MOZ_NO_REMOTE': '1', 05:28:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:28:14 INFO - 'NO_EM_RESTART': '1', 05:28:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:28:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:28:14 INFO - 'PWD': '/builds/slave/test', 05:28:14 INFO - 'SHELL': '/bin/bash', 05:28:14 INFO - 'SHLVL': '1', 05:28:14 INFO - 'TERM': 'linux', 05:28:14 INFO - 'TMOUT': '86400', 05:28:14 INFO - 'USER': 'cltbld', 05:28:14 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1504787241.684952-1206371513', 05:28:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:28:14 INFO - '_': '/tools/buildbot/bin/python'} 05:28:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:28:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:28:14 INFO - Running setup.py (path:/tmp/pip-NOAcay-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:28:14 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)) 05:28:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:28:14 INFO - Running setup.py (path:/tmp/pip-YmCVWb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:28:14 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)) 05:28:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:28:14 INFO - Running setup.py (path:/tmp/pip-yccxvN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:28:14 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)) 05:28:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:28:14 INFO - Running setup.py (path:/tmp/pip-GoZ0cL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:28:14 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)) 05:28:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:28:14 INFO - Running setup.py (path:/tmp/pip-Xl6zN9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:28:14 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)) 05:28:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:28:14 INFO - Running setup.py (path:/tmp/pip-9uWGvY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:28:14 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)) 05:28:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:28:14 INFO - Running setup.py (path:/tmp/pip-_Q8TxO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:28:14 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)) 05:28:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:28:14 INFO - Running setup.py (path:/tmp/pip-btneJn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:28:14 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)) 05:28:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:28:14 INFO - Running setup.py (path:/tmp/pip-RaOqYk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:28:14 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)) 05:28:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:28:15 INFO - Running setup.py (path:/tmp/pip-Y04jgN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:28:15 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)) 05:28:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:28:15 INFO - Running setup.py (path:/tmp/pip-lQ_oPp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:28:15 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)) 05:28:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:28:15 INFO - Running setup.py (path:/tmp/pip-5g6usy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:28:15 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)) 05:28:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:28:15 INFO - Running setup.py (path:/tmp/pip-EKXQ4G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:28:15 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)) 05:28:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:28:15 INFO - Running setup.py (path:/tmp/pip-mEJELu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:28:15 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)) 05:28:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:28:15 INFO - Running setup.py (path:/tmp/pip-G4licc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:28:15 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)) 05:28:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:28:15 INFO - Running setup.py (path:/tmp/pip-6r__XH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:28:15 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)) 05:28:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:28:15 INFO - Running setup.py (path:/tmp/pip-hFn5pi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:28:15 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)) 05:28:15 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)) 05:28:15 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)) 05:28:15 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)) 05:28:15 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)) 05:28:15 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)) 05:28:15 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)) 05:28:15 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:28:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:28:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:28:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:28:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:28:16 INFO - Downloading blessings-1.6.tar.gz 05:28:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:28:16 INFO - Installing collected packages: blessings 05:28:16 INFO - Running setup.py install for blessings 05:28:16 INFO - Successfully installed blessings 05:28:16 INFO - Cleaning up... 05:28:16 INFO - Return code: 0 05:28:16 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:28:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:28:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:28:17 INFO - Reading from file tmpfile_stdout 05:28:17 INFO - Current package versions: 05:28:17 INFO - argparse == 1.2.1 05:28:17 INFO - blessings == 1.6 05:28:17 INFO - blobuploader == 1.2.4 05:28:17 INFO - docopt == 0.6.1 05:28:17 INFO - functools32 == 3.2.3-2 05:28:17 INFO - jsonschema == 2.5.1 05:28:17 INFO - manifestparser == 1.1 05:28:17 INFO - mozInstall == 1.13 05:28:17 INFO - mozcrash == 1.0 05:28:17 INFO - mozdebug == 0.1 05:28:17 INFO - mozdevice == 0.51 05:28:17 INFO - mozfile == 1.2 05:28:17 INFO - mozhttpd == 0.7 05:28:17 INFO - mozinfo == 0.10 05:28:17 INFO - mozleak == 0.1 05:28:17 INFO - mozlog == 3.5 05:28:17 INFO - moznetwork == 0.27 05:28:17 INFO - mozprocess == 0.25 05:28:17 INFO - mozprofile == 0.28 05:28:17 INFO - mozrunner == 6.13 05:28:17 INFO - mozscreenshot == 0.1 05:28:17 INFO - mozsystemmonitor == 0.3 05:28:17 INFO - moztest == 0.8 05:28:17 INFO - mozversion == 1.4 05:28:17 INFO - psutil == 3.1.1 05:28:17 INFO - requests == 1.2.3 05:28:17 INFO - wsgiref == 0.1.2 05:28:17 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:28:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:28:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:28:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:28:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:28:17 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 0x15201f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16e9a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x188ca60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1890090>, '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 0x1890d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x188af90>, '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': '00204705a9daa57ed339a427000001b9-1504787241.684952-1206371513', '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 05:28:17 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 05:28:17 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 05:28:17 INFO - Using env: {'DISPLAY': ':0', 05:28:17 INFO - 'HOME': '/home/cltbld', 05:28:17 INFO - 'LANG': 'en_US.UTF-8', 05:28:17 INFO - 'LANGUAGE': 'en_US:en', 05:28:17 INFO - 'LOGNAME': 'cltbld', 05:28:17 INFO - 'MAIL': '/var/mail/cltbld', 05:28:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:28:17 INFO - 'MOZ_NO_REMOTE': '1', 05:28:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:28:17 INFO - 'NO_EM_RESTART': '1', 05:28:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:28:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:28:17 INFO - 'PWD': '/builds/slave/test', 05:28:17 INFO - 'SHELL': '/bin/bash', 05:28:17 INFO - 'SHLVL': '1', 05:28:17 INFO - 'TERM': 'linux', 05:28:17 INFO - 'TMOUT': '86400', 05:28:17 INFO - 'USER': 'cltbld', 05:28:17 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1504787241.684952-1206371513', 05:28:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:28:17 INFO - '_': '/tools/buildbot/bin/python'} 05:28:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:28:17 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)) 05:28:17 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)) 05:28:17 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)) 05:28:17 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)) 05:28:17 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)) 05:28:17 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)) 05:28:17 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)) 05:28:17 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)) 05:28:17 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)) 05:28:17 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 05:28:17 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 05:28:17 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 05:28:17 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 05:28:17 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 05:28:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 05:28:18 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)) 05:28:18 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)) 05:28:18 INFO - Installing collected packages: simplejson 05:28:18 INFO - Running setup.py install for simplejson 05:28:18 INFO - building 'simplejson._speedups' extension 05:28:18 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 05:28:19 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 05:28:19 INFO - Successfully installed simplejson 05:28:19 INFO - Cleaning up... 05:28:19 INFO - Return code: 0 05:28:19 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:28:19 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')]} 05:28:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:28:19 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')]} 05:28:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:28:19 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 0x15201f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16e9a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x188ca60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1890090>, '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 0x1890d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x188af90>, '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': '00204705a9daa57ed339a427000001b9-1504787241.684952-1206371513', '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 05:28:19 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 05:28:19 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 05:28:19 INFO - Using env: {'DISPLAY': ':0', 05:28:19 INFO - 'HOME': '/home/cltbld', 05:28:19 INFO - 'LANG': 'en_US.UTF-8', 05:28:19 INFO - 'LANGUAGE': 'en_US:en', 05:28:19 INFO - 'LOGNAME': 'cltbld', 05:28:19 INFO - 'MAIL': '/var/mail/cltbld', 05:28:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:28:19 INFO - 'MOZ_NO_REMOTE': '1', 05:28:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:28:19 INFO - 'NO_EM_RESTART': '1', 05:28:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:28:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:28:19 INFO - 'PWD': '/builds/slave/test', 05:28:19 INFO - 'SHELL': '/bin/bash', 05:28:19 INFO - 'SHLVL': '1', 05:28:19 INFO - 'TERM': 'linux', 05:28:19 INFO - 'TMOUT': '86400', 05:28:19 INFO - 'USER': 'cltbld', 05:28:19 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1504787241.684952-1206371513', 05:28:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:28:19 INFO - '_': '/tools/buildbot/bin/python'} 05:28:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:28:19 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 05:28:19 INFO - Cleaning up... 05:28:19 INFO - Return code: 0 05:28:19 INFO - Running post-action listener: _resource_record_post_action 05:28:19 INFO - Running post-action listener: _start_resource_monitoring 05:28:19 INFO - Starting resource monitoring. 05:28:19 INFO - [mozharness: 2017-09-07 12:28:19.886456Z] Finished create-virtualenv step (success) 05:28:19 INFO - [mozharness: 2017-09-07 12:28:19.887439Z] Running install step. 05:28:19 INFO - Running pre-action listener: _resource_record_pre_action 05:28:19 INFO - Running main action method: install 05:28:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:28:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:28:20 INFO - Reading from file tmpfile_stdout 05:28:20 INFO - Detecting whether we're running mozinstall >=1.0... 05:28:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:28:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:28:20 INFO - Reading from file tmpfile_stdout 05:28:20 INFO - Output received: 05:28:20 INFO - Usage: mozinstall [options] installer 05:28:20 INFO - Options: 05:28:20 INFO - -h, --help show this help message and exit 05:28:20 INFO - -d DEST, --destination=DEST 05:28:20 INFO - Directory to install application into. [default: 05:28:20 INFO - "/builds/slave/test"] 05:28:20 INFO - --app=APP Application being installed. [default: firefox] 05:28:20 INFO - mkdir: /builds/slave/test/build/application 05:28:20 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'] 05:28:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 05:28:36 INFO - Reading from file tmpfile_stdout 05:28:36 INFO - Output received: 05:28:36 INFO - /builds/slave/test/build/application/firefox/firefox 05:28:36 INFO - Running post-action listener: _resource_record_post_action 05:28:36 INFO - [mozharness: 2017-09-07 12:28:36.748832Z] Finished install step (success) 05:28:36 INFO - [mozharness: 2017-09-07 12:28:36.749084Z] Running setup-mitmproxy step. 05:28:36 INFO - Running pre-action listener: _resource_record_pre_action 05:28:36 INFO - Running main action method: setup_mitmproxy 05:28:36 INFO - Skipping: mitmproxy is not required 05:28:36 INFO - Running post-action listener: _resource_record_post_action 05:28:36 INFO - [mozharness: 2017-09-07 12:28:36.750270Z] Finished setup-mitmproxy step (success) 05:28:36 INFO - [mozharness: 2017-09-07 12:28:36.750490Z] Running run-tests step. 05:28:36 INFO - Running pre-action listener: _resource_record_pre_action 05:28:36 INFO - Running pre-action listener: _set_gcov_prefix 05:28:36 INFO - Running main action method: run_tests 05:28:36 WARNING - Try message not found. 05:28:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:28:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:28:36 INFO - Python 2.7.3 05:28:36 INFO - Return code: 0 05:28:36 INFO - grabbing minidump binary from tooltool 05:28:36 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')]} 05:28:36 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 0x1890090>, '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 0x1890d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x188af90>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:28:36 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 05:28:36 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 05:28:36 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 05:28:36 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:28:36 INFO - Return code: 0 05:28:36 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 05:28:36 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:28:36 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:28:36 INFO - ENV: RUST_BACKTRACE is now full 05:28:36 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 05:28:36 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:28:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/BaAK-As6Q66QQapQlMtaJw/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-016', '--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 05:28:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/BaAK-As6Q66QQapQlMtaJw/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-016 --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 05:28:36 INFO - Using env: {'DISPLAY': ':0', 05:28:36 INFO - 'HOME': '/home/cltbld', 05:28:36 INFO - 'LANG': 'en_US.UTF-8', 05:28:36 INFO - 'LANGUAGE': 'en_US:en', 05:28:36 INFO - 'LOGNAME': 'cltbld', 05:28:36 INFO - 'MAIL': '/var/mail/cltbld', 05:28:36 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:28:36 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 05:28:36 INFO - 'MOZ_ACCELERATED': '1', 05:28:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:28:36 INFO - 'MOZ_NO_REMOTE': '1', 05:28:36 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:28:36 INFO - 'MOZ_WEBRENDER': '1', 05:28:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:28:36 INFO - 'NO_EM_RESTART': '1', 05:28:36 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:28:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:28:36 INFO - 'PWD': '/builds/slave/test', 05:28:36 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:28:36 INFO - 'RUST_BACKTRACE': 'full', 05:28:36 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 05:28:36 INFO - 'SHELL': '/bin/bash', 05:28:36 INFO - 'SHLVL': '1', 05:28:36 INFO - 'TERM': 'linux', 05:28:36 INFO - 'TMOUT': '86400', 05:28:36 INFO - 'USER': 'cltbld', 05:28:36 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1504787241.684952-1206371513', 05:28:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:28:36 INFO - '_': '/tools/buildbot/bin/python'} 05:28:36 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/BaAK-As6Q66QQapQlMtaJw/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-016', '--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 05:28:37 INFO - mozversion application_buildid: 20170907103107 05:28:37 INFO - mozversion application_changeset: 6469a2cb7df662afb23493b5566f99b6802fcb5a 05:28:37 INFO - mozversion application_display_name: Nightly 05:28:37 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:28:37 INFO - mozversion application_name: Firefox 05:28:37 INFO - mozversion application_remotingname: firefox 05:28:37 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 05:28:37 INFO - mozversion application_vendor: Mozilla 05:28:37 INFO - mozversion application_version: 57.0a1 05:28:37 INFO - mozversion platform_buildid: 20170907103107 05:28:37 INFO - mozversion platform_changeset: 6469a2cb7df662afb23493b5566f99b6802fcb5a 05:28:37 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 05:28:37 INFO - mozversion platform_version: 57.0a1 05:28:37 INFO - using testdate: 1504787317 05:28:37 INFO - actual date: 1504787317 05:28:37 INFO - starting webserver on 'localhost:60609' 05:28:37 INFO - SUITE-START | Running 2 tests 05:28:37 INFO - TEST-START | dromaeo_css 05:28:37 INFO - Initialising browser for dromaeo_css test... 05:28:37 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:60609/getInfo.html -profile /tmp/tmp6rN5ba/profile 05:28:37 INFO - TEST-INFO | started process 3501 (/builds/slave/test/build/application/firefox/firefox http://localhost:60609/getInfo.html) 05:28:46 INFO - TEST-INFO | 3501: exit 0 05:28:47 INFO - Browser initialized. 05:28:47 INFO - Running cycle 1/1 for dromaeo_css test... 05:28:47 INFO - Using env: {'DISPLAY': ':0', 05:28:47 INFO - 'HOME': '/home/cltbld', 05:28:47 INFO - 'JSGC_DISABLE_POISONING': '1', 05:28:47 INFO - 'LANG': 'en_US.UTF-8', 05:28:47 INFO - 'LANGUAGE': 'en_US:en', 05:28:47 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 05:28:47 INFO - 'LOGNAME': 'cltbld', 05:28:47 INFO - 'MAIL': '/var/mail/cltbld', 05:28:47 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:28:47 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 05:28:47 INFO - 'MOZ_ACCELERATED': '1', 05:28:47 INFO - 'MOZ_CRASHREPORTER': '1', 05:28:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:28:47 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 05:28:47 INFO - 'MOZ_NO_REMOTE': '1', 05:28:47 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:28:47 INFO - 'MOZ_WEBRENDER': '1', 05:28:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:28:47 INFO - 'NO_EM_RESTART': '1', 05:28:47 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:28:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:28:47 INFO - 'PWD': '/builds/slave/test', 05:28:47 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:28:47 INFO - 'RUST_BACKTRACE': 'full', 05:28:47 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 05:28:47 INFO - 'SHELL': '/bin/bash', 05:28:47 INFO - 'SHLVL': '1', 05:28:47 INFO - 'TERM': 'linux', 05:28:47 INFO - 'TMOUT': '86400', 05:28:47 INFO - 'USER': 'cltbld', 05:28:47 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1504787241.684952-1206371513', 05:28:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:28:47 INFO - '_': '/tools/buildbot/bin/python'} 05:28:47 INFO - TEST-INFO | started process 3711 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp6rN5ba/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 05:28:47 INFO - PID 3711 | WebRender - OpenGL version new 3.2.0 NVIDIA 361.42 05:28:48 INFO - PID 3711 | WebRender - OpenGL version new 3.2.0 NVIDIA 361.42 05:28:48 INFO - PID 3711 | 05:28:48 INFO - PID 3711 | (/builds/slave/test/build/application/firefox/firefox:3772): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 05:28:48 INFO - PID 3711 | 05:28:58 INFO - PID 3711 | RSS: Main: 209596416 05:28:58 INFO - PID 3711 | 05:31:56 INFO - PID 3711 | Cycle 1(1): loaded http://localhost:60609/tests/dromaeo/cssquery-dojo.html (next: http://localhost:60609/tests/dromaeo/cssquery-ext.html) 05:31:57 INFO - PID 3711 | RSS: Main: 216010752 05:31:57 INFO - PID 3711 | 05:34:59 INFO - PID 3711 | Cycle 1(1): loaded http://localhost:60609/tests/dromaeo/cssquery-ext.html (next: http://localhost:60609/tests/dromaeo/cssquery-jquery.html) 05:35:00 INFO - PID 3711 | RSS: Main: 212717568 05:35:00 INFO - PID 3711 | 05:38:02 INFO - PID 3711 | Cycle 1(1): loaded http://localhost:60609/tests/dromaeo/cssquery-jquery.html (next: http://localhost:60609/tests/dromaeo/cssquery-mootools.html) 05:38:03 INFO - PID 3711 | RSS: Main: 218419200 05:38:03 INFO - PID 3711 | 05:41:05 INFO - PID 3711 | Cycle 1(1): loaded http://localhost:60609/tests/dromaeo/cssquery-mootools.html (next: http://localhost:60609/tests/dromaeo/cssquery-prototype.html) 05:41:05 INFO - PID 3711 | RSS: Main: 220348416 05:41:05 INFO - PID 3711 | 05:44:09 INFO - PID 3711 | Cycle 1(1): loaded http://localhost:60609/tests/dromaeo/cssquery-prototype.html (next: http://localhost:60609/tests/dromaeo/cssquery-yui.html) 05:44:10 INFO - PID 3711 | RSS: Main: 218902528 05:44:10 INFO - PID 3711 | 05:47:12 INFO - PID 3711 | Cycle 1(1): loaded http://localhost:60609/tests/dromaeo/cssquery-yui.html (next: http://localhost:60609/tests/dromaeo/cssquery-dojo.html) 05:47:12 INFO - PID 3711 | RSS: Main: 221261824 05:47:12 INFO - PID 3711 | 05:47:12 INFO - PID 3711 | __start_tp_report 05:47:12 INFO - PID 3711 | _x_x_mozilla_page_load 05:47:12 INFO - PID 3711 | _x_x_mozilla_page_load_details 05:47:12 INFO - PID 3711 | |i|pagename|runs| 05:47:12 INFO - PID 3711 | |0;dojo.html;3277.4919887417445;3312.1719570107475;3325.7006869381753;3334.033130392185;3338.0653417043227;6414;6421.582597131183;6456.289808121109;6473;6514.543981921267;6336.112944187817;6458.547901646886;6464.8060558183215;6470.3529647035275;6489.870202595946;5837.795677151301;5860.648361098337;5886.381929897363;5894.233749612566;5903.291605007405;5933.991221492357;5953.970230148843;5954.047352423613;5954.880902381949;5966.761329546813;5851.736671849777;5908.291005079396;5989.191459153002;5999.61002534836;6012.3687012863675;5952.4642782149385;5993.520518358543;6031.125486804411;6034.788782392595;6113.724882380259;5816.1275808628625;5895.55783316253;5934.97032514839;5935;6014.248218972629;6250.718717657716;6284.685765711696;6306.747730090791;6331.651759153245;6344.777932772331;6902;6946.79159625212;6950.992106144581;6999.23008469068;7053.0830991970715;6724.495662825308;7014.403775679073;7049.436045116429;7116.857662846766;7131.928680713178;6400.679966001728;6403.711832967481;6412.903806442907;6464.224293084813;6474.093626892239;7112.288771122846;7113.181984071794;7117.964410177916;7130.429565634737;7132.500724949204;6733.427658648971;6744.83137921546;6781.11845460087;6807.421369183576;6825.5222134451105;6117.351566315546;6822;6899.93100069003;6922.5154239202775;6927.238003819576;6810.795676129724;6834.555753875982;6858.931410685929;6901.033855260268;6938.306169383021;6694.59832410057;6843.760468383683;6889.104416425833;6940.479464040217;6979.82550436233;5361.329833770778;5364.6512976656395;5452.100403433468;5466.863328416822;5473.2063850741415;4667.276572131325;4764.380630518011;4780.880477988078;4802.951970480321;4818.638602104857;5959.28488581373;5984.491318237999;6023.548233882389;6044.214252147281;6058.939410605925;6725.125733654593;6884.552504087218;6903.1716194057035;6916.792496225121;6927.134108236471;5984.910226346608;5994.910076348859;6003.939960600425;6023.66869822164;6029.186059881859;5962.463378295887;6045.274567051894;6049.969750151221;6052.394760523913;6054.7880824171825;6742.123523941954;6776.830579235559;6789.762358317435;6878.002689610079;6885.793426197222;6982.79051628452;6992.265812089658;7011.474139439664;7049.259827718016;7120.786376408612;6474.4820414365795;6735.225449073419;6745.0219718139615;6829.52193346461;6846.281140480178;6806.319368063154;6823;6877.65611719402;6882.174139103339;6906.482013848881;7007.229204787572;7046.859062818612;7078.362947334558;7101.147862256562;7123.287671232835;6666.066750655009;6702.631355275506;6734.9326506734305;6802.591844489347;6826.214985276558;6518.250401203923;6631.602103873783;6706.262311145868;6784.423324017514;6823.420009299265;6615.239247486601;6674.799756007327;6757.358050985148;6760.93239067603;6765.1205343305055;6680.231773346128;6700.564463309869;6745.763898263537;6809.489288303496;6836.487263455161;6400.903986440114;6423.325550817097;6508.446782023581;6523.608583485006;6634.270230274762 05:47:12 INFO - PID 3711 | |1;ext.html;821.2772759971228;849.876767868659;879.5909901895619;1085.7557049663822;1114.0808832713014;40054.799726001365;40627.1874562509;40649.1870162597;40792.18415631686;40833.59166408335;38220.85337439874;38464.80767596158;38594.8070259649;38647.22705545894;38676.80661596688;7164.641767911597;7277.3814225790875;7348.191698913115;7350.228226036269;7351.191368949411;7208.531445456055;7304.8173795655;7309.853802923938;7318.414526837841;7318.487705860592;7283;7286.344229019387;7877.251661092216;7882;7891;7765.922340776605;7829.7259595913865;7833.921660783376;7844.333231675286;7846.882296765553;7689.307962283366;7768.3008529232075;7771.145174030852;7772.378209743207;7777.805554861117;37773.244535109145;37942.81028594867;38347.80826095852;38400.42399363984;38547.42178867319;3446.672566106241;3467.1158854492196;3470.514128022079;3479.408500554912;3486.477028445728;31954.360912781845;32171.19572010695;32214.516782248284;32285.677143228735;32389.190270243198;5181.766820493049;5209.270702101709;5222.399424066243;5222.451642577513;5313.973430132824;184411.99999999866;184961;184982;185104;185542;47206.76396617995;47416.28875566869;47435.5256447438;47663.04673906572;47805.28292075622;48603.27095093577;48808.26787598189;48960.75519622379;49168.50831491639;49295.50704492981;14376.568702938928;14456.494022709154;14470.710585788436;14568.271586420637;14620;11512.76974460506;11575.88424115765;11590.304581725124;11605.419729013516;11854.229475084092;12555.435005424777;14161.78757318641;14254;14318.498852540111;14512.564623061326;5000.049990501793;5581.49766521015;5684.857878553069;5731.512821410143;5801.506871915934;1001.1340190734962;1003.4280460137797;1016.2784423059562;1022.8414595737672;1026.38416949831;23987.28038158858;24298.271051868473;24311.513769724508;29657.85171074131;30384.088477345715;1086.1962148010573;1089.6513115802868;1101.8677758669012;1102.3330884814573;1111.377628528027;12489.687757805947;12682.175658582162;12749.872501275055;12753.426095825711;12839.935800320938;232146;232154;233044;233420;233611;52526;52989.73505132527;53230.73384633052;53267.46732532625;53275.20087198695;1360.6462319796726;1430.9713805724036;1442.8845692344587;1455.6215384000025;1457.3878970832277;22867.542649147257;23056.193033244428;23088.191913282953;23419.648705269094;23553.669495756367;38683.22633547257;38998.4150237741;39004;39005;39071.80464097661;204134;204147;204834;206692;206863;33421.66578334186;36992.26015479622;37451.625483744814;37881.81059094687;38162.236755265294;40784.59215407927;46703;46729.29906051344;47202;48713.75643121762;33977.49033764545;34046.319073618884;34236.48645270273;34295.828520857234;34526.82736586301;33274.833625831714;33377.332453351286;34271;34294.31411371809;35171;37803.62196378111;38891.80554097211;39129.41305880471;39415;39524;32470.675293246764;33184.502232466046;33418.164545886546;33761.15597110092;34322.48516272308;24372;24435.51128977375;24472.51054978855;24778;25168.24495265145 05:47:12 INFO - PID 3711 | |2;jquery.html;563.9651239974648;578.8842231553689;581.5783556921235;581.6771691711101;586.694918642306;21804.89097554512;22706.54586908263;22856.314310570688;23017.654735178985;23028.88485557574;21875.890620546874;23725.76274237257;23919.402014949635;23946.281611551636;24046.278611641636;6630.138082049327;6713.429358504533;6753.122094127756;6775.186977562699;6780.932190678104;6585.6048637081685;6612.636305003223;6617.371349721769;6617.867642647144;6642.368974947372;5929.970350148244;6581.835454113638;6597.406233438989;6601.042848786947;6635.170603674541;6522.836929076763;6538.738450461976;6590.5716128451495;6600.3729645683825;6603.900941485882;6033.276006879159;6097.603655762361;6113.755449782004;6126.081087836816;6135.693215339215;27540.311492212655;27797.16608501748;28886.277843053882;28913.56629650557;29395.55906661402;1970.1922211893054;1995.8203761661375;2005.5888542848681;2026.2401599400225;2028.7261219735294;18770.436886893414;19348.322808701767;19388;19444;19463;2260.977390226093;2322.779335963081;2323.233333000106;2383.880805959695;2482.4290413205063;130054.3497282517;130886;131522.684773152;131579.34210328982;131692;13781.448742050206;14290.356933937997;14333.426662933574;14670.339834707464;14821.407143714347;22878.65682014771;22918.31245062651;22983.850807459894;23107.88446057759;23206.65190022151;9301.116393942564;9355.672551460666;9618.326717129874;9704.951475242578;9764.609415623438;8583.65665373378;8723.302135829119;8776.341774366949;8908.510031948175;8927.464352138892;8759.255463285692;8894.911050889537;8940.46357218569;9208.217301529312;9251.67619133327;2697.7032526422076;2747.3955729739423;2777.5139350613563;2844.33158207821;2855.457463082008;974.4104816585864;977.5405559387077;994.3089552760906;995.2535598301274;1016.3698506925606;18751.156197971122;19172.808271917103;19605.8039419604;19724.013799309978;22844.543109138056;1002.2483137646765;1003.8795344558699;1036.5750042482546;1046.7330830638139;1051.2483574244452;10841.78316433667;10954.39750813697;10977.780444391068;11145.387003714874;11205.271657342246;476870;481581;491835;502461;510611;121623.39188304002;123181.38409307896;123358;124223.378883105;125059;1231.1874163052341;1244.9253044817158;1287.0347239570322;1288.5168061976758;1290.5289569307135;20943.476413089793;21125.6831147536;21188.68216976716;21393.78606213918;21911.01400436952;58634.7068264673;58673.413265868505;59349.703251483465;59890;61540;74295.62852185704;74798.62600686961;76643.61678191573;77052;78049.60975195315;20328.695069574263;20672.793272067087;20809;20969.685454717885;21026;17362.91318543399;18101;18204.271829127218;18986.620267594295;19138;17642.558936026187;17763.378281760077;17799.953005404543;17816.643667126325;17939.73090403671;15015;15121.395144194548;15334.693306134039;16944.915275423544;17299.481015569552;17730.64538709193;17824.732629010316;18000.18999145068;18007.909960450113;18212.45362639123;20314;20402.693959590913;20690.793092068885;20735.27426540064;20743.8962805185;16915.492535223962;17164;17166.055866926938;17185.828141718423;17349.479515614552 05:47:12 INFO - PID 3711 | |3;mootools.html;1333.6465836553316;1384.5638623833493;1403.1581051369176;1409.9929500352496;1412.3503188533275;14863.851361486382;15160.469383571577;15632.921835390807;15736.842631573682;15782.447614333501;15537.22313884307;15801.288941997609;15811.525654230363;15813.367465301375;15824;2632.6577544919182;2677.7188395218514;2678.3304173956512;2684.6912605050375;2705.0937935791535;2538.073603134861;2651.4034342273026;2736.3979924416594;2760.9585856212175;2762.4889395461905;2718.103026001415;2744.972550274492;2747.5329194036963;2748.50526905157;2748.8213266137636;2599.2072417912527;2607.7522635349706;2646.8544230067337;2651.6552848129813;2658.3752818087833;2502.9374265643323;2511;2521.34445044288;2523.3060908250195;2531.190019193859;14596.927015364961;14864.182469964147;15016.099034057992;15043.623909402244;15047.548573542812;7607.581583012932;7910.406719496061;7945;7949.64226609804;7977.920220797834;5211.42674305826;5315.096433606296;5344.091504444254;5366.543843773284;5402.945970540283;1883.0396497786091;1898.5253686578355;1902.5909429472729;1943.2712732725229;1960.3236883275247;26488.748456381232;26496.867515662492;26670.333241669112;26698.733012669818;26712.59931101035;6402.199725034371;6705.362990515893;6730.93269067303;6751.864962700718;6771.661416929134;16948.74576881348;16995.40516081931;17007;17052.14739263032;17075;7765.417593680384;8036.276735093869;8047.637856296481;8050.194980501903;8063.879041814377;7023.789286321418;7187.281271872771;7211.314925082109;7270.127584689765;7276.308750668678;5211.7915283389;5307;5323.148296272578;5348;5537.058700021006;1373.5261334839465;1388.6528367908022;1544.266473425114;1551.363940784273;1574.2522301906731;865.057087774329;881.6076845803556;885.3359980014989;892.8125093730259;909.7589138878203;7334.3765779908235;7424.443166762514;7449.962750186214;7460.813479663052;7523.811904702427;935.9812803743887;954.4845783276953;956.9569369378395;973.7711637765119;977.6480467031863;5027.396712394536;5027.421846487628;5069.8732531687;5155.7679904404395;5215.009148261818;21084.578308433745;21931.451713706967;21937.34187974363;21951.121955121936;21993.230236941632;20341;21039.368818935458;21172.47068823292;21463.892680536497;21528.246511372028;10704.30422022566;10731.141508679288;10886.61896833607;10899.29154604948;11069.446527673585;7960.761177164694;8027.759167224993;8128.674853005814;8149.714759983609;8234.547099909323;17319;17327.047012414438;17351.219195135996;18555.25778968826;18646.813531864507;17813.376531821323;17853.196606153015;18060.638787224445;18758.6248275031;19169.80830191736;13734.93132534331;13981.23103229332;13997.230152341719;14056.859431405555;14082.436702532194;13053.086283960032;13349.132306400053;13776;13925.373358198703;13946.511872084428;10712.196585256293;10778.299410538604;11072.723181920517;11103.38931358783;11367.43162841838;10094.89905100969;10932.453377330943;11141.108711302913;11159.442027898735;11224.494897729784;9079.182873541413;9167.08329167078;9224.538773061455;9238.076192380708;9240.584173712334;6318.241810982528;6343.460805831556;6370.6814659267775;6399.8080057598345;6457.225132983884;6523.151990241238;6632.436242919406;6878.724851006104;7055.541389809646;7078.68145933424 05:47:12 INFO - PID 3711 | |4;prototype.html;490.86819261941116;495.9628027897908;521.5957632834555;525.5138996428306;529.0661981602472;6297.590656607317;6317.810465686031;6377.61734295942;6395.58428702134;6397;6027.879442411149;6183.752649893999;6201.426408040669;6235.5946863453955;6336.556441049129;5058.772355244005;5080.745962701869;5083.389993200821;5107.591392688576;5113.795448182068;4987.501249875019;5041.72270525121;5049.293098966147;5056.823011194609;5097;4771.8091276348905;4958.900821983558;5022.995400919813;5027.396712394518;5027.717931927354;4991.151504244287;5039.546440820343;5042.495750424965;5052.115879721053;5095;4522.253828118356;4528.139653465831;4531.13908357411;4537.4328208973875;4537.954620453786;6183.103449999725;6190.535709821781;6212.751489940397;6215;6275.780347687809;5717.25623684776;5753.252077229975;5775.509081728058;5802;5824.854378640525;6597.472202223858;6607.867842643168;6648.401643852028;6665.366790154928;6667.566338286539;4849.9272510912015;4867.610591152735;4869.464358920516;4926.926096108561;4972.975135124338;6873.20958089821;7023.454839935206;7030.191527974297;7066.258042905523;7075.363217310364;5024.824131155392;5037.899242015139;5046.621503387188;5059.139946209079;5086.237064440364;5072.163093089673;5079.3650793650795;5096.617753668415;5103.464136265713;5105.923411148836;5728.2504397888415;5781.682007489629;5817.7091145442555;5818.301803783573;5827.796027139115;6688.799336019927;6693.832654183587;6700.195976482853;6749.223839258548;6790.864182716318;1666.7749853769828;1690.4590531029953;1734.7224444089138;1760.542259012666;1764.9647007059787;1150.108665784024;1222.87771222877;1232.383808095952;1241.1002023532867;1242.9627111186678;5644.379118296984;5795.565332600072;5810.0994345875615;5832.737526811304;5865;6542.803715888531;6635.369639884299;6635.8009259722285;6663.233728121231;6686.331366863372;5683.147527870852;5751.798687046017;5758.3090029196765;5814.302283725895;5852.8536786579825;3581.8567257309414;3605.5938184108218;3613.8915832525067;3621.6740493355724;3628.4920111184456;6504.902426463606;6542.345765423514;6597.703103360361;6619.768308109193;6658.3674550917585;6887.242403335629;6936.2023367312395;6972.860542789116;6985.126859142607;7056.682449289794;6492.967535162294;6582.901256481061;6657.367550082734;6664.300248473937;6702.83242918931;6811.93188068113;6817.216020157547;6823.28355522663;6895.241523432519;6914.654267286716;6735.25912149673;6741.292164322872;6803.965980170067;6827.453803695792;6855.245922948571;6465.967670161619;6545.022014983076;6584.539082264196;6617.768378106935;6622.602643841385;4906.803727850846;4973.204287314013;4982.6512144149565;4995.525425084611;4997.177723496843;6678.365555272241;6682.627667178276;6752.3922846944015;6772.424343930624;6813;6575.736970521126;6583.44040756541;6623.470122390294;6639.900401494078;6684.197896252481;6425.935740642721;6481.740730370732;6518.250401203923;6535.183102112236;6558.344165583403;6306.432421082125;6549.443297319591;6553.035413574718;6583.144191255106;6601.174853143357;6256.403592509239;6439.590743775251;6522.771702990372;6574.605523668595;6639.634820084749;6175.541696649891;6400.45596124316;6414.166158399378;6415.101885735908;6451.903221451776 05:47:12 INFO - PID 3711 | |5;yui.html;877.4209022045451;905.9275257979363;921.9124183202593;923.9630414783406;940.1397721085206;18709.906450467744;19466.902665486687;19490.122944467497;19527.316543920966;19546.31587894424;17355.566110847234;18105.4568362949;21713.457163570918;21751.12995480183;21761.23835665752;909.9727008189765;918.4718786697642;920.6363486422858;921.3320342751518;922.4649703172144;969.5491596407669;976.1458723616835;978.2320878110685;981.8625392445064;982.4301904895179;921.6313474610142;989.1789814453986;1004.6132239087967;1022.3559157730656;1028.0850043461326;978.936369136011;979.5591983607369;983.5672304186136;985.9408435493857;989.4261328429529;733.8899165125221;737.1117803047315;740.4298690008663;740.9259074092602;741.1587847792794;18268.269269229215;18442.723359149622;18491.63016739671;18502.629947400976;19483.318083866998;20373;20525.17899284027;21124.683129753066;21176.15295388198;21403.036863341033;16328.346866125341;16383.525482706495;16476;16523.586910327216;16536.338546458126;3673.3571624965793;3721.813909304524;3727.422249551324;3729.8881033568764;3734.3651579231596;121929.39035304767;124498;127595.36202319022;128118.35940820236;128996.35501822525;15716.29276682552;16010.759838602431;16143;16257.349706011864;16304.836951630568;30258.24354391114;30501.542476862865;30507.084787456413;30638.38723225523;30765;7932.167122452175;7950.403719721044;7985.842052902297;8038.799030024296;8088.312493438006;3789.9621003789607;3864.091938394475;3866.7679939203736;3870.9225815483533;3876.7480113792512;5044.066847633199;5186.948130518722;5204.115300398866;5271.42014378418;5330.360356757136;936.0545848692869;955.7945041815904;957.6025949231131;978.295627148452;979.0307595480565;694.1011390249639;711.4557363616838;718.7843646905907;720.4884531982246;730.2551397574445;11634.243774154653;11720.782781205944;11829;12173.452194651261;12298.323592202336;694.4687314204638;699.8565294114694;701.9508634395544;702.9297070293032;704.9788506344818;5462.562994960394;5506.889862202734;5550.306211723535;5603.15952607104;5657.745401456862;112616;113401.43299283451;114511;114635.42682286703;115156.42421787838;96580.51709741406;98963.50518247363;100968;101345;103927;87592.5620371894;88507;89356.5532172348;91675;92140;12238.571649992207;12429.45760458265;12763.170393924365;12917.22496650204;13115.868841311465;41056.58943410647;41901;42125.789371052946;42681.35977960271;43784.124317514106;72097.27902721116;72120.63939680268;72569.6371518139;74290;76051.61974190094;17706.11469426498;17808.3767068152;17922.283108676027;17944.461666150037;18468.07659616987;21295;21300.7869921305;21455.141794328676;21462;21989;18729.344472943383;19174.328898488486;19208.13563389679;19349.516262093;19617.70573441428;17554.648907022045;18626.348077817212;19504.21983120716;19792.505187370432;20105.597888041866;17741.201645925707;17809.287628494716;17954.371596994042;18602.81397186011;18781.436556903314;13452.5291614793;13620.250886201355;13899.166050036625;13909.791353129509;13919.095258808145;14400.927995359956;14618.342174601956;14680.706385872008;14790.955034857887;14881.553553393416 05:47:12 INFO - PID 3711 | __end_tp_report 05:47:12 INFO - PID 3711 | __start_cc_report 05:47:12 INFO - PID 3711 | _x_x_mozilla_cycle_collect,375 05:47:12 INFO - PID 3711 | __end_cc_report 05:47:12 INFO - PID 3711 | __startTimestamp1504788432738__endTimestamp 05:47:12 INFO - PID 3711 | 05:47:12 INFO - PID 3711 | ------- Summary: start ------- 05:47:12 INFO - PID 3711 | Number of tests: 6 05:47:12 INFO - PID 3711 | 05:47:12 INFO - PID 3711 | [#0] dojo.html Cycles:165 Average:6365.36 Median:6615.24 stddev:755.45 (11.4%) stddev-sans-first:717.88 05:47:12 INFO - PID 3711 | Values: 3277.5 3312.2 3325.7 3334.0 3338.1 6414.0 6421.6 6456.3 6473.0 6514.5 6336.1 6458.5 6464.8 6470.4 6489.9 5837.8 5860.6 5886.4 5894.2 5903.3 5934.0 5954.0 5954.0 5954.9 5966.8 5851.7 5908.3 5989.2 5999.6 6012.4 5952.5 5993.5 6031.1 6034.8 6113.7 5816.1 5895.6 5935.0 5935.0 6014.2 6250.7 6284.7 6306.7 6331.7 6344.8 6902.0 6946.8 6951.0 6999.2 7053.1 6724.5 7014.4 7049.4 7116.9 7131.9 6400.7 6403.7 6412.9 6464.2 6474.1 7112.3 7113.2 7118.0 7130.4 7132.5 6733.4 6744.8 6781.1 6807.4 6825.5 6117.4 6822.0 6899.9 6922.5 6927.2 6810.8 6834.6 6858.9 6901.0 6938.3 6694.6 6843.8 6889.1 6940.5 6979.8 5361.3 5364.7 5452.1 5466.9 5473.2 4667.3 4764.4 4780.9 4803.0 4818.6 5959.3 5984.5 6023.5 6044.2 6058.9 6725.1 6884.6 6903.2 6916.8 6927.1 5984.9 5994.9 6003.9 6023.7 6029.2 5962.5 6045.3 6050.0 6052.4 6054.8 6742.1 6776.8 6789.8 6878.0 6885.8 6982.8 6992.3 7011.5 7049.3 7120.8 6474.5 6735.2 6745.0 6829.5 6846.3 6806.3 6823.0 6877.7 6882.2 6906.5 7007.2 7046.9 7078.4 7101.1 7123.3 6666.1 6702.6 6734.9 6802.6 6826.2 6518.3 6631.6 6706.3 6784.4 6823.4 6615.2 6674.8 6757.4 6760.9 6765.1 6680.2 6700.6 6745.8 6809.5 6836.5 6400.9 6423.3 6508.4 6523.6 6634.3 05:47:12 INFO - PID 3711 | 05:47:12 INFO - PID 3711 | [#1] ext.html Cycles:180 Average:38011.73 Median:3482.94 stddev:54051.21 (1551.9%) stddev-sans-first:54130.70 05:47:12 INFO - PID 3711 | Values: 821.3 849.9 879.6 1085.8 1114.1 40054.8 40627.2 40649.2 40792.2 40833.6 38220.9 38464.8 38594.8 38647.2 38676.8 7164.6 7277.4 7348.2 7350.2 7351.2 7208.5 7304.8 7309.9 7318.4 7318.5 7283.0 7286.3 7877.3 7882.0 7891.0 7765.9 7829.7 7833.9 7844.3 7846.9 7689.3 7768.3 7771.1 7772.4 7777.8 37773.2 37942.8 38347.8 38400.4 38547.4 3446.7 3467.1 3470.5 3479.4 3486.5 31954.4 32171.2 32214.5 32285.7 32389.2 5181.8 5209.3 5222.4 5222.5 5314.0 184412.0 184961.0 184982.0 185104.0 185542.0 47206.8 47416.3 47435.5 47663.0 47805.3 48603.3 48808.3 48960.8 49168.5 49295.5 14376.6 14456.5 14470.7 14568.3 14620.0 11512.8 11575.9 11590.3 11605.4 11854.2 12555.4 14161.8 14254.0 14318.5 14512.6 5000.0 5581.5 5684.9 5731.5 5801.5 1001.1 1003.4 1016.3 1022.8 1026.4 23987.3 24298.3 24311.5 29657.9 30384.1 1086.2 1089.7 1101.9 1102.3 1111.4 12489.7 12682.2 12749.9 12753.4 12839.9 232146.0 232154.0 233044.0 233420.0 233611.0 52526.0 52989.7 53230.7 53267.5 53275.2 1360.6 1431.0 1442.9 1455.6 1457.4 22867.5 23056.2 23088.2 23419.6 23553.7 38683.2 38998.4 39004.0 39005.0 39071.8 204134.0 204147.0 204834.0 206692.0 206863.0 33421.7 36992.3 37451.6 37881.8 38162.2 40784.6 46703.0 46729.3 47202.0 48713.8 33977.5 34046.3 34236.5 34295.8 34526.8 33274.8 33377.3 34271.0 34294.3 35171.0 37803.6 38891.8 39129.4 39415.0 39524.0 32470.7 33184.5 33418.2 33761.2 34322.5 24372.0 24435.5 24472.5 24778.0 25168.2 05:47:12 INFO - PID 3711 | 05:47:12 INFO - PID 3711 | [#2] jquery.html Cycles:180 Average:35172.49 Median:22867.49 stddev:83060.96 (363.2%) stddev-sans-first:83253.33 05:47:12 INFO - PID 3711 | Values: 564.0 578.9 581.6 581.7 586.7 21804.9 22706.5 22856.3 23017.7 23028.9 21875.9 23725.8 23919.4 23946.3 24046.3 6630.1 6713.4 6753.1 6775.2 6780.9 6585.6 6612.6 6617.4 6617.9 6642.4 5930.0 6581.8 6597.4 6601.0 6635.2 6522.8 6538.7 6590.6 6600.4 6603.9 6033.3 6097.6 6113.8 6126.1 6135.7 27540.3 27797.2 28886.3 28913.6 29395.6 1970.2 1995.8 2005.6 2026.2 2028.7 18770.4 19348.3 19388.0 19444.0 19463.0 2261.0 2322.8 2323.2 2383.9 2482.4 130054.3 130886.0 131522.7 131579.3 131692.0 13781.4 14290.4 14333.4 14670.3 14821.4 22878.7 22918.3 22983.9 23107.9 23206.7 9301.1 9355.7 9618.3 9705.0 9764.6 8583.7 8723.3 8776.3 8908.5 8927.5 8759.3 8894.9 8940.5 9208.2 9251.7 2697.7 2747.4 2777.5 2844.3 2855.5 974.4 977.5 994.3 995.3 1016.4 18751.2 19172.8 19605.8 19724.0 22844.5 1002.2 1003.9 1036.6 1046.7 1051.2 10841.8 10954.4 10977.8 11145.4 11205.3 476870.0 481581.0 491835.0 502461.0 510611.0 121623.4 123181.4 123358.0 124223.4 125059.0 1231.2 1244.9 1287.0 1288.5 1290.5 20943.5 21125.7 21188.7 21393.8 21911.0 58634.7 58673.4 59349.7 59890.0 61540.0 74295.6 74798.6 76643.6 77052.0 78049.6 20328.7 20672.8 20809.0 20969.7 21026.0 17362.9 18101.0 18204.3 18986.6 19138.0 17642.6 17763.4 17800.0 17816.6 17939.7 15015.0 15121.4 15334.7 16944.9 17299.5 17730.6 17824.7 18000.2 18007.9 18212.5 20314.0 20402.7 20690.8 20735.3 20743.9 16915.5 17164.0 17166.1 17185.8 17349.5 05:47:12 INFO - PID 3711 | 05:47:12 INFO - PID 3711 | [#3] mootools.html Cycles:180 Average:9236.06 Median:26492.81 stddev:6670.43 (25.2%) stddev-sans-first:6662.72 05:47:12 INFO - PID 3711 | Values: 1333.6 1384.6 1403.2 1410.0 1412.4 14863.9 15160.5 15632.9 15736.8 15782.4 15537.2 15801.3 15811.5 15813.4 15824.0 2632.7 2677.7 2678.3 2684.7 2705.1 2538.1 2651.4 2736.4 2761.0 2762.5 2718.1 2745.0 2747.5 2748.5 2748.8 2599.2 2607.8 2646.9 2651.7 2658.4 2502.9 2511.0 2521.3 2523.3 2531.2 14596.9 14864.2 15016.1 15043.6 15047.5 7607.6 7910.4 7945.0 7949.6 7977.9 5211.4 5315.1 5344.1 5366.5 5402.9 1883.0 1898.5 1902.6 1943.3 1960.3 26488.7 26496.9 26670.3 26698.7 26712.6 6402.2 6705.4 6730.9 6751.9 6771.7 16948.7 16995.4 17007.0 17052.1 17075.0 7765.4 8036.3 8047.6 8050.2 8063.9 7023.8 7187.3 7211.3 7270.1 7276.3 5211.8 5307.0 5323.1 5348.0 5537.1 1373.5 1388.7 1544.3 1551.4 1574.3 865.1 881.6 885.3 892.8 909.8 7334.4 7424.4 7450.0 7460.8 7523.8 936.0 954.5 957.0 973.8 977.6 5027.4 5027.4 5069.9 5155.8 5215.0 21084.6 21931.5 21937.3 21951.1 21993.2 20341.0 21039.4 21172.5 21463.9 21528.2 10704.3 10731.1 10886.6 10899.3 11069.4 7960.8 8027.8 8128.7 8149.7 8234.5 17319.0 17327.0 17351.2 18555.3 18646.8 17813.4 17853.2 18060.6 18758.6 19169.8 13734.9 13981.2 13997.2 14056.9 14082.4 13053.1 13349.1 13776.0 13925.4 13946.5 10712.2 10778.3 11072.7 11103.4 11367.4 10094.9 10932.5 11141.1 11159.4 11224.5 9079.2 9167.1 9224.5 9238.1 9240.6 6318.2 6343.5 6370.7 6399.8 6457.2 6523.2 6632.4 6878.7 7055.5 7078.7 05:47:12 INFO - PID 3711 | 05:47:12 INFO - PID 3711 | [#4] prototype.html Cycles:180 Average:5563.41 Median:6207.09 stddev:1568.33 (25.3%) stddev-sans-first:1525.82 05:47:12 INFO - PID 3711 | Values: 490.9 496.0 521.6 525.5 529.1 6297.6 6317.8 6377.6 6395.6 6397.0 6027.9 6183.8 6201.4 6235.6 6336.6 5058.8 5080.7 5083.4 5107.6 5113.8 4987.5 5041.7 5049.3 5056.8 5097.0 4771.8 4958.9 5023.0 5027.4 5027.7 4991.2 5039.5 5042.5 5052.1 5095.0 4522.3 4528.1 4531.1 4537.4 4538.0 6183.1 6190.5 6212.8 6215.0 6275.8 5717.3 5753.3 5775.5 5802.0 5824.9 6597.5 6607.9 6648.4 6665.4 6667.6 4849.9 4867.6 4869.5 4926.9 4973.0 6873.2 7023.5 7030.2 7066.3 7075.4 5024.8 5037.9 5046.6 5059.1 5086.2 5072.2 5079.4 5096.6 5103.5 5105.9 5728.3 5781.7 5817.7 5818.3 5827.8 6688.8 6693.8 6700.2 6749.2 6790.9 1666.8 1690.5 1734.7 1760.5 1765.0 1150.1 1222.9 1232.4 1241.1 1243.0 5644.4 5795.6 5810.1 5832.7 5865.0 6542.8 6635.4 6635.8 6663.2 6686.3 5683.1 5751.8 5758.3 5814.3 5852.9 3581.9 3605.6 3613.9 3621.7 3628.5 6504.9 6542.3 6597.7 6619.8 6658.4 6887.2 6936.2 6972.9 6985.1 7056.7 6493.0 6582.9 6657.4 6664.3 6702.8 6811.9 6817.2 6823.3 6895.2 6914.7 6735.3 6741.3 6804.0 6827.5 6855.2 6466.0 6545.0 6584.5 6617.8 6622.6 4906.8 4973.2 4982.7 4995.5 4997.2 6678.4 6682.6 6752.4 6772.4 6813.0 6575.7 6583.4 6623.5 6639.9 6684.2 6425.9 6481.7 6518.3 6535.2 6558.3 6306.4 6549.4 6553.0 6583.1 6601.2 6256.4 6439.6 6522.8 6574.6 6639.6 6175.5 6400.5 6414.2 6415.1 6451.9 05:47:12 INFO - PID 3711 | 05:47:12 INFO - PID 3711 | [#5] yui.html Cycles:180 Average:24211.87 Median:26123.62 stddev:32978.68 (126.2%) stddev-sans-first:33024.65 05:47:12 INFO - PID 3711 | Values: 877.4 905.9 921.9 924.0 940.1 18709.9 19466.9 19490.1 19527.3 19546.3 17355.6 18105.5 21713.5 21751.1 21761.2 910.0 918.5 920.6 921.3 922.5 969.5 976.1 978.2 981.9 982.4 921.6 989.2 1004.6 1022.4 1028.1 978.9 979.6 983.6 985.9 989.4 733.9 737.1 740.4 740.9 741.2 18268.3 18442.7 18491.6 18502.6 19483.3 20373.0 20525.2 21124.7 21176.2 21403.0 16328.3 16383.5 16476.0 16523.6 16536.3 3673.4 3721.8 3727.4 3729.9 3734.4 121929.4 124498.0 127595.4 128118.4 128996.4 15716.3 16010.8 16143.0 16257.3 16304.8 30258.2 30501.5 30507.1 30638.4 30765.0 7932.2 7950.4 7985.8 8038.8 8088.3 3790.0 3864.1 3866.8 3870.9 3876.7 5044.1 5186.9 5204.1 5271.4 5330.4 936.1 955.8 957.6 978.3 979.0 694.1 711.5 718.8 720.5 730.3 11634.2 11720.8 11829.0 12173.5 12298.3 694.5 699.9 702.0 702.9 705.0 5462.6 5506.9 5550.3 5603.2 5657.7 112616.0 113401.4 114511.0 114635.4 115156.4 96580.5 98963.5 100968.0 101345.0 103927.0 87592.6 88507.0 89356.6 91675.0 92140.0 12238.6 12429.5 12763.2 12917.2 13115.9 41056.6 41901.0 42125.8 42681.4 43784.1 72097.3 72120.6 72569.6 74290.0 76051.6 17706.1 17808.4 17922.3 17944.5 18468.1 21295.0 21300.8 21455.1 21462.0 21989.0 18729.3 19174.3 19208.1 19349.5 19617.7 17554.6 18626.3 19504.2 19792.5 20105.6 17741.2 17809.3 17954.4 18602.8 18781.4 13452.5 13620.3 13899.2 13909.8 13919.1 14400.9 14618.3 14680.7 14791.0 14881.6 05:47:12 INFO - PID 3711 | -------- Summary: end -------- 05:47:12 INFO - PID 3711 | 05:47:13 INFO - TEST-INFO | 3711: exit 0 05:47:13 INFO - TEST-OK | dromaeo_css | took 1116365ms 05:47:13 INFO - TEST-START | kraken 05:47:13 INFO - Initialising browser for kraken test... 05:47:13 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:60609/getInfo.html -profile /tmp/tmpfhpWF4/profile 05:47:13 INFO - TEST-INFO | started process 4145 (/builds/slave/test/build/application/firefox/firefox http://localhost:60609/getInfo.html) 05:47:18 INFO - TEST-INFO | 4145: exit 0 05:47:19 INFO - Browser initialized. 05:47:19 INFO - Running cycle 1/1 for kraken test... 05:47:19 INFO - Using env: {'DISPLAY': ':0', 05:47:19 INFO - 'HOME': '/home/cltbld', 05:47:19 INFO - 'JSGC_DISABLE_POISONING': '1', 05:47:19 INFO - 'LANG': 'en_US.UTF-8', 05:47:19 INFO - 'LANGUAGE': 'en_US:en', 05:47:19 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 05:47:19 INFO - 'LOGNAME': 'cltbld', 05:47:19 INFO - 'MAIL': '/var/mail/cltbld', 05:47:19 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:47:19 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 05:47:19 INFO - 'MOZ_ACCELERATED': '1', 05:47:19 INFO - 'MOZ_CRASHREPORTER': '1', 05:47:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:47:19 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 05:47:19 INFO - 'MOZ_NO_REMOTE': '1', 05:47:19 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:47:19 INFO - 'MOZ_WEBRENDER': '1', 05:47:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:47:19 INFO - 'NO_EM_RESTART': '1', 05:47:19 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:47:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:47:19 INFO - 'PWD': '/builds/slave/test', 05:47:19 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:47:19 INFO - 'RUST_BACKTRACE': 'full', 05:47:19 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 05:47:19 INFO - 'SHELL': '/bin/bash', 05:47:19 INFO - 'SHLVL': '1', 05:47:19 INFO - 'TERM': 'linux', 05:47:19 INFO - 'TMOUT': '86400', 05:47:19 INFO - 'USER': 'cltbld', 05:47:19 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1504787241.684952-1206371513', 05:47:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:47:19 INFO - '_': '/tools/buildbot/bin/python'} 05:47:19 INFO - TEST-INFO | started process 4352 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpfhpWF4/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 05:47:19 INFO - PID 4352 | WebRender - OpenGL version new 3.2.0 NVIDIA 361.42 05:47:20 INFO - PID 4352 | WebRender - OpenGL version new 3.2.0 NVIDIA 361.42 05:47:20 INFO - PID 4352 | 05:47:20 INFO - PID 4352 | (/builds/slave/test/build/application/firefox/firefox:4413): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 05:47:20 INFO - PID 4352 | 05:47:30 INFO - PID 4352 | RSS: Main: 211189760 05:47:30 INFO - PID 4352 | 05:47:33 INFO - PID 4352 | Cycle 1(1): loaded http://localhost:60609/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:60609/tests/kraken/driver.html?testName=audio-beat-detection) 05:47:34 INFO - PID 4352 | RSS: Main: 217214976 05:47:34 INFO - PID 4352 | 05:47:37 INFO - PID 4352 | Cycle 1(1): loaded http://localhost:60609/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:60609/tests/kraken/driver.html?testName=audio-dft) 05:47:37 INFO - PID 4352 | RSS: Main: 218992640 05:47:37 INFO - PID 4352 | 05:47:40 INFO - PID 4352 | Cycle 1(1): loaded http://localhost:60609/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:60609/tests/kraken/driver.html?testName=audio-fft) 05:47:41 INFO - PID 4352 | RSS: Main: 212729856 05:47:41 INFO - PID 4352 | 05:47:43 INFO - PID 4352 | Cycle 1(1): loaded http://localhost:60609/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:60609/tests/kraken/driver.html?testName=audio-oscillator) 05:47:44 INFO - PID 4352 | RSS: Main: 214806528 05:47:44 INFO - PID 4352 | 05:47:46 INFO - PID 4352 | Cycle 1(1): loaded http://localhost:60609/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:60609/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:47:47 INFO - PID 4352 | RSS: Main: 213442560 05:47:47 INFO - PID 4352 | 05:47:50 INFO - PID 4352 | Cycle 1(1): loaded http://localhost:60609/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:60609/tests/kraken/driver.html?testName=imaging-darkroom) 05:47:50 INFO - PID 4352 | RSS: Main: 216657920 05:47:50 INFO - PID 4352 | 05:47:54 INFO - PID 4352 | Cycle 1(1): loaded http://localhost:60609/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:60609/tests/kraken/driver.html?testName=imaging-desaturate) 05:47:55 INFO - PID 4352 | RSS: Main: 215478272 05:47:55 INFO - PID 4352 | 05:47:58 INFO - PID 4352 | Cycle 1(1): loaded http://localhost:60609/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:60609/tests/kraken/driver.html?testName=json-parse-financial) 05:47:58 INFO - PID 4352 | RSS: Main: 217468928 05:47:58 INFO - PID 4352 | 05:48:00 INFO - PID 4352 | Cycle 1(1): loaded http://localhost:60609/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:60609/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:48:00 INFO - PID 4352 | RSS: Main: 216825856 05:48:00 INFO - PID 4352 | 05:48:02 INFO - PID 4352 | Cycle 1(1): loaded http://localhost:60609/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:60609/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:48:03 INFO - PID 4352 | RSS: Main: 214142976 05:48:03 INFO - PID 4352 | 05:48:05 INFO - PID 4352 | Cycle 1(1): loaded http://localhost:60609/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:60609/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:48:06 INFO - PID 4352 | RSS: Main: 213581824 05:48:06 INFO - PID 4352 | 05:48:08 INFO - PID 4352 | Cycle 1(1): loaded http://localhost:60609/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:60609/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:48:09 INFO - PID 4352 | RSS: Main: 214343680 05:48:09 INFO - PID 4352 | 05:48:12 INFO - PID 4352 | Cycle 1(1): loaded http://localhost:60609/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:60609/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:48:13 INFO - PID 4352 | RSS: Main: 213250048 05:48:13 INFO - PID 4352 | 05:48:14 INFO - PID 4352 | Cycle 1(1): loaded http://localhost:60609/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:60609/tests/kraken/driver.html?testName=ai-astar) 05:48:15 INFO - PID 4352 | RSS: Main: 215502848 05:48:15 INFO - PID 4352 | 05:48:15 INFO - PID 4352 | __start_tp_report 05:48:15 INFO - PID 4352 | _x_x_mozilla_page_load 05:48:15 INFO - PID 4352 | _x_x_mozilla_page_load_details 05:48:15 INFO - PID 4352 | |i|pagename|runs| 05:48:15 INFO - PID 4352 | |0;ai-astar;109;107;109;108;117;109;119;100;115;114 05:48:15 INFO - PID 4352 | |1;audio-beat-detection;144;132;171;173;117;154;152;119;194;117 05:48:15 INFO - PID 4352 | |2;audio-dft;164;165;162;164;173;176;167;163;164;166 05:48:15 INFO - PID 4352 | |3;audio-fft;77;83;74;166;80;73;73;74;153;76 05:48:15 INFO - PID 4352 | |4;audio-oscillator;84;80;132;82;80;80;131;82;80;130 05:48:15 INFO - PID 4352 | |5;imaging-gaussian-blur;123;124;122;114;118;116;125;115;114;115 05:48:15 INFO - PID 4352 | |6;imaging-darkroom;150;150;148;148;148;148;149;150;147;151 05:48:15 INFO - PID 4352 | |7;imaging-desaturate;95;94;95;94;94;101;94;94;94;96 05:48:15 INFO - PID 4352 | |8;json-parse-financial;58;54;55;54;55;53;53;57;51;53 05:48:15 INFO - PID 4352 | |9;json-stringify-tinderbox;39;38;39;39;38;45;42;38;38;38 05:48:15 INFO - PID 4352 | |10;stanford-crypto-aes;78;81;76;80;84;75;78;82;77;86 05:48:15 INFO - PID 4352 | |11;stanford-crypto-ccm;122;133;116;117;121;137;123;120;115;171 05:48:15 INFO - PID 4352 | |12;stanford-crypto-pbkdf2;174;172;183;175;169;174;174;168;168;172 05:48:15 INFO - PID 4352 | |13;stanford-crypto-sha256-iterative;70;66;65;70;63;68;66;73;66;65 05:48:15 INFO - PID 4352 | __end_tp_report 05:48:15 INFO - PID 4352 | __start_cc_report 05:48:15 INFO - PID 4352 | _x_x_mozilla_cycle_collect,931 05:48:15 INFO - PID 4352 | __end_cc_report 05:48:15 INFO - PID 4352 | __startTimestamp1504788495240__endTimestamp 05:48:15 INFO - PID 4352 | 05:48:15 INFO - PID 4352 | ------- Summary: start ------- 05:48:15 INFO - PID 4352 | Number of tests: 14 05:48:15 INFO - PID 4352 | 05:48:15 INFO - PID 4352 | [#0] ai-astar Cycles:10 Average:110.70 Median:111.50 stddev:5.60 (5.0%) stddev-sans-first:5.90 05:48:15 INFO - PID 4352 | Values: 109.0 107.0 109.0 108.0 117.0 109.0 119.0 100.0 115.0 114.0 05:48:15 INFO - PID 4352 | 05:48:15 INFO - PID 4352 | [#1] audio-beat-detection Cycles:10 Average:147.30 Median:153.00 stddev:26.57 (17.4%) stddev-sans-first:28.15 05:48:15 INFO - PID 4352 | Values: 144.0 132.0 171.0 173.0 117.0 154.0 152.0 119.0 194.0 117.0 05:48:15 INFO - PID 4352 | 05:48:15 INFO - PID 4352 | [#2] audio-dft Cycles:10 Average:166.40 Median:165.50 stddev:4.55 (2.7%) stddev-sans-first:4.74 05:48:15 INFO - PID 4352 | Values: 164.0 165.0 162.0 164.0 173.0 176.0 167.0 163.0 164.0 166.0 05:48:15 INFO - PID 4352 | 05:48:15 INFO - PID 4352 | [#3] audio-fft Cycles:10 Average:92.90 Median:75.00 stddev:35.38 (47.2%) stddev-sans-first:37.05 05:48:15 INFO - PID 4352 | Values: 77.0 83.0 74.0 166.0 80.0 73.0 73.0 74.0 153.0 76.0 05:48:15 INFO - PID 4352 | 05:48:15 INFO - PID 4352 | [#4] audio-oscillator Cycles:10 Average:96.10 Median:80.00 stddev:24.12 (30.2%) stddev-sans-first:25.18 05:48:15 INFO - PID 4352 | Values: 84.0 80.0 132.0 82.0 80.0 80.0 131.0 82.0 80.0 130.0 05:48:15 INFO - PID 4352 | 05:48:15 INFO - PID 4352 | [#5] imaging-gaussian-blur Cycles:10 Average:118.60 Median:120.00 stddev:4.43 (3.7%) stddev-sans-first:4.40 05:48:15 INFO - PID 4352 | Values: 123.0 124.0 122.0 114.0 118.0 116.0 125.0 115.0 114.0 115.0 05:48:15 INFO - PID 4352 | 05:48:15 INFO - PID 4352 | [#6] imaging-darkroom Cycles:10 Average:148.90 Median:149.50 stddev:1.29 (0.9%) stddev-sans-first:1.30 05:48:15 INFO - PID 4352 | Values: 150.0 150.0 148.0 148.0 148.0 148.0 149.0 150.0 147.0 151.0 05:48:15 INFO - PID 4352 | 05:48:15 INFO - PID 4352 | [#7] imaging-desaturate Cycles:10 Average:95.10 Median:94.00 stddev:2.18 (2.3%) stddev-sans-first:2.32 05:48:15 INFO - PID 4352 | Values: 95.0 94.0 95.0 94.0 94.0 101.0 94.0 94.0 94.0 96.0 05:48:15 INFO - PID 4352 | 05:48:15 INFO - PID 4352 | [#8] json-parse-financial Cycles:10 Average:54.30 Median:54.50 stddev:2.06 (3.8%) stddev-sans-first:1.69 05:48:15 INFO - PID 4352 | Values: 58.0 54.0 55.0 54.0 55.0 53.0 53.0 57.0 51.0 53.0 05:48:15 INFO - PID 4352 | 05:48:15 INFO - PID 4352 | [#9] json-stringify-tinderbox Cycles:10 Average:39.40 Median:39.00 stddev:2.32 (5.9%) stddev-sans-first:2.46 05:48:15 INFO - PID 4352 | Values: 39.0 38.0 39.0 39.0 38.0 45.0 42.0 38.0 38.0 38.0 05:48:15 INFO - PID 4352 | 05:48:15 INFO - PID 4352 | [#10] stanford-crypto-aes Cycles:10 Average:79.70 Median:80.50 stddev:3.56 (4.4%) stddev-sans-first:3.72 05:48:15 INFO - PID 4352 | Values: 78.0 81.0 76.0 80.0 84.0 75.0 78.0 82.0 77.0 86.0 05:48:15 INFO - PID 4352 | 05:48:15 INFO - PID 4352 | [#11] stanford-crypto-ccm Cycles:10 Average:127.50 Median:122.50 stddev:16.87 (13.8%) stddev-sans-first:17.77 05:48:15 INFO - PID 4352 | Values: 122.0 133.0 116.0 117.0 121.0 137.0 123.0 120.0 115.0 171.0 05:48:15 INFO - PID 4352 | 05:48:15 INFO - PID 4352 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:172.90 Median:174.00 stddev:4.41 (2.5%) stddev-sans-first:4.66 05:48:15 INFO - PID 4352 | Values: 174.0 172.0 183.0 175.0 169.0 174.0 174.0 168.0 168.0 172.0 05:48:15 INFO - PID 4352 | 05:48:15 INFO - PID 4352 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.20 Median:67.00 stddev:3.01 (4.5%) stddev-sans-first:3.02 05:48:15 INFO - PID 4352 | Values: 70.0 66.0 65.0 70.0 63.0 68.0 66.0 73.0 66.0 65.0 05:48:15 INFO - PID 4352 | -------- Summary: end -------- 05:48:15 INFO - PID 4352 | 05:48:15 INFO - PID 4352 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 05:48:16 INFO - TEST-INFO | 4352: exit 0 05:48:16 INFO - TEST-OK | kraken | took 62652ms 05:48:16 INFO - SUITE-END | took 1179s 05:48:16 INFO - Completed test suite (00:19:39) 05:48:16 INFO - javascript benchmark 05:48:16 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8599.198726937746, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3277.4919887417445, 3312.1719570107475, 3325.7006869381753, 3334.033130392185, 3338.0653417043227, 6414.0, 6421.582597131183, 6456.289808121109, 6473.0, 6514.543981921267, 6336.112944187817, 6458.547901646886, 6464.8060558183215, 6470.3529647035275, 6489.870202595946, 5837.795677151301, 5860.648361098337, 5886.381929897363, 5894.233749612566, 5903.291605007405, 5933.991221492357, 5953.970230148843, 5954.047352423613, 5954.880902381949, 5966.761329546813, 5851.736671849777, 5908.291005079396, 5989.191459153002, 5999.61002534836, 6012.3687012863675, 5952.4642782149385, 5993.520518358543, 6031.125486804411, 6034.788782392595, 6113.724882380259, 5816.1275808628625, 5895.55783316253, 5934.97032514839, 5935.0, 6014.248218972629, 6250.718717657716, 6284.685765711696, 6306.747730090791, 6331.651759153245, 6344.777932772331, 6902.0, 6946.79159625212, 6950.992106144581, 6999.23008469068, 7053.0830991970715, 6724.495662825308, 7014.403775679073, 7049.436045116429, 7116.857662846766, 7131.928680713178, 6400.679966001728, 6403.711832967481, 6412.903806442907, 6464.224293084813, 6474.093626892239, 7112.288771122846, 7113.181984071794, 7117.964410177916, 7130.429565634737, 7132.500724949204, 6733.427658648971, 6744.83137921546, 6781.11845460087, 6807.421369183576, 6825.5222134451105, 6117.351566315546, 6822.0, 6899.93100069003, 6922.5154239202775, 6927.238003819576, 6810.795676129724, 6834.555753875982, 6858.931410685929, 6901.033855260268, 6938.306169383021, 6694.59832410057, 6843.760468383683, 6889.104416425833, 6940.479464040217, 6979.82550436233, 5361.329833770778, 5364.6512976656395, 5452.100403433468, 5466.863328416822, 5473.2063850741415, 4667.276572131325, 4764.380630518011, 4780.880477988078, 4802.951970480321, 4818.638602104857, 5959.28488581373, 5984.491318237999, 6023.548233882389, 6044.214252147281, 6058.939410605925, 6725.125733654593, 6884.552504087218, 6903.1716194057035, 6916.792496225121, 6927.134108236471, 5984.910226346608, 5994.910076348859, 6003.939960600425, 6023.66869822164, 6029.186059881859, 5962.463378295887, 6045.274567051894, 6049.969750151221, 6052.394760523913, 6054.7880824171825, 6742.123523941954, 6776.830579235559, 6789.762358317435, 6878.002689610079, 6885.793426197222, 6982.79051628452, 6992.265812089658, 7011.474139439664, 7049.259827718016, 7120.786376408612, 6474.4820414365795, 6735.225449073419, 6745.0219718139615, 6829.52193346461, 6846.281140480178, 6806.319368063154, 6823.0, 6877.65611719402, 6882.174139103339, 6906.482013848881, 7007.229204787572, 7046.859062818612, 7078.362947334558, 7101.147862256562, 7123.287671232835, 6666.066750655009, 6702.631355275506, 6734.9326506734305, 6802.591844489347, 6826.214985276558, 6518.250401203923, 6631.602103873783, 6706.262311145868, 6784.423324017514, 6823.420009299265, 6615.239247486601, 6674.799756007327, 6757.358050985148, 6760.93239067603, 6765.1205343305055, 6680.231773346128, 6700.564463309869, 6745.763898263537, 6809.489288303496, 6836.487263455161, 6400.903986440114, 6423.325550817097, 6508.446782023581, 6523.608583485006, 6634.270230274762], "value": 6309.32750755224, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [821.2772759971228, 849.876767868659, 879.5909901895619, 1085.7557049663822, 1114.0808832713014, 40054.799726001365, 40627.1874562509, 40649.1870162597, 40792.18415631686, 40833.59166408335, 38220.85337439874, 38464.80767596158, 38594.8070259649, 38647.22705545894, 38676.80661596688, 7164.641767911597, 7277.3814225790875, 7348.191698913115, 7350.228226036269, 7351.191368949411, 7208.531445456055, 7304.8173795655, 7309.853802923938, 7318.414526837841, 7318.487705860592, 7283.0, 7286.344229019387, 7877.251661092216, 7882.0, 7891.0, 7765.922340776605, 7829.7259595913865, 7833.921660783376, 7844.333231675286, 7846.882296765553, 7689.307962283366, 7768.3008529232075, 7771.145174030852, 7772.378209743207, 7777.805554861117, 37773.244535109145, 37942.81028594867, 38347.80826095852, 38400.42399363984, 38547.42178867319, 3446.672566106241, 3467.1158854492196, 3470.514128022079, 3479.408500554912, 3486.477028445728, 31954.360912781845, 32171.19572010695, 32214.516782248284, 32285.677143228735, 32389.190270243198, 5181.766820493049, 5209.270702101709, 5222.399424066243, 5222.451642577513, 5313.973430132824, 184411.99999999866, 184961.0, 184982.0, 185104.0, 185542.0, 47206.76396617995, 47416.28875566869, 47435.5256447438, 47663.04673906572, 47805.28292075622, 48603.27095093577, 48808.26787598189, 48960.75519622379, 49168.50831491639, 49295.50704492981, 14376.568702938928, 14456.494022709154, 14470.710585788436, 14568.271586420637, 14620.0, 11512.76974460506, 11575.88424115765, 11590.304581725124, 11605.419729013516, 11854.229475084092, 12555.435005424777, 14161.78757318641, 14254.0, 14318.498852540111, 14512.564623061326, 5000.049990501793, 5581.49766521015, 5684.857878553069, 5731.512821410143, 5801.506871915934, 1001.1340190734962, 1003.4280460137797, 1016.2784423059562, 1022.8414595737672, 1026.38416949831, 23987.28038158858, 24298.271051868473, 24311.513769724508, 29657.85171074131, 30384.088477345715, 1086.1962148010573, 1089.6513115802868, 1101.8677758669012, 1102.3330884814573, 1111.377628528027, 12489.687757805947, 12682.175658582162, 12749.872501275055, 12753.426095825711, 12839.935800320938, 232146.0, 232154.0, 233044.0, 233420.0, 233611.0, 52526.0, 52989.73505132527, 53230.73384633052, 53267.46732532625, 53275.20087198695, 1360.6462319796726, 1430.9713805724036, 1442.8845692344587, 1455.6215384000025, 1457.3878970832277, 22867.542649147257, 23056.193033244428, 23088.191913282953, 23419.648705269094, 23553.669495756367, 38683.22633547257, 38998.4150237741, 39004.0, 39005.0, 39071.80464097661, 204134.0, 204147.0, 204834.0, 206692.0, 206863.0, 33421.66578334186, 36992.26015479622, 37451.625483744814, 37881.81059094687, 38162.236755265294, 40784.59215407927, 46703.0, 46729.29906051344, 47202.0, 48713.75643121762, 33977.49033764545, 34046.319073618884, 34236.48645270273, 34295.828520857234, 34526.82736586301, 33274.833625831714, 33377.332453351286, 34271.0, 34294.31411371809, 35171.0, 37803.62196378111, 38891.80554097211, 39129.41305880471, 39415.0, 39524.0, 32470.675293246764, 33184.502232466046, 33418.164545886546, 33761.15597110092, 34322.48516272308, 24372.0, 24435.51128977375, 24472.51054978855, 24778.0, 25168.24495265145], "value": 17286.00553599082, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [563.9651239974648, 578.8842231553689, 581.5783556921235, 581.6771691711101, 586.694918642306, 21804.89097554512, 22706.54586908263, 22856.314310570688, 23017.654735178985, 23028.88485557574, 21875.890620546874, 23725.76274237257, 23919.402014949635, 23946.281611551636, 24046.278611641636, 6630.138082049327, 6713.429358504533, 6753.122094127756, 6775.186977562699, 6780.932190678104, 6585.6048637081685, 6612.636305003223, 6617.371349721769, 6617.867642647144, 6642.368974947372, 5929.970350148244, 6581.835454113638, 6597.406233438989, 6601.042848786947, 6635.170603674541, 6522.836929076763, 6538.738450461976, 6590.5716128451495, 6600.3729645683825, 6603.900941485882, 6033.276006879159, 6097.603655762361, 6113.755449782004, 6126.081087836816, 6135.693215339215, 27540.311492212655, 27797.16608501748, 28886.277843053882, 28913.56629650557, 29395.55906661402, 1970.1922211893054, 1995.8203761661375, 2005.5888542848681, 2026.2401599400225, 2028.7261219735294, 18770.436886893414, 19348.322808701767, 19388.0, 19444.0, 19463.0, 2260.977390226093, 2322.779335963081, 2323.233333000106, 2383.880805959695, 2482.4290413205063, 130054.3497282517, 130886.0, 131522.684773152, 131579.34210328982, 131692.0, 13781.448742050206, 14290.356933937997, 14333.426662933574, 14670.339834707464, 14821.407143714347, 22878.65682014771, 22918.31245062651, 22983.850807459894, 23107.88446057759, 23206.65190022151, 9301.116393942564, 9355.672551460666, 9618.326717129874, 9704.951475242578, 9764.609415623438, 8583.65665373378, 8723.302135829119, 8776.341774366949, 8908.510031948175, 8927.464352138892, 8759.255463285692, 8894.911050889537, 8940.46357218569, 9208.217301529312, 9251.67619133327, 2697.7032526422076, 2747.3955729739423, 2777.5139350613563, 2844.33158207821, 2855.457463082008, 974.4104816585864, 977.5405559387077, 994.3089552760906, 995.2535598301274, 1016.3698506925606, 18751.156197971122, 19172.808271917103, 19605.8039419604, 19724.013799309978, 22844.543109138056, 1002.2483137646765, 1003.8795344558699, 1036.5750042482546, 1046.7330830638139, 1051.2483574244452, 10841.78316433667, 10954.39750813697, 10977.780444391068, 11145.387003714874, 11205.271657342246, 476870.0, 481581.0, 491835.0, 502461.0, 510611.0, 121623.39188304002, 123181.38409307896, 123358.0, 124223.378883105, 125059.0, 1231.1874163052341, 1244.9253044817158, 1287.0347239570322, 1288.5168061976758, 1290.5289569307135, 20943.476413089793, 21125.6831147536, 21188.68216976716, 21393.78606213918, 21911.01400436952, 58634.7068264673, 58673.413265868505, 59349.703251483465, 59890.0, 61540.0, 74295.62852185704, 74798.62600686961, 76643.61678191573, 77052.0, 78049.60975195315, 20328.695069574263, 20672.793272067087, 20809.0, 20969.685454717885, 21026.0, 17362.91318543399, 18101.0, 18204.271829127218, 18986.620267594295, 19138.0, 17642.558936026187, 17763.378281760077, 17799.953005404543, 17816.643667126325, 17939.73090403671, 15015.0, 15121.395144194548, 15334.693306134039, 16944.915275423544, 17299.481015569552, 17730.64538709193, 17824.732629010316, 18000.18999145068, 18007.909960450113, 18212.45362639123, 20314.0, 20402.693959590913, 20690.793092068885, 20735.27426540064, 20743.8962805185, 16915.492535223962, 17164.0, 17166.055866926938, 17185.828141718423, 17349.479515614552], "value": 12107.58367041816, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1333.6465836553316, 1384.5638623833493, 1403.1581051369176, 1409.9929500352496, 1412.3503188533275, 14863.851361486382, 15160.469383571577, 15632.921835390807, 15736.842631573682, 15782.447614333501, 15537.22313884307, 15801.288941997609, 15811.525654230363, 15813.367465301375, 15824.0, 2632.6577544919182, 2677.7188395218514, 2678.3304173956512, 2684.6912605050375, 2705.0937935791535, 2538.073603134861, 2651.4034342273026, 2736.3979924416594, 2760.9585856212175, 2762.4889395461905, 2718.103026001415, 2744.972550274492, 2747.5329194036963, 2748.50526905157, 2748.8213266137636, 2599.2072417912527, 2607.7522635349706, 2646.8544230067337, 2651.6552848129813, 2658.3752818087833, 2502.9374265643323, 2511.0, 2521.34445044288, 2523.3060908250195, 2531.190019193859, 14596.927015364961, 14864.182469964147, 15016.099034057992, 15043.623909402244, 15047.548573542812, 7607.581583012932, 7910.406719496061, 7945.0, 7949.64226609804, 7977.920220797834, 5211.42674305826, 5315.096433606296, 5344.091504444254, 5366.543843773284, 5402.945970540283, 1883.0396497786091, 1898.5253686578355, 1902.5909429472729, 1943.2712732725229, 1960.3236883275247, 26488.748456381232, 26496.867515662492, 26670.333241669112, 26698.733012669818, 26712.59931101035, 6402.199725034371, 6705.362990515893, 6730.93269067303, 6751.864962700718, 6771.661416929134, 16948.74576881348, 16995.40516081931, 17007.0, 17052.14739263032, 17075.0, 7765.417593680384, 8036.276735093869, 8047.637856296481, 8050.194980501903, 8063.879041814377, 7023.789286321418, 7187.281271872771, 7211.314925082109, 7270.127584689765, 7276.308750668678, 5211.7915283389, 5307.0, 5323.148296272578, 5348.0, 5537.058700021006, 1373.5261334839465, 1388.6528367908022, 1544.266473425114, 1551.363940784273, 1574.2522301906731, 865.057087774329, 881.6076845803556, 885.3359980014989, 892.8125093730259, 909.7589138878203, 7334.3765779908235, 7424.443166762514, 7449.962750186214, 7460.813479663052, 7523.811904702427, 935.9812803743887, 954.4845783276953, 956.9569369378395, 973.7711637765119, 977.6480467031863, 5027.396712394536, 5027.421846487628, 5069.8732531687, 5155.7679904404395, 5215.009148261818, 21084.578308433745, 21931.451713706967, 21937.34187974363, 21951.121955121936, 21993.230236941632, 20341.0, 21039.368818935458, 21172.47068823292, 21463.892680536497, 21528.246511372028, 10704.30422022566, 10731.141508679288, 10886.61896833607, 10899.29154604948, 11069.446527673585, 7960.761177164694, 8027.759167224993, 8128.674853005814, 8149.714759983609, 8234.547099909323, 17319.0, 17327.047012414438, 17351.219195135996, 18555.25778968826, 18646.813531864507, 17813.376531821323, 17853.196606153015, 18060.638787224445, 18758.6248275031, 19169.80830191736, 13734.93132534331, 13981.23103229332, 13997.230152341719, 14056.859431405555, 14082.436702532194, 13053.086283960032, 13349.132306400053, 13776.0, 13925.373358198703, 13946.511872084428, 10712.196585256293, 10778.299410538604, 11072.723181920517, 11103.38931358783, 11367.43162841838, 10094.89905100969, 10932.453377330943, 11141.108711302913, 11159.442027898735, 11224.494897729784, 9079.182873541413, 9167.08329167078, 9224.538773061455, 9238.076192380708, 9240.584173712334, 6318.241810982528, 6343.460805831556, 6370.6814659267775, 6399.8080057598345, 6457.225132983884, 6523.151990241238, 6632.436242919406, 6878.724851006104, 7055.541389809646, 7078.68145933424], "value": 6580.606698894369, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [490.86819261941116, 495.9628027897908, 521.5957632834555, 525.5138996428306, 529.0661981602472, 6297.590656607317, 6317.810465686031, 6377.61734295942, 6395.58428702134, 6397.0, 6027.879442411149, 6183.752649893999, 6201.426408040669, 6235.5946863453955, 6336.556441049129, 5058.772355244005, 5080.745962701869, 5083.389993200821, 5107.591392688576, 5113.795448182068, 4987.501249875019, 5041.72270525121, 5049.293098966147, 5056.823011194609, 5097.0, 4771.8091276348905, 4958.900821983558, 5022.995400919813, 5027.396712394518, 5027.717931927354, 4991.151504244287, 5039.546440820343, 5042.495750424965, 5052.115879721053, 5095.0, 4522.253828118356, 4528.139653465831, 4531.13908357411, 4537.4328208973875, 4537.954620453786, 6183.103449999725, 6190.535709821781, 6212.751489940397, 6215.0, 6275.780347687809, 5717.25623684776, 5753.252077229975, 5775.509081728058, 5802.0, 5824.854378640525, 6597.472202223858, 6607.867842643168, 6648.401643852028, 6665.366790154928, 6667.566338286539, 4849.9272510912015, 4867.610591152735, 4869.464358920516, 4926.926096108561, 4972.975135124338, 6873.20958089821, 7023.454839935206, 7030.191527974297, 7066.258042905523, 7075.363217310364, 5024.824131155392, 5037.899242015139, 5046.621503387188, 5059.139946209079, 5086.237064440364, 5072.163093089673, 5079.3650793650795, 5096.617753668415, 5103.464136265713, 5105.923411148836, 5728.2504397888415, 5781.682007489629, 5817.7091145442555, 5818.301803783573, 5827.796027139115, 6688.799336019927, 6693.832654183587, 6700.195976482853, 6749.223839258548, 6790.864182716318, 1666.7749853769828, 1690.4590531029953, 1734.7224444089138, 1760.542259012666, 1764.9647007059787, 1150.108665784024, 1222.87771222877, 1232.383808095952, 1241.1002023532867, 1242.9627111186678, 5644.379118296984, 5795.565332600072, 5810.0994345875615, 5832.737526811304, 5865.0, 6542.803715888531, 6635.369639884299, 6635.8009259722285, 6663.233728121231, 6686.331366863372, 5683.147527870852, 5751.798687046017, 5758.3090029196765, 5814.302283725895, 5852.8536786579825, 3581.8567257309414, 3605.5938184108218, 3613.8915832525067, 3621.6740493355724, 3628.4920111184456, 6504.902426463606, 6542.345765423514, 6597.703103360361, 6619.768308109193, 6658.3674550917585, 6887.242403335629, 6936.2023367312395, 6972.860542789116, 6985.126859142607, 7056.682449289794, 6492.967535162294, 6582.901256481061, 6657.367550082734, 6664.300248473937, 6702.83242918931, 6811.93188068113, 6817.216020157547, 6823.28355522663, 6895.241523432519, 6914.654267286716, 6735.25912149673, 6741.292164322872, 6803.965980170067, 6827.453803695792, 6855.245922948571, 6465.967670161619, 6545.022014983076, 6584.539082264196, 6617.768378106935, 6622.602643841385, 4906.803727850846, 4973.204287314013, 4982.6512144149565, 4995.525425084611, 4997.177723496843, 6678.365555272241, 6682.627667178276, 6752.3922846944015, 6772.424343930624, 6813.0, 6575.736970521126, 6583.44040756541, 6623.470122390294, 6639.900401494078, 6684.197896252481, 6425.935740642721, 6481.740730370732, 6518.250401203923, 6535.183102112236, 6558.344165583403, 6306.432421082125, 6549.443297319591, 6553.035413574718, 6583.144191255106, 6601.174853143357, 6256.403592509239, 6439.590743775251, 6522.771702990372, 6574.605523668595, 6639.634820084749, 6175.541696649891, 6400.45596124316, 6414.166158399378, 6415.101885735908, 6451.903221451776], "value": 5098.113022238504, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [877.4209022045451, 905.9275257979363, 921.9124183202593, 923.9630414783406, 940.1397721085206, 18709.906450467744, 19466.902665486687, 19490.122944467497, 19527.316543920966, 19546.31587894424, 17355.566110847234, 18105.4568362949, 21713.457163570918, 21751.12995480183, 21761.23835665752, 909.9727008189765, 918.4718786697642, 920.6363486422858, 921.3320342751518, 922.4649703172144, 969.5491596407669, 976.1458723616835, 978.2320878110685, 981.8625392445064, 982.4301904895179, 921.6313474610142, 989.1789814453986, 1004.6132239087967, 1022.3559157730656, 1028.0850043461326, 978.936369136011, 979.5591983607369, 983.5672304186136, 985.9408435493857, 989.4261328429529, 733.8899165125221, 737.1117803047315, 740.4298690008663, 740.9259074092602, 741.1587847792794, 18268.269269229215, 18442.723359149622, 18491.63016739671, 18502.629947400976, 19483.318083866998, 20373.0, 20525.17899284027, 21124.683129753066, 21176.15295388198, 21403.036863341033, 16328.346866125341, 16383.525482706495, 16476.0, 16523.586910327216, 16536.338546458126, 3673.3571624965793, 3721.813909304524, 3727.422249551324, 3729.8881033568764, 3734.3651579231596, 121929.39035304767, 124498.0, 127595.36202319022, 128118.35940820236, 128996.35501822525, 15716.29276682552, 16010.759838602431, 16143.0, 16257.349706011864, 16304.836951630568, 30258.24354391114, 30501.542476862865, 30507.084787456413, 30638.38723225523, 30765.0, 7932.167122452175, 7950.403719721044, 7985.842052902297, 8038.799030024296, 8088.312493438006, 3789.9621003789607, 3864.091938394475, 3866.7679939203736, 3870.9225815483533, 3876.7480113792512, 5044.066847633199, 5186.948130518722, 5204.115300398866, 5271.42014378418, 5330.360356757136, 936.0545848692869, 955.7945041815904, 957.6025949231131, 978.295627148452, 979.0307595480565, 694.1011390249639, 711.4557363616838, 718.7843646905907, 720.4884531982246, 730.2551397574445, 11634.243774154653, 11720.782781205944, 11829.0, 12173.452194651261, 12298.323592202336, 694.4687314204638, 699.8565294114694, 701.9508634395544, 702.9297070293032, 704.9788506344818, 5462.562994960394, 5506.889862202734, 5550.306211723535, 5603.15952607104, 5657.745401456862, 112616.0, 113401.43299283451, 114511.0, 114635.42682286703, 115156.42421787838, 96580.51709741406, 98963.50518247363, 100968.0, 101345.0, 103927.0, 87592.5620371894, 88507.0, 89356.5532172348, 91675.0, 92140.0, 12238.571649992207, 12429.45760458265, 12763.170393924365, 12917.22496650204, 13115.868841311465, 41056.58943410647, 41901.0, 42125.789371052946, 42681.35977960271, 43784.124317514106, 72097.27902721116, 72120.63939680268, 72569.6371518139, 74290.0, 76051.61974190094, 17706.11469426498, 17808.3767068152, 17922.283108676027, 17944.461666150037, 18468.07659616987, 21295.0, 21300.7869921305, 21455.141794328676, 21462.0, 21989.0, 18729.344472943383, 19174.328898488486, 19208.13563389679, 19349.516262093, 19617.70573441428, 17554.648907022045, 18626.348077817212, 19504.21983120716, 19792.505187370432, 20105.597888041866, 17741.201645925707, 17809.287628494716, 17954.371596994042, 18602.81397186011, 18781.436556903314, 13452.5291614793, 13620.250886201355, 13899.166050036625, 13909.791353129509, 13919.095258808145, 14400.927995359956, 14618.342174601956, 14680.706385872008, 14790.955034857887, 14881.553553393416], "value": 9126.657545108868, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1517.0000000000002, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [109.0, 107.0, 109.0, 108.0, 117.0, 109.0, 119.0, 100.0, 115.0, 114.0], "value": 110.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [144.0, 132.0, 171.0, 173.0, 117.0, 154.0, 152.0, 119.0, 194.0, 117.0], "value": 147.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 165.0, 162.0, 164.0, 173.0, 176.0, 167.0, 163.0, 164.0, 166.0], "value": 166.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 83.0, 74.0, 166.0, 80.0, 73.0, 73.0, 74.0, 153.0, 76.0], "value": 92.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 80.0, 132.0, 82.0, 80.0, 80.0, 131.0, 82.0, 80.0, 130.0], "value": 96.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [123.0, 124.0, 122.0, 114.0, 118.0, 116.0, 125.0, 115.0, 114.0, 115.0], "value": 118.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 150.0, 148.0, 148.0, 148.0, 148.0, 149.0, 150.0, 147.0, 151.0], "value": 148.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 94.0, 95.0, 94.0, 94.0, 101.0, 94.0, 94.0, 94.0, 96.0], "value": 95.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 54.0, 55.0, 54.0, 55.0, 53.0, 53.0, 57.0, 51.0, 53.0], "value": 54.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [39.0, 38.0, 39.0, 39.0, 38.0, 45.0, 42.0, 38.0, 38.0, 38.0], "value": 39.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 81.0, 76.0, 80.0, 84.0, 75.0, 78.0, 82.0, 77.0, 86.0], "value": 79.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [122.0, 133.0, 116.0, 117.0, 121.0, 137.0, 123.0, 120.0, 115.0, 171.0], "value": 127.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [174.0, 172.0, 183.0, 175.0, 169.0, 174.0, 174.0, 168.0, 168.0, 172.0], "value": 172.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 66.0, 65.0, 70.0, 63.0, 68.0, 66.0, 73.0, 66.0, 65.0], "value": 67.2, "unit": "score"}]}]} 05:48:16 INFO - Return code: 0 05:48:16 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 05:48:16 INFO - # TBPL SUCCESS # 05:48:16 INFO - Running post-action listener: _package_coverage_data 05:48:16 INFO - Running post-action listener: _resource_record_post_action 05:48:16 INFO - [mozharness: 2017-09-07 12:48:16.537192Z] Finished run-tests step (success) 05:48:16 INFO - Running post-run listener: _resource_record_post_run 05:48:16 INFO - Total resource usage - Wall time: 1196s; CPU: 13.0%; Read bytes: 17125376; Write bytes: 401068032; Read time: 7956; Write time: 441484 05:48:16 INFO - TinderboxPrint: CPU usage
13.3% 05:48:16 INFO - TinderboxPrint: I/O read bytes / time
17,125,376 / 7,956 05:48:16 INFO - TinderboxPrint: I/O write bytes / time
401,068,032 / 441,484 05:48:16 INFO - TinderboxPrint: CPU idle
8,262.0 (86.7%) 05:48:16 INFO - TinderboxPrint: CPU user
1,200.3 (12.6%) 05:48:16 INFO - TinderboxPrint: Swap in / out
0 / 0 05:48:16 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 4096; Write bytes: 117411840; Read time: 64; Write time: 107284 05:48:16 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 05:48:16 INFO - run-tests - Wall time: 1180s; CPU: 13.0%; Read bytes: 15376384; Write bytes: 283262976; Read time: 7860; Write time: 334176 05:48:17 INFO - Running post-run listener: _upload_blobber_files 05:48:17 INFO - Blob upload gear active. 05:48:17 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 05:48:17 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 05:48:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 05:48:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 05:48:17 INFO - (blobuploader) - INFO - Open directory for files ... 05:48:17 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 05:48:17 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:48:17 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:48:18 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 05:48:18 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:48:18 INFO - (blobuploader) - INFO - Done attempting. 05:48:18 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 05:48:18 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:48:18 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:48:19 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 05:48:19 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:48:19 INFO - (blobuploader) - INFO - Done attempting. 05:48:19 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 05:48:19 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:48:19 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:48:20 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 05:48:20 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:48:20 INFO - (blobuploader) - INFO - Done attempting. 05:48:20 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 05:48:20 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:48:20 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:48:23 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 05:48:23 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:48:23 INFO - (blobuploader) - INFO - Done attempting. 05:48:23 INFO - (blobuploader) - INFO - Iteration through files over. 05:48:23 INFO - Return code: 0 05:48:23 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 05:48:23 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 05:48:23 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e388dcc1994da7bfb1fc06c821c2b9188e50d26796dd3a9874a26c8b3b5aaab12e5026fc53f4d4128940895b7c5313e46b98f35b856c4bd36e8857e13d9f749d", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/916e98c01e1b98d4a10cfac51bfa8dcbc983219d4633cece263974d391af164117720975682b8fb4a8ae0d4d525a7ee773b3de1639553f3d960938b21a1f05a6", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/fb6bc24ad42fa7d66aa664d0d38e0bae3695d512299f2092f73fcfb08b69d6e349777a1808ebb43f18f1cf5e723535c6aad896a3eaf7c9076e934fa24b0d1f3f", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/fa683b24ef4f1a49a7bd09bf12d83284e13879902f4be27e92bdb2be1bad4f5809e83b14dac15ff7d796ca7c9b87f5200f2f835eef7f9aca03038047d5544803"} 05:48:23 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 05:48:23 INFO - Writing to file /builds/slave/test/properties/blobber_files 05:48:23 INFO - Contents: 05:48:23 INFO - blobber_files:{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e388dcc1994da7bfb1fc06c821c2b9188e50d26796dd3a9874a26c8b3b5aaab12e5026fc53f4d4128940895b7c5313e46b98f35b856c4bd36e8857e13d9f749d", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/916e98c01e1b98d4a10cfac51bfa8dcbc983219d4633cece263974d391af164117720975682b8fb4a8ae0d4d525a7ee773b3de1639553f3d960938b21a1f05a6", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/fb6bc24ad42fa7d66aa664d0d38e0bae3695d512299f2092f73fcfb08b69d6e349777a1808ebb43f18f1cf5e723535c6aad896a3eaf7c9076e934fa24b0d1f3f", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/fa683b24ef4f1a49a7bd09bf12d83284e13879902f4be27e92bdb2be1bad4f5809e83b14dac15ff7d796ca7c9b87f5200f2f835eef7f9aca03038047d5544803"} 05:48:23 INFO - Running post-run listener: copy_logs_to_upload_dir 05:48:23 INFO - Copying logs to upload dir... 05:48:23 INFO - mkdir: /builds/slave/test/build/upload/logs 05:48:23 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1259.594057 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 59 secs) (at 2017-09-07 05:48:23.786283) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-07 05:48:23.789818) ========= 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=00204705a9daa57ed339a427000001b9-1504787241.684952-1206371513 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e388dcc1994da7bfb1fc06c821c2b9188e50d26796dd3a9874a26c8b3b5aaab12e5026fc53f4d4128940895b7c5313e46b98f35b856c4bd36e8857e13d9f749d", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/916e98c01e1b98d4a10cfac51bfa8dcbc983219d4633cece263974d391af164117720975682b8fb4a8ae0d4d525a7ee773b3de1639553f3d960938b21a1f05a6", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/fb6bc24ad42fa7d66aa664d0d38e0bae3695d512299f2092f73fcfb08b69d6e349777a1808ebb43f18f1cf5e723535c6aad896a3eaf7c9076e934fa24b0d1f3f", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/fa683b24ef4f1a49a7bd09bf12d83284e13879902f4be27e92bdb2be1bad4f5809e83b14dac15ff7d796ca7c9b87f5200f2f835eef7f9aca03038047d5544803"} build_url:https://queue.taskcluster.net/v1/task/BaAK-As6Q66QQapQlMtaJw/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011198 build_url: 'https://queue.taskcluster.net/v1/task/BaAK-As6Q66QQapQlMtaJw/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e388dcc1994da7bfb1fc06c821c2b9188e50d26796dd3a9874a26c8b3b5aaab12e5026fc53f4d4128940895b7c5313e46b98f35b856c4bd36e8857e13d9f749d", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/916e98c01e1b98d4a10cfac51bfa8dcbc983219d4633cece263974d391af164117720975682b8fb4a8ae0d4d525a7ee773b3de1639553f3d960938b21a1f05a6", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/fb6bc24ad42fa7d66aa664d0d38e0bae3695d512299f2092f73fcfb08b69d6e349777a1808ebb43f18f1cf5e723535c6aad896a3eaf7c9076e934fa24b0d1f3f", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/fa683b24ef4f1a49a7bd09bf12d83284e13879902f4be27e92bdb2be1bad4f5809e83b14dac15ff7d796ca7c9b87f5200f2f835eef7f9aca03038047d5544803"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-07 05:48:23.825895) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-07 05:48:23.826233) ========= 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=00204705a9daa57ed339a427000001b9-1504787241.684952-1206371513 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004417 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-07 05:48:23.909535) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-07 05:48:23.909858) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-07 05:48:23.910173) ========= ========= Total master_lag: 0.19 =========