builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-057 starttime: 1502670259.36 results: success (0) revision: 3bfcbdf5c6c381d5a8febb5c209e27a69fb89f9b ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-08-13 17:24:19.361425) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-08-13 17:24:19.362304) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-08-13 17:24:19.362668) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-08-13 17:24:19.425385) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-13 17:24:19.425705) ========= 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=934fc3100db09dcb9af4d4b6000001ab-1502669820.30246-1911042536 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-08-13 17:24:19-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 46.3M=0s 2017-08-13 17:24:19 (46.3 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.195993 ========= master_lag: 0.05 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-13 17:24:19.673742) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-08-13 17:24:19.677139) ========= 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=934fc3100db09dcb9af4d4b6000001ab-1502669820.30246-1911042536 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019232 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-08-13 17:24:19.733259) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-13 17:24:19.733657) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 3bfcbdf5c6c381d5a8febb5c209e27a69fb89f9b --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 3bfcbdf5c6c381d5a8febb5c209e27a69fb89f9b --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=934fc3100db09dcb9af4d4b6000001ab-1502669820.30246-1911042536 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-08-13 17:24:19,915 truncating revision to first 12 chars 2017-08-13 17:24:19,915 Setting DEBUG logging. 2017-08-13 17:24:19,915 attempt 1/10 2017-08-13 17:24:19,915 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/3bfcbdf5c6c3?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-08-13 17:24:20,324 unpacking tar archive at: mozilla-central-3bfcbdf5c6c3/testing/mozharness/ program finished with exit code 0 elapsedTime=0.698241 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-13 17:24:20.448612) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-08-13 17:24:20.448981) ========= script_repo_revision: 3bfcbdf5c6c381d5a8febb5c209e27a69fb89f9b ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-08-13 17:24:20.449382) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-08-13 17:24:20.449688) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-08-13 17:24:20.459099) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 57 secs) (at 2017-08-13 17:24:20.459428) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=934fc3100db09dcb9af4d4b6000001ab-1502669820.30246-1911042536 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 17:24:20 INFO - MultiFileLogger online at 20170813 17:24:20 in /builds/slave/test 17:24:20 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 17:24:20 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 17:24:20 INFO - {'append_to_log': False, 17:24:20 INFO - 'base_work_dir': '/builds/slave/test', 17:24:20 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 17:24:20 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 17:24:20 INFO - 'branch': 'Firefox-Non-PGO', 17:24:20 INFO - 'buildbot_json_path': 'buildprops.json', 17:24:20 INFO - 'code_coverage': False, 17:24:20 INFO - 'config_files': ('talos/linux_config.py',), 17:24:20 INFO - 'default_actions': ('clobber', 17:24:20 INFO - 'read-buildbot-config', 17:24:20 INFO - 'download-and-extract', 17:24:20 INFO - 'populate-webroot', 17:24:20 INFO - 'create-virtualenv', 17:24:20 INFO - 'install', 17:24:20 INFO - 'setup-mitmproxy', 17:24:20 INFO - 'run-tests'), 17:24:20 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 17:24:20 INFO - 'disable_ccov_upload': False, 17:24:20 INFO - 'download_minidump_stackwalk': True, 17:24:20 INFO - 'download_symbols': 'ondemand', 17:24:20 INFO - 'enable_stylo': False, 17:24:20 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 17:24:20 INFO - 'tooltool.py': '/tools/tooltool.py', 17:24:20 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 17:24:20 INFO - '/tools/misc-python/virtualenv.py')}, 17:24:20 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 17:24:20 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 17:24:20 INFO - 'gecko_profile': False, 17:24:20 INFO - 'gecko_profile_interval': 0, 17:24:20 INFO - 'installer_path': 'installer.exe', 17:24:20 INFO - 'log_level': 'info', 17:24:20 INFO - 'log_name': 'talos', 17:24:20 INFO - 'log_to_console': True, 17:24:20 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 17:24:20 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 17:24:20 INFO - 'opt_config_files': (), 17:24:20 INFO - 'pip_index': False, 17:24:20 INFO - 'suite': 'dromaeojs-e10s', 17:24:20 INFO - 'system_bits': '32', 17:24:20 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 17:24:20 INFO - 'title': 'talos-linux64-ix-057', 17:24:20 INFO - 'tooltool_cache': '/builds/tooltool_cache', 17:24:20 INFO - 'use_talos_json': True, 17:24:20 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 17:24:20 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 17:24:20 INFO - 'work_dir': 'build'} 17:24:20 INFO - [mozharness: 2017-08-14 00:24:20.855883Z] Running clobber step. 17:24:20 INFO - Running pre-action listener: _resource_record_pre_action 17:24:20 INFO - Running main action method: clobber 17:24:20 INFO - rmtree: /builds/slave/test/build 17:24:20 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 17:24:21 INFO - Running post-action listener: _resource_record_post_action 17:24:21 INFO - [mozharness: 2017-08-14 00:24:21.846507Z] Finished clobber step (success) 17:24:21 INFO - [mozharness: 2017-08-14 00:24:21.846609Z] Running read-buildbot-config step. 17:24:21 INFO - Running pre-action listener: _resource_record_pre_action 17:24:21 INFO - Running main action method: read_buildbot_config 17:24:21 INFO - Using buildbot properties: 17:24:21 INFO - { 17:24:21 INFO - "project": "", 17:24:21 INFO - "product": "firefox", 17:24:21 INFO - "who": "archaeopteryx@coole-files.de", 17:24:21 INFO - "installer_path": "public/build/target.tar.bz2", 17:24:21 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 17:24:21 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 17:24:21 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-e10s", 17:24:21 INFO - "stage_platform": "linux64", 17:24:21 INFO - "basedir": "/builds/slave/test", 17:24:21 INFO - "buildnumber": 1074, 17:24:21 INFO - "platform": "ubuntu64_hw", 17:24:21 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 17:24:21 INFO - "slavebuilddir": "test", 17:24:21 INFO - "taskId": "eVkzfN3iSZ-JpmQLzvqFhw", 17:24:21 INFO - "branch": "mozilla-central", 17:24:21 INFO - "script_repo_revision": "production", 17:24:21 INFO - "revision": "3bfcbdf5c6c381d5a8febb5c209e27a69fb89f9b", 17:24:21 INFO - "slavename": "talos-linux64-ix-057", 17:24:21 INFO - "repo_path": "mozilla-central" 17:24:21 INFO - } 17:24:21 INFO - Finding installer, test and symbols from parent task. 17:24:21 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/eVkzfN3iSZ-JpmQLzvqFhw'}, attempt #1 17:24:22 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/eVkzfN3iSZ-JpmQLzvqFhw'}, attempt #1 17:24:22 INFO - Task dependencies: LPo6Qd1VS8e-mSF6G8gTBA 17:24:22 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/LPo6Qd1VS8e-mSF6G8gTBA'}, attempt #1 17:24:23 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/LPo6Qd1VS8e-mSF6G8gTBA/artifacts/public/build/target.tar.bz2 17:24:23 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/LPo6Qd1VS8e-mSF6G8gTBA/artifacts/public/build/target.test_packages.json 17:24:23 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/LPo6Qd1VS8e-mSF6G8gTBA/artifacts/public/build/target.crashreporter-symbols.zip 17:24:23 INFO - Running post-action listener: _resource_record_post_action 17:24:23 INFO - [mozharness: 2017-08-14 00:24:23.204038Z] Finished read-buildbot-config step (success) 17:24:23 INFO - [mozharness: 2017-08-14 00:24:23.204256Z] Running download-and-extract step. 17:24:23 INFO - Running pre-action listener: _resource_record_pre_action 17:24:23 INFO - Running main action method: download_and_extract 17:24:23 INFO - mkdir: /builds/slave/test/build/tests 17:24:23 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')]} 17:24:23 INFO - trying https://queue.taskcluster.net/v1/task/LPo6Qd1VS8e-mSF6G8gTBA/artifacts/public/build/target.test_packages.json 17:24:23 INFO - Downloading https://queue.taskcluster.net/v1/task/LPo6Qd1VS8e-mSF6G8gTBA/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 17:24:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/LPo6Qd1VS8e-mSF6G8gTBA/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 17:24:23 INFO - Downloaded 989 bytes. 17:24:23 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 17:24:23 INFO - Using the following test package requirements: 17:24:23 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 17:24:23 INFO - u'common': [u'target.common.tests.zip'], 17:24:23 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 17:24:23 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 17:24:23 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 17:24:23 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 17:24:23 INFO - u'mozbase': [u'target.common.tests.zip'], 17:24:23 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 17:24:23 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 17:24:23 INFO - u'web-platform': [u'target.common.tests.zip', 17:24:23 INFO - u'target.web-platform.tests.tar.gz'], 17:24:23 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 17:24:23 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 17:24:23 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/LPo6Qd1VS8e-mSF6G8gTBA/artifacts/public/build/target.common.tests.zip 17:24:23 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/LPo6Qd1VS8e-mSF6G8gTBA/artifacts/public/build/target.common.tests.zip'}, attempt #1 17:24:23 INFO - Fetch https://queue.taskcluster.net/v1/task/LPo6Qd1VS8e-mSF6G8gTBA/artifacts/public/build/target.common.tests.zip into memory 17:24:24 INFO - Content-Length response header: 54034620 17:24:24 INFO - Bytes received: 54034620 17:24:36 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 17:24:36 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/LPo6Qd1VS8e-mSF6G8gTBA/artifacts/public/build/target.common.tests.zip 17:24:36 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/LPo6Qd1VS8e-mSF6G8gTBA/artifacts/public/build/target.common.tests.zip'}, attempt #1 17:24:36 INFO - Fetch https://queue.taskcluster.net/v1/task/LPo6Qd1VS8e-mSF6G8gTBA/artifacts/public/build/target.common.tests.zip into memory 17:24:37 INFO - Content-Length response header: 54034620 17:24:37 INFO - Bytes received: 54034620 17:24:51 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/LPo6Qd1VS8e-mSF6G8gTBA/artifacts/public/build/target.talos.tests.zip 17:24:51 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/LPo6Qd1VS8e-mSF6G8gTBA/artifacts/public/build/target.talos.tests.zip'}, attempt #1 17:24:51 INFO - Fetch https://queue.taskcluster.net/v1/task/LPo6Qd1VS8e-mSF6G8gTBA/artifacts/public/build/target.talos.tests.zip into memory 17:24:51 INFO - Content-Length response header: 14496050 17:24:51 INFO - Bytes received: 14496050 17:24:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:24:52 INFO - trying https://queue.taskcluster.net/v1/task/LPo6Qd1VS8e-mSF6G8gTBA/artifacts/public/build/target.tar.bz2 17:24:52 INFO - Downloading https://queue.taskcluster.net/v1/task/LPo6Qd1VS8e-mSF6G8gTBA/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 17:24:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/LPo6Qd1VS8e-mSF6G8gTBA/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 17:24:53 INFO - Downloaded 61718089 bytes. 17:24:53 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/LPo6Qd1VS8e-mSF6G8gTBA/artifacts/public/build/target.tar.bz2 17:24:53 INFO - mkdir: /builds/slave/test/properties 17:24:53 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 17:24:53 INFO - Writing to file /builds/slave/test/properties/build_url 17:24:53 INFO - Contents: 17:24:53 INFO - build_url:https://queue.taskcluster.net/v1/task/LPo6Qd1VS8e-mSF6G8gTBA/artifacts/public/build/target.tar.bz2 17:24:53 INFO - Running post-action listener: _resource_record_post_action 17:24:53 INFO - Running post-action listener: set_extra_try_arguments 17:24:53 INFO - [mozharness: 2017-08-14 00:24:53.523957Z] Finished download-and-extract step (success) 17:24:53 INFO - [mozharness: 2017-08-14 00:24:53.524121Z] Running populate-webroot step. 17:24:53 INFO - Running pre-action listener: _resource_record_pre_action 17:24:53 INFO - Running main action method: populate_webroot 17:24:53 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 17:24:53 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 17:24:53 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 17:24:53 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:24:53 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 17:24:53 INFO - 'tests': ['damp', 'tps']}, 17:24:53 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 17:24:53 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 17:24:53 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 17:24:53 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 17:24:53 INFO - 'other-e10s': {'tests': ['a11yr', 17:24:53 INFO - 'ts_paint', 17:24:53 INFO - 'tpaint', 17:24:53 INFO - 'sessionrestore', 17:24:53 INFO - 'sessionrestore_many_windows', 17:24:53 INFO - 'sessionrestore_no_auto_restore', 17:24:53 INFO - 'tabpaint']}, 17:24:53 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 17:24:53 INFO - 'perf-reftest-singletons-e10s': {'tests': ['bloom_basic_singleton']}, 17:24:53 INFO - 'svgr-e10s': {'tests': ['tsvgx', 17:24:53 INFO - 'tsvgr_opacity', 17:24:53 INFO - 'tart', 17:24:53 INFO - 'tscrollx', 17:24:53 INFO - 'tsvg_static']}, 17:24:53 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 17:24:53 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 17:24:53 INFO - 'talos_options': ['--mitmproxy', 17:24:53 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 17:24:53 INFO - '--firstNonBlankPaint'], 17:24:53 INFO - 'tests': ['tp6_google', 17:24:53 INFO - 'tp6_youtube', 17:24:53 INFO - 'tp6_amazon', 17:24:53 INFO - 'tp6_facebook']}, 17:24:53 INFO - 'tp6-stylo-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 17:24:53 INFO - 'talos_options': ['--stylo', 17:24:53 INFO - '--mitmproxy', 17:24:53 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 17:24:53 INFO - '--firstNonBlankPaint'], 17:24:53 INFO - 'tests': ['tp6_google', 17:24:53 INFO - 'tp6_youtube', 17:24:53 INFO - 'tp6_amazon', 17:24:53 INFO - 'tp6_facebook']}, 17:24:53 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 17:24:53 INFO - 'talos_options': ['--stylo', 17:24:53 INFO - '--stylo-threads=1', 17:24:53 INFO - '--mitmproxy', 17:24:53 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 17:24:53 INFO - '--firstNonBlankPaint'], 17:24:53 INFO - 'tests': ['tp6_google', 17:24:53 INFO - 'tp6_youtube', 17:24:53 INFO - 'tp6_amazon', 17:24:53 INFO - 'tp6_facebook']}, 17:24:53 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 17:24:53 INFO - 'talos_options': ['--xperf_path', 17:24:53 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:24:53 INFO - 'tests': ['tp5n']}}} 17:24:53 INFO - Running post-action listener: _resource_record_post_action 17:24:53 INFO - [mozharness: 2017-08-14 00:24:53.534873Z] Finished populate-webroot step (success) 17:24:53 INFO - [mozharness: 2017-08-14 00:24:53.534963Z] Running create-virtualenv step. 17:24:53 INFO - Running pre-action listener: _resource_record_pre_action 17:24:53 INFO - Running main action method: create_virtualenv 17:24:53 INFO - Creating virtualenv /builds/slave/test/build/venv 17:24:53 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 17:24:53 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 17:24:53 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 17:24:53 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 17:24:53 INFO - Using real prefix '/usr' 17:24:53 INFO - New python executable in /builds/slave/test/build/venv/bin/python 17:24:54 INFO - Installing distribute.............................................................................................................................................................................................done. 17:24:56 INFO - Installing pip.................done. 17:24:56 INFO - Return code: 0 17:24:56 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 17:24:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 17:24:56 INFO - Reading from file tmpfile_stdout 17:24:56 INFO - Output received: 17:24:56 INFO - pip 1.5.5 from /builds/slave/test/build/venv/local/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 17:24:56 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 17:24:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:24:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:24:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:24:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:24:56 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xef81f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c5a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1266b20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1269f00>, '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 0x1264ba0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1265050>, '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': '934fc3100db09dcb9af4d4b6000001ab-1502669820.30246-1911042536', '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 17:24:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 17:24:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 17:24:56 INFO - Using env: {'DISPLAY': ':0', 17:24:56 INFO - 'HOME': '/home/cltbld', 17:24:56 INFO - 'LANG': 'en_US.UTF-8', 17:24:56 INFO - 'LANGUAGE': 'en_US:en', 17:24:56 INFO - 'LOGNAME': 'cltbld', 17:24:56 INFO - 'MAIL': '/var/mail/cltbld', 17:24:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:24:56 INFO - 'MOZ_NO_REMOTE': '1', 17:24:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:24:56 INFO - 'NO_EM_RESTART': '1', 17:24:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:24:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:24:56 INFO - 'PWD': '/builds/slave/test', 17:24:56 INFO - 'SHELL': '/bin/bash', 17:24:56 INFO - 'SHLVL': '1', 17:24:56 INFO - 'TERM': 'linux', 17:24:56 INFO - 'TMOUT': '86400', 17:24:56 INFO - 'USER': 'cltbld', 17:24:56 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1502669820.30246-1911042536', 17:24:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:24:56 INFO - '_': '/tools/buildbot/bin/python'} 17:24:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:24:56 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 17:24:56 INFO - Cleaning up... 17:24:56 INFO - Return code: 0 17:24:56 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 17:24:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:24:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:24:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:24:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:24:56 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0xef81f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c5a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1266b20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1269f00>, '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 0x1264ba0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1265050>, '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': '934fc3100db09dcb9af4d4b6000001ab-1502669820.30246-1911042536', '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 17:24:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 17:24:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 17:24:56 INFO - Using env: {'DISPLAY': ':0', 17:24:56 INFO - 'HOME': '/home/cltbld', 17:24:56 INFO - 'LANG': 'en_US.UTF-8', 17:24:56 INFO - 'LANGUAGE': 'en_US:en', 17:24:56 INFO - 'LOGNAME': 'cltbld', 17:24:56 INFO - 'MAIL': '/var/mail/cltbld', 17:24:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:24:56 INFO - 'MOZ_NO_REMOTE': '1', 17:24:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:24:56 INFO - 'NO_EM_RESTART': '1', 17:24:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:24:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:24:56 INFO - 'PWD': '/builds/slave/test', 17:24:56 INFO - 'SHELL': '/bin/bash', 17:24:56 INFO - 'SHLVL': '1', 17:24:56 INFO - 'TERM': 'linux', 17:24:56 INFO - 'TMOUT': '86400', 17:24:56 INFO - 'USER': 'cltbld', 17:24:56 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1502669820.30246-1911042536', 17:24:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:24:56 INFO - '_': '/tools/buildbot/bin/python'} 17:24:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:24:56 INFO - Downloading/unpacking psutil>=3.1.1 17:24:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:24:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:24:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:24:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:24:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 17:24:58 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:24:58 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:24:58 INFO - Installing collected packages: psutil 17:24:58 INFO - Running setup.py install for psutil 17:24:58 INFO - building 'psutil._psutil_linux' extension 17:24:58 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 17:24:59 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 17:24:59 INFO - building 'psutil._psutil_posix' extension 17:24:59 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 17:24:59 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 17:24:59 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:24:59 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:24:59 INFO - Successfully installed psutil 17:24:59 INFO - Cleaning up... 17:24:59 INFO - Return code: 0 17:24:59 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 17:24:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:24:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:24:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:24:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:24:59 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xef81f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c5a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1266b20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1269f00>, '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 0x1264ba0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1265050>, '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': '934fc3100db09dcb9af4d4b6000001ab-1502669820.30246-1911042536', '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 17:24:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 17:24:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 17:24:59 INFO - Using env: {'DISPLAY': ':0', 17:24:59 INFO - 'HOME': '/home/cltbld', 17:24:59 INFO - 'LANG': 'en_US.UTF-8', 17:24:59 INFO - 'LANGUAGE': 'en_US:en', 17:24:59 INFO - 'LOGNAME': 'cltbld', 17:24:59 INFO - 'MAIL': '/var/mail/cltbld', 17:24:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:24:59 INFO - 'MOZ_NO_REMOTE': '1', 17:24:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:24:59 INFO - 'NO_EM_RESTART': '1', 17:24:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:24:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:24:59 INFO - 'PWD': '/builds/slave/test', 17:24:59 INFO - 'SHELL': '/bin/bash', 17:24:59 INFO - 'SHLVL': '1', 17:24:59 INFO - 'TERM': 'linux', 17:24:59 INFO - 'TMOUT': '86400', 17:24:59 INFO - 'USER': 'cltbld', 17:24:59 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1502669820.30246-1911042536', 17:24:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:24:59 INFO - '_': '/tools/buildbot/bin/python'} 17:24:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:24:59 INFO - Downloading/unpacking mozsystemmonitor==0.3 17:24:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:24:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:24:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:24:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:25:00 INFO - Downloading mozsystemmonitor-0.3.tar.gz 17:25:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 17:25:01 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 17:25:01 INFO - Installing collected packages: mozsystemmonitor 17:25:01 INFO - Running setup.py install for mozsystemmonitor 17:25:01 INFO - Successfully installed mozsystemmonitor 17:25:01 INFO - Cleaning up... 17:25:01 INFO - Return code: 0 17:25:01 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 17:25:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:25:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:25:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:25:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:25:01 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0xef81f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c5a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1266b20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1269f00>, '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 0x1264ba0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1265050>, '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': '934fc3100db09dcb9af4d4b6000001ab-1502669820.30246-1911042536', '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 17:25:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 17:25:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 17:25:01 INFO - Using env: {'DISPLAY': ':0', 17:25:01 INFO - 'HOME': '/home/cltbld', 17:25:01 INFO - 'LANG': 'en_US.UTF-8', 17:25:01 INFO - 'LANGUAGE': 'en_US:en', 17:25:01 INFO - 'LOGNAME': 'cltbld', 17:25:01 INFO - 'MAIL': '/var/mail/cltbld', 17:25:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:25:01 INFO - 'MOZ_NO_REMOTE': '1', 17:25:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:25:01 INFO - 'NO_EM_RESTART': '1', 17:25:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:25:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:25:01 INFO - 'PWD': '/builds/slave/test', 17:25:01 INFO - 'SHELL': '/bin/bash', 17:25:01 INFO - 'SHLVL': '1', 17:25:01 INFO - 'TERM': 'linux', 17:25:01 INFO - 'TMOUT': '86400', 17:25:01 INFO - 'USER': 'cltbld', 17:25:01 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1502669820.30246-1911042536', 17:25:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:25:01 INFO - '_': '/tools/buildbot/bin/python'} 17:25:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:25:01 INFO - Downloading/unpacking jsonschema==2.5.1 17:25:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:25:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:25:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:25:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:25:02 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 17:25:02 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 17:25: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 17:25: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 17:25: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 17:25: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 17:25:02 INFO - Downloading functools32-3.2.3-2.tar.gz 17:25:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 17:25:02 INFO - warning: no files found matching '*.txt' 17:25:02 INFO - no previously-included directories found matching 'build' 17:25:02 INFO - no previously-included directories found matching 'dist' 17:25:02 INFO - no previously-included directories found matching '.git*' 17:25:02 INFO - Installing collected packages: jsonschema, functools32 17:25:02 INFO - Running setup.py install for functools32 17:25:02 INFO - warning: no files found matching '*.txt' 17:25:02 INFO - no previously-included directories found matching 'build' 17:25:02 INFO - no previously-included directories found matching 'dist' 17:25:02 INFO - no previously-included directories found matching '.git*' 17:25:02 INFO - Successfully installed jsonschema functools32 17:25:02 INFO - Cleaning up... 17:25:02 INFO - Return code: 0 17:25:02 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 17:25: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')]} 17:25:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:25: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')]} 17:25:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:25: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', '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 0xef81f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c5a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1266b20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1269f00>, '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 0x1264ba0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1265050>, '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': '934fc3100db09dcb9af4d4b6000001ab-1502669820.30246-1911042536', '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 17:25: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', 'functools32==3.2.3-2'] in /builds/slave/test/build 17:25: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 functools32==3.2.3-2 17:25:02 INFO - Using env: {'DISPLAY': ':0', 17:25:02 INFO - 'HOME': '/home/cltbld', 17:25:02 INFO - 'LANG': 'en_US.UTF-8', 17:25:02 INFO - 'LANGUAGE': 'en_US:en', 17:25:02 INFO - 'LOGNAME': 'cltbld', 17:25:02 INFO - 'MAIL': '/var/mail/cltbld', 17:25:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:25:02 INFO - 'MOZ_NO_REMOTE': '1', 17:25:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:25:02 INFO - 'NO_EM_RESTART': '1', 17:25:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:25:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:25:02 INFO - 'PWD': '/builds/slave/test', 17:25:02 INFO - 'SHELL': '/bin/bash', 17:25:02 INFO - 'SHLVL': '1', 17:25:02 INFO - 'TERM': 'linux', 17:25:02 INFO - 'TMOUT': '86400', 17:25:02 INFO - 'USER': 'cltbld', 17:25:02 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1502669820.30246-1911042536', 17:25:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:25:02 INFO - '_': '/tools/buildbot/bin/python'} 17:25:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:25:03 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 17:25:03 INFO - Cleaning up... 17:25:03 INFO - Return code: 0 17:25:03 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 17:25:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:25:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:25:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:25:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:25:03 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 0xef81f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c5a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1266b20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1269f00>, '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 0x1264ba0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1265050>, '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': '934fc3100db09dcb9af4d4b6000001ab-1502669820.30246-1911042536', '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 17:25:03 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 17:25:03 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 17:25:03 INFO - Using env: {'DISPLAY': ':0', 17:25:03 INFO - 'HOME': '/home/cltbld', 17:25:03 INFO - 'LANG': 'en_US.UTF-8', 17:25:03 INFO - 'LANGUAGE': 'en_US:en', 17:25:03 INFO - 'LOGNAME': 'cltbld', 17:25:03 INFO - 'MAIL': '/var/mail/cltbld', 17:25:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:25:03 INFO - 'MOZ_NO_REMOTE': '1', 17:25:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:25:03 INFO - 'NO_EM_RESTART': '1', 17:25:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:25:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:25:03 INFO - 'PWD': '/builds/slave/test', 17:25:03 INFO - 'SHELL': '/bin/bash', 17:25:03 INFO - 'SHLVL': '1', 17:25:03 INFO - 'TERM': 'linux', 17:25:03 INFO - 'TMOUT': '86400', 17:25:03 INFO - 'USER': 'cltbld', 17:25:03 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1502669820.30246-1911042536', 17:25:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:25:03 INFO - '_': '/tools/buildbot/bin/python'} 17:25:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:25:03 INFO - Downloading/unpacking blobuploader==1.2.4 17:25:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:25:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:25:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:25:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:25:04 INFO - Downloading blobuploader-1.2.4.tar.gz 17:25:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 17:25:04 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 17:25:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:25:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:25:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:25:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:25:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 17:25:04 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 17:25:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:25:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:25:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:25:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:25:04 INFO - Downloading docopt-0.6.1.tar.gz 17:25:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 17:25:04 INFO - Installing collected packages: blobuploader, requests, docopt 17:25:04 INFO - Running setup.py install for blobuploader 17:25:05 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 17:25:05 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 17:25:05 INFO - Running setup.py install for requests 17:25:05 INFO - Running setup.py install for docopt 17:25:05 INFO - Successfully installed blobuploader requests docopt 17:25:05 INFO - Cleaning up... 17:25:05 INFO - Return code: 0 17:25:05 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:25: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')]} 17:25:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:25: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')]} 17:25:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:25:05 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 0xef81f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c5a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1266b20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1269f00>, '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 0x1264ba0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1265050>, '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': '934fc3100db09dcb9af4d4b6000001ab-1502669820.30246-1911042536', '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 17:25:05 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 17:25:05 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 17:25:05 INFO - Using env: {'DISPLAY': ':0', 17:25:05 INFO - 'HOME': '/home/cltbld', 17:25:05 INFO - 'LANG': 'en_US.UTF-8', 17:25:05 INFO - 'LANGUAGE': 'en_US:en', 17:25:05 INFO - 'LOGNAME': 'cltbld', 17:25:05 INFO - 'MAIL': '/var/mail/cltbld', 17:25:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:25:05 INFO - 'MOZ_NO_REMOTE': '1', 17:25:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:25:05 INFO - 'NO_EM_RESTART': '1', 17:25:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:25:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:25:05 INFO - 'PWD': '/builds/slave/test', 17:25:05 INFO - 'SHELL': '/bin/bash', 17:25:05 INFO - 'SHLVL': '1', 17:25:05 INFO - 'TERM': 'linux', 17:25:05 INFO - 'TMOUT': '86400', 17:25:05 INFO - 'USER': 'cltbld', 17:25:05 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1502669820.30246-1911042536', 17:25:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:25:05 INFO - '_': '/tools/buildbot/bin/python'} 17:25:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:25:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:25:05 INFO - Running setup.py (path:/tmp/pip-XE2n7_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:25:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:25:05 INFO - Running setup.py (path:/tmp/pip-x55LWV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:25:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:25:05 INFO - Running setup.py (path:/tmp/pip-ceyUEf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:25:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:25:06 INFO - Running setup.py (path:/tmp/pip-OoDmZM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:25:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:25:06 INFO - Running setup.py (path:/tmp/pip-ebJkuL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:25:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:25:06 INFO - Running setup.py (path:/tmp/pip-7QiAE6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:25:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:25:06 INFO - Running setup.py (path:/tmp/pip-7HvDDv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:25:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:25:06 INFO - Running setup.py (path:/tmp/pip-gfUOej-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:25:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:25:06 INFO - Running setup.py (path:/tmp/pip-srJvs_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:25:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:25:06 INFO - Running setup.py (path:/tmp/pip-FysoOl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:25:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:25:06 INFO - Running setup.py (path:/tmp/pip-LSWJBc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:25:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:25:06 INFO - Running setup.py (path:/tmp/pip-77LYsM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:25:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:25:06 INFO - Running setup.py (path:/tmp/pip-mA8vlx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:25:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:25:06 INFO - Running setup.py (path:/tmp/pip-HMukOW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:25:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:25:06 INFO - Running setup.py (path:/tmp/pip-cBBn5Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:25:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:25:06 INFO - Running setup.py (path:/tmp/pip-3UGTJm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:25:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:25:06 INFO - Running setup.py (path:/tmp/pip-VfYBOr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:25:07 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 17:25:07 INFO - Running setup.py install for manifestparser 17:25:07 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 17:25:07 INFO - Running setup.py install for mozcrash 17:25:07 INFO - Running setup.py install for mozdebug 17:25:07 INFO - Running setup.py install for mozdevice 17:25:07 INFO - Installing dm script to /builds/slave/test/build/venv/bin 17:25:07 INFO - Running setup.py install for mozfile 17:25:07 INFO - Running setup.py install for mozhttpd 17:25:07 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 17:25:07 INFO - Running setup.py install for mozinfo 17:25:07 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 17:25:07 INFO - Running setup.py install for mozInstall 17:25:07 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 17:25:07 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 17:25:07 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 17:25:07 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 17:25:07 INFO - Running setup.py install for mozleak 17:25:07 INFO - Running setup.py install for mozlog 17:25:08 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 17:25:08 INFO - Running setup.py install for moznetwork 17:25:08 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 17:25:08 INFO - Running setup.py install for mozprocess 17:25:08 INFO - Running setup.py install for mozprofile 17:25:08 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 17:25:08 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 17:25:08 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 17:25:08 INFO - Running setup.py install for mozrunner 17:25:08 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 17:25:08 INFO - Running setup.py install for mozscreenshot 17:25:08 INFO - Running setup.py install for moztest 17:25:08 INFO - Running setup.py install for mozversion 17:25:08 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 17:25:08 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 17:25:08 INFO - Cleaning up... 17:25:08 INFO - Return code: 0 17:25:08 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:25: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')]} 17:25:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:25: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')]} 17:25:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:25:08 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 0xef81f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c5a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1266b20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1269f00>, '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 0x1264ba0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1265050>, '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': '934fc3100db09dcb9af4d4b6000001ab-1502669820.30246-1911042536', '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 17:25:08 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 17:25:08 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 17:25:08 INFO - Using env: {'DISPLAY': ':0', 17:25:08 INFO - 'HOME': '/home/cltbld', 17:25:08 INFO - 'LANG': 'en_US.UTF-8', 17:25:08 INFO - 'LANGUAGE': 'en_US:en', 17:25:08 INFO - 'LOGNAME': 'cltbld', 17:25:08 INFO - 'MAIL': '/var/mail/cltbld', 17:25:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:25:08 INFO - 'MOZ_NO_REMOTE': '1', 17:25:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:25:08 INFO - 'NO_EM_RESTART': '1', 17:25:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:25:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:25:08 INFO - 'PWD': '/builds/slave/test', 17:25:08 INFO - 'SHELL': '/bin/bash', 17:25:08 INFO - 'SHLVL': '1', 17:25:08 INFO - 'TERM': 'linux', 17:25:08 INFO - 'TMOUT': '86400', 17:25:08 INFO - 'USER': 'cltbld', 17:25:08 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1502669820.30246-1911042536', 17:25:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:25:08 INFO - '_': '/tools/buildbot/bin/python'} 17:25:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:25:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:25:09 INFO - Running setup.py (path:/tmp/pip-gH88JN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:25:09 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)) 17:25:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:25:09 INFO - Running setup.py (path:/tmp/pip-8J1eXq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:25:09 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)) 17:25:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:25:09 INFO - Running setup.py (path:/tmp/pip-LKJwsF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:25:09 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)) 17:25:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:25:09 INFO - Running setup.py (path:/tmp/pip-nAjrMN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:25:09 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)) 17:25:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:25:09 INFO - Running setup.py (path:/tmp/pip-EZPzAo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:25:09 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)) 17:25:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:25:09 INFO - Running setup.py (path:/tmp/pip-35fChJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:25:09 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)) 17:25:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:25:09 INFO - Running setup.py (path:/tmp/pip-qGhK7h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:25:09 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)) 17:25:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:25:09 INFO - Running setup.py (path:/tmp/pip-571eLr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:25:09 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)) 17:25:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:25:09 INFO - Running setup.py (path:/tmp/pip-0yJKHd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:25:09 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)) 17:25:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:25:09 INFO - Running setup.py (path:/tmp/pip-I1SyAA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:25:09 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)) 17:25:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:25:09 INFO - Running setup.py (path:/tmp/pip-O7YNjB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:25:09 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)) 17:25:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:25:09 INFO - Running setup.py (path:/tmp/pip-3DXz1b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:25:09 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)) 17:25:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:25:09 INFO - Running setup.py (path:/tmp/pip-4nxd3x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:25:09 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)) 17:25:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:25:09 INFO - Running setup.py (path:/tmp/pip-IHvXk_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:25:10 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)) 17:25:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:25:10 INFO - Running setup.py (path:/tmp/pip-nbp2fa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:25:10 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)) 17:25:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:25:10 INFO - Running setup.py (path:/tmp/pip-0MzsK9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:25:10 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)) 17:25:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:25:10 INFO - Running setup.py (path:/tmp/pip-7wrPT1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:25:10 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)) 17:25:10 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)) 17:25:10 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)) 17:25:10 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)) 17:25:10 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)) 17:25:10 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)) 17:25:10 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)) 17:25:10 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 17:25: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 17:25: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 17:25: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 17:25: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 17:25:11 INFO - Downloading blessings-1.6.tar.gz 17:25:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 17:25:11 INFO - Installing collected packages: blessings 17:25:11 INFO - Running setup.py install for blessings 17:25:11 INFO - Successfully installed blessings 17:25:11 INFO - Cleaning up... 17:25:11 INFO - Return code: 0 17:25:11 INFO - Done creating virtualenv /builds/slave/test/build/venv. 17:25:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:25:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:25:11 INFO - Reading from file tmpfile_stdout 17:25:11 INFO - Current package versions: 17:25:11 INFO - argparse == 1.2.1 17:25:11 INFO - blessings == 1.6 17:25:11 INFO - blobuploader == 1.2.4 17:25:11 INFO - docopt == 0.6.1 17:25:11 INFO - functools32 == 3.2.3-2 17:25:11 INFO - jsonschema == 2.5.1 17:25:11 INFO - manifestparser == 1.1 17:25:11 INFO - mozInstall == 1.13 17:25:11 INFO - mozcrash == 1.0 17:25:11 INFO - mozdebug == 0.1 17:25:11 INFO - mozdevice == 0.51 17:25:11 INFO - mozfile == 1.2 17:25:11 INFO - mozhttpd == 0.7 17:25:11 INFO - mozinfo == 0.10 17:25:11 INFO - mozleak == 0.1 17:25:11 INFO - mozlog == 3.5 17:25:11 INFO - moznetwork == 0.27 17:25:11 INFO - mozprocess == 0.25 17:25:11 INFO - mozprofile == 0.28 17:25:11 INFO - mozrunner == 6.13 17:25:11 INFO - mozscreenshot == 0.1 17:25:11 INFO - mozsystemmonitor == 0.3 17:25:11 INFO - moztest == 0.8 17:25:11 INFO - mozversion == 1.4 17:25:11 INFO - psutil == 3.1.1 17:25:11 INFO - requests == 1.2.3 17:25:11 INFO - wsgiref == 0.1.2 17:25:11 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:25:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:25:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:25:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:25:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:25:11 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 0xef81f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c5a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1266b20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1269f00>, '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 0x1264ba0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1265050>, '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': '934fc3100db09dcb9af4d4b6000001ab-1502669820.30246-1911042536', '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 17:25:11 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 17:25:11 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 17:25:11 INFO - Using env: {'DISPLAY': ':0', 17:25:11 INFO - 'HOME': '/home/cltbld', 17:25:11 INFO - 'LANG': 'en_US.UTF-8', 17:25:11 INFO - 'LANGUAGE': 'en_US:en', 17:25:11 INFO - 'LOGNAME': 'cltbld', 17:25:11 INFO - 'MAIL': '/var/mail/cltbld', 17:25:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:25:11 INFO - 'MOZ_NO_REMOTE': '1', 17:25:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:25:11 INFO - 'NO_EM_RESTART': '1', 17:25:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:25:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:25:11 INFO - 'PWD': '/builds/slave/test', 17:25:11 INFO - 'SHELL': '/bin/bash', 17:25:11 INFO - 'SHLVL': '1', 17:25:11 INFO - 'TERM': 'linux', 17:25:11 INFO - 'TMOUT': '86400', 17:25:11 INFO - 'USER': 'cltbld', 17:25:11 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1502669820.30246-1911042536', 17:25:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:25:11 INFO - '_': '/tools/buildbot/bin/python'} 17:25:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:25:12 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)) 17:25:12 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)) 17:25:12 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)) 17:25:12 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)) 17:25:12 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)) 17:25:12 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)) 17:25:12 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)) 17:25:12 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)) 17:25:12 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)) 17:25:12 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 17:25:12 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 17:25:12 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 17:25:12 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 17:25:12 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 17:25:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 17:25:13 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)) 17:25:13 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)) 17:25:13 INFO - Installing collected packages: simplejson 17:25:13 INFO - Running setup.py install for simplejson 17:25:13 INFO - building 'simplejson._speedups' extension 17:25:13 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 17:25:14 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 17:25:14 INFO - Successfully installed simplejson 17:25:14 INFO - Cleaning up... 17:25:14 INFO - Return code: 0 17:25:14 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 17:25: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')]} 17:25:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:25: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')]} 17:25:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:25:14 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 0xef81f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c5a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1266b20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1269f00>, '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 0x1264ba0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1265050>, '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': '934fc3100db09dcb9af4d4b6000001ab-1502669820.30246-1911042536', '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 17:25:14 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 17:25:14 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 17:25:14 INFO - Using env: {'DISPLAY': ':0', 17:25:14 INFO - 'HOME': '/home/cltbld', 17:25:14 INFO - 'LANG': 'en_US.UTF-8', 17:25:14 INFO - 'LANGUAGE': 'en_US:en', 17:25:14 INFO - 'LOGNAME': 'cltbld', 17:25:14 INFO - 'MAIL': '/var/mail/cltbld', 17:25:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:25:14 INFO - 'MOZ_NO_REMOTE': '1', 17:25:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:25:14 INFO - 'NO_EM_RESTART': '1', 17:25:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:25:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:25:14 INFO - 'PWD': '/builds/slave/test', 17:25:14 INFO - 'SHELL': '/bin/bash', 17:25:14 INFO - 'SHLVL': '1', 17:25:14 INFO - 'TERM': 'linux', 17:25:14 INFO - 'TMOUT': '86400', 17:25:14 INFO - 'USER': 'cltbld', 17:25:14 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1502669820.30246-1911042536', 17:25:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:25:14 INFO - '_': '/tools/buildbot/bin/python'} 17:25:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:25:14 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 17:25:14 INFO - Cleaning up... 17:25:14 INFO - Return code: 0 17:25:14 INFO - Running post-action listener: _resource_record_post_action 17:25:14 INFO - Running post-action listener: _start_resource_monitoring 17:25:14 INFO - Starting resource monitoring. 17:25:14 INFO - [mozharness: 2017-08-14 00:25:14.579832Z] Finished create-virtualenv step (success) 17:25:14 INFO - [mozharness: 2017-08-14 00:25:14.580837Z] Running install step. 17:25:14 INFO - Running pre-action listener: _resource_record_pre_action 17:25:14 INFO - Running main action method: install 17:25:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:25:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:25:14 INFO - Reading from file tmpfile_stdout 17:25:14 INFO - Detecting whether we're running mozinstall >=1.0... 17:25:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 17:25:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 17:25:14 INFO - Reading from file tmpfile_stdout 17:25:14 INFO - Output received: 17:25:14 INFO - Usage: mozinstall [options] installer 17:25:14 INFO - Options: 17:25:14 INFO - -h, --help show this help message and exit 17:25:14 INFO - -d DEST, --destination=DEST 17:25:14 INFO - Directory to install application into. [default: 17:25:14 INFO - "/builds/slave/test"] 17:25:14 INFO - --app=APP Application being installed. [default: firefox] 17:25:14 INFO - mkdir: /builds/slave/test/build/application 17:25:14 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'] 17:25:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 17:25:32 INFO - Reading from file tmpfile_stdout 17:25:32 INFO - Output received: 17:25:32 INFO - /builds/slave/test/build/application/firefox/firefox 17:25:32 INFO - Running post-action listener: _resource_record_post_action 17:25:32 INFO - [mozharness: 2017-08-14 00:25:32.861189Z] Finished install step (success) 17:25:32 INFO - [mozharness: 2017-08-14 00:25:32.861407Z] Running setup-mitmproxy step. 17:25:32 INFO - Running pre-action listener: _resource_record_pre_action 17:25:32 INFO - Running main action method: setup_mitmproxy 17:25:32 INFO - Skipping: mitmproxy is not required 17:25:32 INFO - Running post-action listener: _resource_record_post_action 17:25:32 INFO - [mozharness: 2017-08-14 00:25:32.862118Z] Finished setup-mitmproxy step (success) 17:25:32 INFO - [mozharness: 2017-08-14 00:25:32.862252Z] Running run-tests step. 17:25:32 INFO - Running pre-action listener: _resource_record_pre_action 17:25:32 INFO - Running pre-action listener: _set_gcov_prefix 17:25:32 INFO - Running main action method: run_tests 17:25:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 17:25:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 17:25:32 INFO - Python 2.7.3 17:25:32 INFO - Return code: 0 17:25:32 INFO - grabbing minidump binary from tooltool 17:25:32 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')]} 17:25:32 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--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 0x1269f00>, '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 0x1264ba0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1265050>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 17:25:32 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--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 17:25:32 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 17:25:32 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--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 17:25:33 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 17:25:33 INFO - Return code: 0 17:25:33 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 17:25:33 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 17:25:33 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 17:25:33 INFO - ENV: RUST_BACKTRACE is now full 17:25:33 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 17:25:33 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 17:25:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/LPo6Qd1VS8e-mSF6G8gTBA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-057', '--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 17:25:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/LPo6Qd1VS8e-mSF6G8gTBA/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-057 --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 17:25:33 INFO - Using env: {'DISPLAY': ':0', 17:25:33 INFO - 'HOME': '/home/cltbld', 17:25:33 INFO - 'LANG': 'en_US.UTF-8', 17:25:33 INFO - 'LANGUAGE': 'en_US:en', 17:25:33 INFO - 'LOGNAME': 'cltbld', 17:25:33 INFO - 'MAIL': '/var/mail/cltbld', 17:25:33 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 17:25:33 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 17:25:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:25:33 INFO - 'MOZ_NO_REMOTE': '1', 17:25:33 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 17:25:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:25:33 INFO - 'NO_EM_RESTART': '1', 17:25:33 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:25:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:25:33 INFO - 'PWD': '/builds/slave/test', 17:25:33 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 17:25:33 INFO - 'RUST_BACKTRACE': 'full', 17:25:33 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 17:25:33 INFO - 'SHELL': '/bin/bash', 17:25:33 INFO - 'SHLVL': '1', 17:25:33 INFO - 'TERM': 'linux', 17:25:33 INFO - 'TMOUT': '86400', 17:25:33 INFO - 'USER': 'cltbld', 17:25:33 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1502669820.30246-1911042536', 17:25:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:25:33 INFO - '_': '/tools/buildbot/bin/python'} 17:25:33 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/LPo6Qd1VS8e-mSF6G8gTBA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-057', '--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 17:25:33 INFO - mozversion application_buildid: 20170813233048 17:25:33 INFO - mozversion application_changeset: 3bfcbdf5c6c381d5a8febb5c209e27a69fb89f9b 17:25:33 INFO - mozversion application_display_name: Nightly 17:25:33 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 17:25:33 INFO - mozversion application_name: Firefox 17:25:33 INFO - mozversion application_remotingname: firefox 17:25:33 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 17:25:33 INFO - mozversion application_vendor: Mozilla 17:25:33 INFO - mozversion application_version: 57.0a1 17:25:33 INFO - mozversion platform_buildid: 20170813233048 17:25:33 INFO - mozversion platform_changeset: 3bfcbdf5c6c381d5a8febb5c209e27a69fb89f9b 17:25:33 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 17:25:33 INFO - mozversion platform_version: 57.0a1 17:25:33 INFO - using testdate: 1502670333 17:25:33 INFO - actual date: 1502670333 17:25:33 INFO - starting webserver on 'localhost:60553' 17:25:33 INFO - SUITE-START | Running 2 tests 17:25:33 INFO - TEST-START | dromaeo_css 17:25:33 INFO - Initialising browser for dromaeo_css test... 17:25:33 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:60553/getInfo.html -profile /tmp/tmpolMOfI/profile 17:25:33 INFO - TEST-INFO | started process 3320 (/builds/slave/test/build/application/firefox/firefox http://localhost:60553/getInfo.html) 17:25:40 INFO - TEST-INFO | 3320: exit 0 17:25:40 INFO - Browser initialized. 17:25:40 INFO - Running cycle 1/1 for dromaeo_css test... 17:25:40 INFO - TEST-INFO | started process 3531 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpolMOfI/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 17:25:41 INFO - PID 3531 | 17:25:41 INFO - PID 3531 | (/builds/slave/test/build/application/firefox/firefox:3581): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 17:25:41 INFO - PID 3531 | 17:25:51 INFO - PID 3531 | RSS: Main: 168935424 17:25:51 INFO - PID 3531 | 17:28:50 INFO - PID 3531 | Cycle 1(1): loaded http://localhost:60553/tests/dromaeo/cssquery-dojo.html (next: http://localhost:60553/tests/dromaeo/cssquery-ext.html) 17:28:51 INFO - PID 3531 | RSS: Main: 173019136 17:28:51 INFO - PID 3531 | 17:31:53 INFO - PID 3531 | Cycle 1(1): loaded http://localhost:60553/tests/dromaeo/cssquery-ext.html (next: http://localhost:60553/tests/dromaeo/cssquery-jquery.html) 17:31:54 INFO - PID 3531 | RSS: Main: 170397696 17:31:54 INFO - PID 3531 | 17:34:55 INFO - PID 3531 | Cycle 1(1): loaded http://localhost:60553/tests/dromaeo/cssquery-jquery.html (next: http://localhost:60553/tests/dromaeo/cssquery-mootools.html) 17:34:56 INFO - PID 3531 | RSS: Main: 170708992 17:34:56 INFO - PID 3531 | 17:37:58 INFO - PID 3531 | Cycle 1(1): loaded http://localhost:60553/tests/dromaeo/cssquery-mootools.html (next: http://localhost:60553/tests/dromaeo/cssquery-prototype.html) 17:37:58 INFO - PID 3531 | RSS: Main: 170459136 17:37:58 INFO - PID 3531 | 17:41:02 INFO - PID 3531 | Cycle 1(1): loaded http://localhost:60553/tests/dromaeo/cssquery-prototype.html (next: http://localhost:60553/tests/dromaeo/cssquery-yui.html) 17:41:02 INFO - PID 3531 | RSS: Main: 174239744 17:41:02 INFO - PID 3531 | 17:44:04 INFO - PID 3531 | Cycle 1(1): loaded http://localhost:60553/tests/dromaeo/cssquery-yui.html (next: http://localhost:60553/tests/dromaeo/cssquery-dojo.html) 17:44:04 INFO - PID 3531 | RSS: Main: 174977024 17:44:04 INFO - PID 3531 | 17:44:04 INFO - PID 3531 | __start_tp_report 17:44:04 INFO - PID 3531 | _x_x_mozilla_page_load 17:44:04 INFO - PID 3531 | _x_x_mozilla_page_load_details 17:44:04 INFO - PID 3531 | |i|pagename|runs| 17:44:04 INFO - PID 3531 | |0;dojo.html;3117.8596963136656;3148.039847846406;3181.793183443076;3181.9522707159394;3194.217416732901;6122.326544080153;6263.123162757206;6293.930031894577;6297.433231009209;6332.556721029524;6060;6159.168512250845;6172.969135154318;6180.072989051644;6201.286852012008;5658.74535645897;5666.631668941505;5691.4877661010505;5716.199732037498;5771.538276937835;5760.6255593386295;5790.073588225885;5793.362730099686;5809.854753631151;5811.0702287633985;5521.365043020024;5641.12562552805;5741.569382296324;5830.854228644275;5846.152307915349;5463.071277882769;5700.429957004308;5748.166515855178;5776.59563830532;5781.219535362757;5635.915461268084;5646.858828529279;5730.799422020209;5748.396418376052;5758.510526605243;6143.293521245069;6148.415900489491;6160.260768707739;6161.075838624242;6201.224846894138;6584.572002819801;6673.833154171136;6705.932940670579;6723.899141512881;6725.66371681414;6731.49513786468;6745.696443660047;6833.384995350442;6836.897446538306;6837.179538455367;6087.4521293083835;6155.815325540241;6193.783217587363;6249.406306400884;6338.714757835908;6901.896471552931;6925.826854328581;6932.272111428228;6955.826104347432;6973.4072603829245;6535.411812936763;6541.215054193527;6544.443722283564;6554.377334153248;6642;6649.667516624149;6686.69909854048;6711.63086030273;6736.124303840469;6752.729890804411;6465.191851018622;6585.901211481736;6594.73621055162;6668.0331351954665;6693.263740988487;6649.501287403464;6698.129243198353;6723.125993620798;6736.5284430090405;6741.629210393476;5268.051750684914;5278.81524146653;5350.625456218105;5403.891922161613;5426.864328391743;4599.701019433793;4615.538446155358;4637.072585482917;4638.652101092432;4645.883852903705;5693.402192769782;5768.451997060272;5768.74040668171;5770.711464426762;5785.71071446426;6683.365080317362;6687;6745.224299205556;6783.796486105425;6787.5588086774205;5769.134629805479;5782.017057100303;5784.942150578525;5809.50619197373;5844.12338149281;5733.226014487991;5817.621854579439;5851.356350801409;5885.440883116183;5918.2898052234;6498.935010649928;6505.121808555879;6517.348265173445;6526.869462610721;6545.901811472737;6696.799096026932;6708.329167083252;6724.596524208368;6776.288489708608;6799.728010879509;6453.806385808433;6469.708863101077;6536.248331441945;6543.1821022372205;6547.083408322934;6447.290798012309;6463.127477790438;6517.771877984248;6526.575772574767;6587.374199451045;6754.5947243165565;6765.932340676531;6801.693923773343;6812.216595091628;6819.045333653194;6498.317676643885;6500.187476565429;6509.218893732783;6601.966990165019;6610.933890661032;6502.089707441057;6503.341647879761;6584.703688333941;6591.538592298685;6604.174478190226;6315.842103947438;6399.744010239725;6407.839804004937;6426.068220108152;6459.321771214143;6497.960326347762;6509.056186852975;6517.902231466626;6549.541532092708;6576.112224849775;6303.180586523723;6310.810675679737;6383.553151279366;6391.137196478602;6392.808215753535 17:44:04 INFO - PID 3531 | |1;ext.html;780.2119858942466;799.8040480082374;834.2158371131136;863.0808189278418;864.7103220421161;37848.81075594618;40377;41734.165316693645;41810.37284440736;41905.79047104764;42022.36966445506;42317.15365692684;42359.576404236024;42569;42633.360499592454;7332.413406927446;7479.62601869907;7483.887741683852;7484.064491938508;7485.139208990981;7402.851942961164;7530.887036694454;7534.5855977921465;7539.886901696479;7540;7575.659095340723;7580.962095189517;7601.657925393343;7604.201558836326;7605.505642133271;7523.887141692851;7546.735864244725;7548.849023019564;7549.962250188769;7550.3582195513445;7436.88844667325;7496.062992125984;7502.887456688154;7505.812354691177;7512.21121782216;39237.60762392368;39295.624653137005;39569.20861582752;39689.404658930136;39730.80134599337;3351.4302568563403;3355.261842394669;3389.6271410144864;3391.3047825195777;3391.440412331987;31192.844035779675;31301.217469563442;31303.53044704331;31328.530072048936;31371.215719607193;4784.114938736345;5024.221245706921;5025.346704928336;5056.721880296583;5073.644844860862;200830;201195;201724;201916;202518;48046.5195348049;48206.27690584644;48306.758466207444;48480.27279590809;48546.27180592294;49154.50845491571;49331.50668493341;49384;49410;49447;14889.181095039878;15193.468228611946;15255.313510892036;15260.618484537976;15284.847151528342;12401.689957750948;12416.689582760504;12423.130380873252;12425.130240883233;12431.254124752544;12779.552715655094;12907.741845163044;12920.870791292155;12985.610431687064;13075.738485230242;5152.536271735562;5174.197999310113;5176.767045482962;5272.314599102092;5322.654027488201;973.3284034016506;985.2561316206362;992.9950350248347;996.8704068471197;997.1773287038078;22260.55478890413;22456.88771556132;22525.774742252368;22637.320880373616;22858.023985157215;1096.5010920031366;1096.8848270931596;1101.388729255255;1112.093643680398;1113.2485572238706;12103.273803571814;12115.273083615011;12132.332721700392;12260.203086799507;12269.815952760715;221252;223364;223677;247611;255507;56937.145942810894;57033.714831425576;57104.714476428184;57315.14027289594;57429.71285143548;1478.2830327291256;1479.8298195707416;1490.567735356756;1496.3416096917322;1504.9097054176784;28139.859300703367;28435;28583.571246430904;28888.133355999355;28977.275568110967;37689.62310376861;38088;38135;38179;38254.42618360671;227937;229403;229694;229782;229838;37296;37360.81319593385;37440.812795935846;37495.62504374921;37549;44342.55657443513;44785.328220077376;45624.54375456203;45687;45702;33019.504707428925;33186.83406582951;33429.66570334265;33597.83201083979;33705.66294337124;32969.67030329666;33128.83435582807;33135.668643314224;33343.49984750279;33756.49365259474;35032;36254;36489.270214596094;36579.817100914326;36771.26457470889;31189.8440507796;31556.36887262196;31600.36799263956;31881.68118318787;32334.514982275756;23179.884100580064;23699.52600947937;23964.40088997789;24027.159049433187;24180 17:44:04 INFO - PID 3531 | |2;jquery.html;563.6082922368953;567.5658121537025;583.122400786816;584.5323741007193;591.7573794744155;22369.888150559244;22644.660330095063;23136.88431557844;23174.073037078495;23214.65178022329;25220.873895630542;27212.59181112285;27255.046073387435;27308.5903711444;27319.863400682967;6336;6489.059086432464;6492.707828147721;6494.902576461357;6494.967525162368;6396.968015159918;6438.645874476902;6478.449331806802;6943.1668199816095;6999.615021173833;6953.269906659803;6954.23503414624;6958.930410695904;6960.756373526928;6964.965175174117;6985.650717464132;6986.720531178747;6986.825329366756;6987.860242795141;6988.895166572505;6837.692303846339;6847.383735463783;6856.657167141673;6858.691358888862;6862.210845752703;32054.358912821845;32288.515672264934;32501.349973000644;32558.348833023443;32689;1948.65898467769;2002.2791794953805;2003.4190084875368;2005.0576229172266;2006.4582562707988;19824.504387390287;20475.8976205118;20502.487437814023;20506.897465512728;20520.38438846837;2471.209213051824;2482.987585062081;2524.6591710119083;2593.4164812916943;2603.271084096456;147463;151547.24226378798;152129.23935380252;152156;152343;19760.455095328154;22443.551128977328;22575.548489030127;23218.76781232166;23388.415289617897;45782.54217457849;45936.5406345939;45950;46048;46123.53876461193;11958.461869215906;12098;12142.635720928387;12180.878191218151;12256.38718064111;10089.243306752023;10114.797704045877;10147.238957078249;10214.131798797036;10261.794764104676;11493.597724079784;11712.70718232051;12177.878221217852;12245.32650704202;12302.261864287992;4353.4122893408985;4594.287885377705;4612.53874612536;4614.054118905617;4668.206404911173;945.0407836046281;962.8603852441357;973.0366936732584;976.3165783951121;980.1766516126488;20185.394438166877;20340.389788306373;20465;20591.485212869797;20794.896025519774;1025.9692209233735;1028.8148133336072;1035.414990530348;1037.4397825174472;1043.1446214104512;11067.778644427066;11339.829902551468;11525.596604118984;11619.186656933933;11630.127740419503;531755;540723;548398;551228;556265;117783.41108294403;121591;123740.38129809294;124017;124565.37717311537;1257.4787550960448;1271.4151490314373;1311.3574348569132;1312.744014917082;1325.0062453160322;21266.680999784705;21289.148434062463;21310.467238319165;21387.25144619931;21619.891900540395;59115;59213.40786592251;59297.70351148216;60769.0884636722;61035.694821525605;71012.64493677499;72449;73420.26579734348;73877;74000.25999739933;12843.486260549847;13290.534831280858;14731.705365892836;14905.701885962437;15346.616334591725;23301.76698232996;23699.289021329387;24402.877985609957;24792.628110577996;25001.499970000863;18193.181306840957;18244.543886402946;18247.726284106015;18354.449366519028;18594.349197778014;16495.34018639289;17072.658546829243;17128.40050598273;17171.141442927554;17312.913435432743;18320.358787442376;19565.217391304188;19624.509387265432;19840.60318793645;20005.499862503555;14730.410783568537;15048.473303434328;15072.321745521696;15073.472428464951;15077.396904123712;17748.467545973643;17949.64100717952;17967.371142009968;17979.011154386633;18000.639987200444 17:44:04 INFO - PID 3531 | |3;mootools.html;1338.3375229261515;1396.4763213794827;1409.964750881228;1416.8795652369542;1419.971600567988;14058.718825623482;14438.711225775505;14717.632059198511;14742.041767285133;14836.332365043572;14398.424063037492;14721.41114355427;14727.705445891075;14728.852711472882;14745.041572297792;2647.3381654586356;2671.505771432291;2681.3430709476106;2684.7181045990183;2703;2564.3204550794053;2743.533599288126;2748.367875388662;2751.9036833710725;2756.503829310723;2611.0469678567283;2623.5802271636544;2629.1192450529097;2633.7892968562564;2634.5521261385516;2604.374950011993;2630.473905218964;2644.352133727249;2645.0742240215964;2647.7749391301763;2549.31168584483;2563.717991020986;2572.601246806748;2583.354161459635;2612.7517885800817;14040.297985100806;14162.291885405792;14306.64233394163;14308.21304828234;14350.856491435057;7469.626518674045;7802;7804.0635123785505;7811.804704882366;7821.804454888616;4977.42759582649;5137.922931156036;5208.9739551302;5240.4497527759795;5263.973680131575;1864.4220291709614;1910.121344181678;1913.885166889991;1954.2280799084424;1957.7357056797293;24113;24179.395515112086;24354.878225608758;24439.877800611062;24459.143929962367;6348.746050158034;6414.326495717975;6415.807525774234;6637.834054148589;6642.800715978528;16401.917990409973;16415.5896102596;16419.507414777574;16438.095904725116;16454.84816062864;7505.061867266591;7658.157602663702;7660.080790305199;7661.616919154131;7670.539767613961;6891.448684105259;7012.859742805217;7081.610511421921;7118;7119.430445564342;4831.4202295724735;4983.078130545789;5042.42012168598;5049;5085.593152547787;1347.9258640774656;1349.9392527336292;1370.397025308861;1372.1766939836018;1394.079907261223;882.580774132282;901.531203774047;903.5256490342623;903.8915330160291;920.6179435534312;7665.61671916402;7724.266194711493;7739.264769846855;7752.224777522202;7766;700.726716580534;712.2983860897116;719.413677852559;723.6128671160903;728.2208037399931;4666.60333871618;5710.857228569319;5798.391168927202;5907.675077870673;5911.940880591225;20182.89908550448;20189.394318170478;20453;20532.692009619866;20580.073896674687;18895.52761180954;20247.29134480286;20249.696254556195;20285.087171077335;20321.89839050795;9740.17208537268;9756.170725488413;10793.892061079288;11160.832587511193;11299.322040677422;8384.496930184208;8916.28669706435;8934.687285944961;8950.328725345755;9046.773830654287;16984.745228821826;17612.207450664493;17832;18068.096595170453;18177.81822181761;17477;17655.735163972808;17879.73180402321;18003.72994405059;18154.092295385442;11537.250078744855;11674.70813229642;11803.822942655695;11806.114541409257;11812.881871181178;13060.738785224432;13131.540396086091;13264.33678316061;13328.800067999182;13359.398827052612;10854.077403420797;10927.453627318444;11013.063889569476;11073.944630276797;11319.603813866475;10431.061204491632;10438.582456701646;10439.321444106108;10677.733056673334;10683.626073087406;9572.952135239279;9658.661946831828;9668.951655241679;9671.758206044906;9695.66065187715;7108.893366599402;7142.5714457132735;7342;7382.5570465772225;7622.5426474411715;7324;7431.145418276751;7459.738909138154;7536.321731044232;7551.622418879144 17:44:04 INFO - PID 3531 | |4;prototype.html;500.1447524732708;506.17998841876164;513.5993924738704;521.7260938007546;531.3199105145413;6214.06788981653;6228.377162283769;6249.46888012437;6289.874202515947;6357.8092657220295;6109.877802443949;6141.508679305656;6157.722902469389;6176.351483094278;6255.687215639223;4818.132736107499;4960.578350840183;5002.97439024999;5057.898842023157;5104.464031276718;4961.816800607739;4973.154563724158;4989.226669866159;5000.699958002513;5027.1453852844925;4906.5093490650825;4945.604351651878;4963;4972.353594032771;5008.39899212095;4959.752012399384;5003.349564556603;5012;5026.185336211734;5026.874328141789;4469.128519938581;4491.393661855673;4492.3710680504755;4511.255642818931;4532.4787649420405;5990.101484777275;6025.548083893726;6028.487578555784;6062.484688801457;6087.969560152215;5708.286464191976;5726.337253177293;5741.971290143564;5769.336526299488;5796.739146738407;6573.769918052845;6621.205455345341;6632.8673426531195;6635.236947751022;6696.83257918551;4841.661083724141;4844.667716377989;4844.878878028042;4889.731064791435;4900.338454308694;6570.507211959074;6701.074710088179;6722.630255336004;6841.418479429254;7007.544509606859;4992.625553083533;4993.975030124826;5019.29729837823;5052.221278296922;5055.747212639427;5043.747812609355;5050.267711181858;5078.365204349457;5078.822241221614;5114.33513643224;5658.405867383948;5688.265079150899;5696.658200507983;5708.429157084258;5743.224664670216;6603.405693487609;6655.733770649216;6658.3341665834;6708.664566771642;6759.324067593201;1747.772789537352;1775.6271183051444;1780.9848386419876;1787.973180402295;1798.2627122879558;1194.2237545595433;1201.405304374323;1210.6126039667222;1236.5239382837492;1236.6413740015475;5712;5724.513416359656;5743.684097374601;5755.280589926259;5773.653580785166;6726.159230096238;6755.18937727466;6759;6794.4033152209195;6854.965725171442;5708.914366284509;5710.543156547466;5711.685857277889;5757.309122905278;5788.913166302509;3553.7157027437743;3611.6749492545273;3620.185458271868;3626.220362622049;3645.8177091145867;6612.636305003271;6613;6614.239362473377;6615.140031795836;6656.267810540837;6907.309269073053;6958.130233720785;6977.40692041172;6980.581165130108;7019.403350715144;6492.383223593751;6533.41199292066;6546.541742078104;6569.737210511526;6596.274409814917;6296.968515157395;6630.204375474974;6677.69950352245;6784.525083244125;6837.863242735018;6646.401823835878;6664.866702666017;6702.430293424918;6723.361280678328;6761.087253220752;6405.807825765234;6461.450776684034;6501.837454063686;6547.70535325902;6559.180102487189;4977.8257760978195;5026.547610715053;5028.547430731252;5046.747662616928;5057.721825299644;6588.703508342041;6637.568558043905;6670.899936501053;6802.115724955724;6875.690593923386;6457.903131452938;6576.704048317933;6583.407493325623;6587.769428069994;6608.299352362692;6430.935690643221;6463.192100987377;6516.305760502399;6545.574537655038;6580.7038683260325;6378.182218067828;6443.323451037761;6461.741530338733;6490.156279683611;6556.311587283267;6505.479561635152;6601.174853143357;6605.240397354173;6630.436412904957;6689.384324816056;6322.968385158045;6338.271098823694;6341.573146042104;6401.55189136756;6402.711877965409 17:44:04 INFO - PID 3531 | |5;yui.html;911.2618778789185;925.2736601767614;933.0622724162216;935.6584846531018;952.3619175152647;18610.81389186108;18852.62294754104;19539.12073956672;19615.509612259702;19620.90189549052;21088.472788180265;21828.563428731417;21850;21907.452313692167;21970.45073873154;1006.3810756384808;1039.833626619741;1044.8798388185342;1045.513836066229;1045.984310235347;1010.5099026971913;1041.8333066709329;1068.636663534402;1072.3351522056298;1072.7050061233144;1118.5022664914115;1120.176670147441;1124.083871644607;1125.3979121170175;1126.8028095083368;1112.2047735868812;1115.5872327238933;1117.67587399654;1119.0096764363557;1119.2333251722596;817.0930267403178;819.6188772220886;820.5568992743911;820.6061090676449;820.6676296100089;19715.40853774389;19968.70046949297;20049.498762531053;20058.699119513218;20439.693404598944;21483.892580536998;21547.15718729555;21652.783472165233;21963.890180549155;21986.670199947013;17054.317827286894;17112.058836763972;17254.741178882326;17308.221130049176;17336.73994890065;3538.752287339887;3558.679718825292;3560.2701446203464;3562.1450851795644;3574.1064733816547;128936;130160;132129.99999999904;132428.51864058018;132672.33663831715;16944.23750931211;17076.487705368858;17591;17595.12024398775;17605.559861003578;30025.849870750506;31123.84438077795;31144.377112457623;31225.219369515944;31242.53136202959;7700.730474433368;7964.20357964199;8006.679732810622;8342;8798.824023519493;4097.733647312915;4202.411662367271;4202.894927626772;4203.852865149705;4208.810603522848;5169;5237.423883372826;5243.711595862264;5266.578673706094;5295.046891559479;960.6685693435753;969.6024629901848;979.1970584120952;985.1970643925179;987.5111819649176;685.9622720750407;697.3793323941696;699.8355386484172;711.5872793779596;716.394646523697;11558.826617600742;12255.325957072268;12264.570740024057;12612.747745045048;13034.674133146558;676.932306769329;677.3125277842993;683.1528904158807;697.052009267396;707.0807949665415;5860.253947663814;5899.321578018497;5949.9107513387335;5959.940400596025;6003.849903752353;119157.40421297838;119516.4024179891;120936;123369.14946275813;126021;100687.49656251672;102919;103513.48243258735;104296.47851760844;105104;88812.5559372199;88929.55535222283;90264;91129.54435227648;91945.08054919365;10313.74215644615;10597.523111460157;10752;10832.620858269922;11049.005589496985;38923.22153556856;40030.59969400269;40087.59912400839;41125.588744113375;41433.96415089526;51627.74186129045;52184;52679.736601318284;53642;54587;16032.679346412773;16105.677886441972;16265;16306;16323.59191020234;18163.45509634713;18168.545786355447;18256.543586410447;18294.90852545729;18394.356197533558;15832.60418489547;16099.275532601296;16117.194140292704;16228.269727862038;16248.106354150636;16259;16278.51164465068;16334.754978675091;16378;16485.505434836974;15901.363945442054;15932.522024339289;15943.601409964844;16054;16090.034597923694;11542.825722926262;11599.362035088152;11892.76214475723;11900.345480998629;11922.463489143183;12127.332996685267;12477.93761031189;12557.183783054072;12605.621831345074;12614.243145411305 17:44:04 INFO - PID 3531 | __end_tp_report 17:44:04 INFO - PID 3531 | __start_cc_report 17:44:04 INFO - PID 3531 | _x_x_mozilla_cycle_collect,368 17:44:04 INFO - PID 3531 | __end_cc_report 17:44:04 INFO - PID 3531 | __startTimestamp1502671444742__endTimestamp 17:44:04 INFO - PID 3531 | 17:44:04 INFO - PID 3531 | ------- Summary: start ------- 17:44:04 INFO - PID 3531 | Number of tests: 6 17:44:04 INFO - PID 3531 | 17:44:04 INFO - PID 3531 | [#0] dojo.html Cycles:165 Average:6155.23 Median:6407.84 stddev:734.10 (11.5%) stddev-sans-first:696.61 17:44:04 INFO - PID 3531 | Values: 3117.9 3148.0 3181.8 3182.0 3194.2 6122.3 6263.1 6293.9 6297.4 6332.6 6060.0 6159.2 6173.0 6180.1 6201.3 5658.7 5666.6 5691.5 5716.2 5771.5 5760.6 5790.1 5793.4 5809.9 5811.1 5521.4 5641.1 5741.6 5830.9 5846.2 5463.1 5700.4 5748.2 5776.6 5781.2 5635.9 5646.9 5730.8 5748.4 5758.5 6143.3 6148.4 6160.3 6161.1 6201.2 6584.6 6673.8 6705.9 6723.9 6725.7 6731.5 6745.7 6833.4 6836.9 6837.2 6087.5 6155.8 6193.8 6249.4 6338.7 6901.9 6925.8 6932.3 6955.8 6973.4 6535.4 6541.2 6544.4 6554.4 6642.0 6649.7 6686.7 6711.6 6736.1 6752.7 6465.2 6585.9 6594.7 6668.0 6693.3 6649.5 6698.1 6723.1 6736.5 6741.6 5268.1 5278.8 5350.6 5403.9 5426.9 4599.7 4615.5 4637.1 4638.7 4645.9 5693.4 5768.5 5768.7 5770.7 5785.7 6683.4 6687.0 6745.2 6783.8 6787.6 5769.1 5782.0 5784.9 5809.5 5844.1 5733.2 5817.6 5851.4 5885.4 5918.3 6498.9 6505.1 6517.3 6526.9 6545.9 6696.8 6708.3 6724.6 6776.3 6799.7 6453.8 6469.7 6536.2 6543.2 6547.1 6447.3 6463.1 6517.8 6526.6 6587.4 6754.6 6765.9 6801.7 6812.2 6819.0 6498.3 6500.2 6509.2 6602.0 6610.9 6502.1 6503.3 6584.7 6591.5 6604.2 6315.8 6399.7 6407.8 6426.1 6459.3 6498.0 6509.1 6517.9 6549.5 6576.1 6303.2 6310.8 6383.6 6391.1 6392.8 17:44:04 INFO - PID 3531 | 17:44:04 INFO - PID 3531 | [#1] ext.html Cycles:180 Average:39238.17 Median:37328.41 stddev:57735.44 (154.7%) stddev-sans-first:57825.18 17:44:04 INFO - PID 3531 | Values: 780.2 799.8 834.2 863.1 864.7 37848.8 40377.0 41734.2 41810.4 41905.8 42022.4 42317.2 42359.6 42569.0 42633.4 7332.4 7479.6 7483.9 7484.1 7485.1 7402.9 7530.9 7534.6 7539.9 7540.0 7575.7 7581.0 7601.7 7604.2 7605.5 7523.9 7546.7 7548.8 7550.0 7550.4 7436.9 7496.1 7502.9 7505.8 7512.2 39237.6 39295.6 39569.2 39689.4 39730.8 3351.4 3355.3 3389.6 3391.3 3391.4 31192.8 31301.2 31303.5 31328.5 31371.2 4784.1 5024.2 5025.3 5056.7 5073.6 200830.0 201195.0 201724.0 201916.0 202518.0 48046.5 48206.3 48306.8 48480.3 48546.3 49154.5 49331.5 49384.0 49410.0 49447.0 14889.2 15193.5 15255.3 15260.6 15284.8 12401.7 12416.7 12423.1 12425.1 12431.3 12779.6 12907.7 12920.9 12985.6 13075.7 5152.5 5174.2 5176.8 5272.3 5322.7 973.3 985.3 993.0 996.9 997.2 22260.6 22456.9 22525.8 22637.3 22858.0 1096.5 1096.9 1101.4 1112.1 1113.2 12103.3 12115.3 12132.3 12260.2 12269.8 221252.0 223364.0 223677.0 247611.0 255507.0 56937.1 57033.7 57104.7 57315.1 57429.7 1478.3 1479.8 1490.6 1496.3 1504.9 28139.9 28435.0 28583.6 28888.1 28977.3 37689.6 38088.0 38135.0 38179.0 38254.4 227937.0 229403.0 229694.0 229782.0 229838.0 37296.0 37360.8 37440.8 37495.6 37549.0 44342.6 44785.3 45624.5 45687.0 45702.0 33019.5 33186.8 33429.7 33597.8 33705.7 32969.7 33128.8 33135.7 33343.5 33756.5 35032.0 36254.0 36489.3 36579.8 36771.3 31189.8 31556.4 31600.4 31881.7 32334.5 23179.9 23699.5 23964.4 24027.2 24180.0 17:44:04 INFO - PID 3531 | 17:44:04 INFO - PID 3531 | [#2] jquery.html Cycles:180 Average:38429.33 Median:21994.89 stddev:91652.90 (416.7%) stddev-sans-first:91865.92 17:44:04 INFO - PID 3531 | Values: 563.6 567.6 583.1 584.5 591.8 22369.9 22644.7 23136.9 23174.1 23214.7 25220.9 27212.6 27255.0 27308.6 27319.9 6336.0 6489.1 6492.7 6494.9 6495.0 6397.0 6438.6 6478.4 6943.2 6999.6 6953.3 6954.2 6958.9 6960.8 6965.0 6985.7 6986.7 6986.8 6987.9 6988.9 6837.7 6847.4 6856.7 6858.7 6862.2 32054.4 32288.5 32501.3 32558.3 32689.0 1948.7 2002.3 2003.4 2005.1 2006.5 19824.5 20475.9 20502.5 20506.9 20520.4 2471.2 2483.0 2524.7 2593.4 2603.3 147463.0 151547.2 152129.2 152156.0 152343.0 19760.5 22443.6 22575.5 23218.8 23388.4 45782.5 45936.5 45950.0 46048.0 46123.5 11958.5 12098.0 12142.6 12180.9 12256.4 10089.2 10114.8 10147.2 10214.1 10261.8 11493.6 11712.7 12177.9 12245.3 12302.3 4353.4 4594.3 4612.5 4614.1 4668.2 945.0 962.9 973.0 976.3 980.2 20185.4 20340.4 20465.0 20591.5 20794.9 1026.0 1028.8 1035.4 1037.4 1043.1 11067.8 11339.8 11525.6 11619.2 11630.1 531755.0 540723.0 548398.0 551228.0 556265.0 117783.4 121591.0 123740.4 124017.0 124565.4 1257.5 1271.4 1311.4 1312.7 1325.0 21266.7 21289.1 21310.5 21387.3 21619.9 59115.0 59213.4 59297.7 60769.1 61035.7 71012.6 72449.0 73420.3 73877.0 74000.3 12843.5 13290.5 14731.7 14905.7 15346.6 23301.8 23699.3 24402.9 24792.6 25001.5 18193.2 18244.5 18247.7 18354.4 18594.3 16495.3 17072.7 17128.4 17171.1 17312.9 18320.4 19565.2 19624.5 19840.6 20005.5 14730.4 15048.5 15072.3 15073.5 15077.4 17748.5 17949.6 17967.4 17979.0 18000.6 17:44:04 INFO - PID 3531 | 17:44:04 INFO - PID 3531 | [#3] mootools.html Cycles:180 Average:8956.64 Median:2618.17 stddev:6222.35 (237.7%) stddev-sans-first:6213.48 17:44:04 INFO - PID 3531 | Values: 1338.3 1396.5 1410.0 1416.9 1420.0 14058.7 14438.7 14717.6 14742.0 14836.3 14398.4 14721.4 14727.7 14728.9 14745.0 2647.3 2671.5 2681.3 2684.7 2703.0 2564.3 2743.5 2748.4 2751.9 2756.5 2611.0 2623.6 2629.1 2633.8 2634.6 2604.4 2630.5 2644.4 2645.1 2647.8 2549.3 2563.7 2572.6 2583.4 2612.8 14040.3 14162.3 14306.6 14308.2 14350.9 7469.6 7802.0 7804.1 7811.8 7821.8 4977.4 5137.9 5209.0 5240.4 5264.0 1864.4 1910.1 1913.9 1954.2 1957.7 24113.0 24179.4 24354.9 24439.9 24459.1 6348.7 6414.3 6415.8 6637.8 6642.8 16401.9 16415.6 16419.5 16438.1 16454.8 7505.1 7658.2 7660.1 7661.6 7670.5 6891.4 7012.9 7081.6 7118.0 7119.4 4831.4 4983.1 5042.4 5049.0 5085.6 1347.9 1349.9 1370.4 1372.2 1394.1 882.6 901.5 903.5 903.9 920.6 7665.6 7724.3 7739.3 7752.2 7766.0 700.7 712.3 719.4 723.6 728.2 4666.6 5710.9 5798.4 5907.7 5911.9 20182.9 20189.4 20453.0 20532.7 20580.1 18895.5 20247.3 20249.7 20285.1 20321.9 9740.2 9756.2 10793.9 11160.8 11299.3 8384.5 8916.3 8934.7 8950.3 9046.8 16984.7 17612.2 17832.0 18068.1 18177.8 17477.0 17655.7 17879.7 18003.7 18154.1 11537.3 11674.7 11803.8 11806.1 11812.9 13060.7 13131.5 13264.3 13328.8 13359.4 10854.1 10927.5 11013.1 11073.9 11319.6 10431.1 10438.6 10439.3 10677.7 10683.6 9573.0 9658.7 9669.0 9671.8 9695.7 7108.9 7142.6 7342.0 7382.6 7622.5 7324.0 7431.1 7459.7 7536.3 7551.6 17:44:04 INFO - PID 3531 | 17:44:04 INFO - PID 3531 | [#4] prototype.html Cycles:180 Average:5527.90 Median:6125.69 stddev:1550.32 (25.3%) stddev-sans-first:1508.04 17:44:04 INFO - PID 3531 | Values: 500.1 506.2 513.6 521.7 531.3 6214.1 6228.4 6249.5 6289.9 6357.8 6109.9 6141.5 6157.7 6176.4 6255.7 4818.1 4960.6 5003.0 5057.9 5104.5 4961.8 4973.2 4989.2 5000.7 5027.1 4906.5 4945.6 4963.0 4972.4 5008.4 4959.8 5003.3 5012.0 5026.2 5026.9 4469.1 4491.4 4492.4 4511.3 4532.5 5990.1 6025.5 6028.5 6062.5 6088.0 5708.3 5726.3 5742.0 5769.3 5796.7 6573.8 6621.2 6632.9 6635.2 6696.8 4841.7 4844.7 4844.9 4889.7 4900.3 6570.5 6701.1 6722.6 6841.4 7007.5 4992.6 4994.0 5019.3 5052.2 5055.7 5043.7 5050.3 5078.4 5078.8 5114.3 5658.4 5688.3 5696.7 5708.4 5743.2 6603.4 6655.7 6658.3 6708.7 6759.3 1747.8 1775.6 1781.0 1788.0 1798.3 1194.2 1201.4 1210.6 1236.5 1236.6 5712.0 5724.5 5743.7 5755.3 5773.7 6726.2 6755.2 6759.0 6794.4 6855.0 5708.9 5710.5 5711.7 5757.3 5788.9 3553.7 3611.7 3620.2 3626.2 3645.8 6612.6 6613.0 6614.2 6615.1 6656.3 6907.3 6958.1 6977.4 6980.6 7019.4 6492.4 6533.4 6546.5 6569.7 6596.3 6297.0 6630.2 6677.7 6784.5 6837.9 6646.4 6664.9 6702.4 6723.4 6761.1 6405.8 6461.5 6501.8 6547.7 6559.2 4977.8 5026.5 5028.5 5046.7 5057.7 6588.7 6637.6 6670.9 6802.1 6875.7 6457.9 6576.7 6583.4 6587.8 6608.3 6430.9 6463.2 6516.3 6545.6 6580.7 6378.2 6443.3 6461.7 6490.2 6556.3 6505.5 6601.2 6605.2 6630.4 6689.4 6323.0 6338.3 6341.6 6401.6 6402.7 17:44:04 INFO - PID 3531 | 17:44:04 INFO - PID 3531 | [#5] yui.html Cycles:180 Average:23718.28 Median:18731.72 stddev:33613.11 (179.4%) stddev-sans-first:33663.78 17:44:04 INFO - PID 3531 | Values: 911.3 925.3 933.1 935.7 952.4 18610.8 18852.6 19539.1 19615.5 19620.9 21088.5 21828.6 21850.0 21907.5 21970.5 1006.4 1039.8 1044.9 1045.5 1046.0 1010.5 1041.8 1068.6 1072.3 1072.7 1118.5 1120.2 1124.1 1125.4 1126.8 1112.2 1115.6 1117.7 1119.0 1119.2 817.1 819.6 820.6 820.6 820.7 19715.4 19968.7 20049.5 20058.7 20439.7 21483.9 21547.2 21652.8 21963.9 21986.7 17054.3 17112.1 17254.7 17308.2 17336.7 3538.8 3558.7 3560.3 3562.1 3574.1 128936.0 130160.0 132130.0 132428.5 132672.3 16944.2 17076.5 17591.0 17595.1 17605.6 30025.8 31123.8 31144.4 31225.2 31242.5 7700.7 7964.2 8006.7 8342.0 8798.8 4097.7 4202.4 4202.9 4203.9 4208.8 5169.0 5237.4 5243.7 5266.6 5295.0 960.7 969.6 979.2 985.2 987.5 686.0 697.4 699.8 711.6 716.4 11558.8 12255.3 12264.6 12612.7 13034.7 676.9 677.3 683.2 697.1 707.1 5860.3 5899.3 5949.9 5959.9 6003.8 119157.4 119516.4 120936.0 123369.1 126021.0 100687.5 102919.0 103513.5 104296.5 105104.0 88812.6 88929.6 90264.0 91129.5 91945.1 10313.7 10597.5 10752.0 10832.6 11049.0 38923.2 40030.6 40087.6 41125.6 41434.0 51627.7 52184.0 52679.7 53642.0 54587.0 16032.7 16105.7 16265.0 16306.0 16323.6 18163.5 18168.5 18256.5 18294.9 18394.4 15832.6 16099.3 16117.2 16228.3 16248.1 16259.0 16278.5 16334.8 16378.0 16485.5 15901.4 15932.5 15943.6 16054.0 16090.0 11542.8 11599.4 11892.8 11900.3 11922.5 12127.3 12477.9 12557.2 12605.6 12614.2 17:44:04 INFO - PID 3531 | -------- Summary: end -------- 17:44:04 INFO - PID 3531 | 17:44:05 INFO - TEST-INFO | 3531: exit 0 17:44:05 INFO - TEST-OK | dromaeo_css | took 1111820ms 17:44:05 INFO - TEST-START | kraken 17:44:05 INFO - Initialising browser for kraken test... 17:44:05 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:60553/getInfo.html -profile /tmp/tmpihbFEx/profile 17:44:05 INFO - TEST-INFO | started process 3894 (/builds/slave/test/build/application/firefox/firefox http://localhost:60553/getInfo.html) 17:44:11 INFO - TEST-INFO | 3894: exit 0 17:44:11 INFO - Browser initialized. 17:44:11 INFO - Running cycle 1/1 for kraken test... 17:44:11 INFO - TEST-INFO | started process 4109 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpihbFEx/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 17:44:12 INFO - PID 4109 | 17:44:12 INFO - PID 4109 | (/builds/slave/test/build/application/firefox/firefox:4158): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 17:44:12 INFO - PID 4109 | 17:44:22 INFO - PID 4109 | RSS: Main: 165257216 17:44:22 INFO - PID 4109 | 17:44:25 INFO - PID 4109 | Cycle 1(1): loaded http://localhost:60553/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:60553/tests/kraken/driver.html?testName=audio-beat-detection) 17:44:26 INFO - PID 4109 | RSS: Main: 173092864 17:44:26 INFO - PID 4109 | 17:44:28 INFO - PID 4109 | Cycle 1(1): loaded http://localhost:60553/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:60553/tests/kraken/driver.html?testName=audio-dft) 17:44:29 INFO - PID 4109 | RSS: Main: 172621824 17:44:29 INFO - PID 4109 | 17:44:32 INFO - PID 4109 | Cycle 1(1): loaded http://localhost:60553/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:60553/tests/kraken/driver.html?testName=audio-fft) 17:44:33 INFO - PID 4109 | RSS: Main: 166170624 17:44:33 INFO - PID 4109 | 17:44:35 INFO - PID 4109 | Cycle 1(1): loaded http://localhost:60553/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:60553/tests/kraken/driver.html?testName=audio-oscillator) 17:44:35 INFO - PID 4109 | RSS: Main: 167419904 17:44:35 INFO - PID 4109 | 17:44:38 INFO - PID 4109 | Cycle 1(1): loaded http://localhost:60553/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:60553/tests/kraken/driver.html?testName=imaging-gaussian-blur) 17:44:38 INFO - PID 4109 | RSS: Main: 167378944 17:44:38 INFO - PID 4109 | 17:44:41 INFO - PID 4109 | Cycle 1(1): loaded http://localhost:60553/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:60553/tests/kraken/driver.html?testName=imaging-darkroom) 17:44:42 INFO - PID 4109 | RSS: Main: 170528768 17:44:42 INFO - PID 4109 | 17:44:45 INFO - PID 4109 | Cycle 1(1): loaded http://localhost:60553/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:60553/tests/kraken/driver.html?testName=imaging-desaturate) 17:44:46 INFO - PID 4109 | RSS: Main: 170807296 17:44:46 INFO - PID 4109 | 17:44:49 INFO - PID 4109 | Cycle 1(1): loaded http://localhost:60553/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:60553/tests/kraken/driver.html?testName=json-parse-financial) 17:44:49 INFO - PID 4109 | RSS: Main: 171216896 17:44:49 INFO - PID 4109 | 17:44:51 INFO - PID 4109 | Cycle 1(1): loaded http://localhost:60553/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:60553/tests/kraken/driver.html?testName=json-stringify-tinderbox) 17:44:52 INFO - PID 4109 | RSS: Main: 170893312 17:44:52 INFO - PID 4109 | 17:44:53 INFO - PID 4109 | Cycle 1(1): loaded http://localhost:60553/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:60553/tests/kraken/driver.html?testName=stanford-crypto-aes) 17:44:54 INFO - PID 4109 | RSS: Main: 171286528 17:44:54 INFO - PID 4109 | 17:44:56 INFO - PID 4109 | Cycle 1(1): loaded http://localhost:60553/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:60553/tests/kraken/driver.html?testName=stanford-crypto-ccm) 17:44:57 INFO - PID 4109 | RSS: Main: 171171840 17:44:57 INFO - PID 4109 | 17:44:59 INFO - PID 4109 | Cycle 1(1): loaded http://localhost:60553/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:60553/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 17:45:00 INFO - PID 4109 | RSS: Main: 171470848 17:45:00 INFO - PID 4109 | 17:45:03 INFO - PID 4109 | Cycle 1(1): loaded http://localhost:60553/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:60553/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 17:45:04 INFO - PID 4109 | RSS: Main: 171565056 17:45:04 INFO - PID 4109 | 17:45:06 INFO - PID 4109 | Cycle 1(1): loaded http://localhost:60553/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:60553/tests/kraken/driver.html?testName=ai-astar) 17:45:06 INFO - PID 4109 | RSS: Main: 173191168 17:45:06 INFO - PID 4109 | 17:45:06 INFO - PID 4109 | __start_tp_report 17:45:06 INFO - PID 4109 | _x_x_mozilla_page_load 17:45:06 INFO - PID 4109 | _x_x_mozilla_page_load_details 17:45:06 INFO - PID 4109 | |i|pagename|runs| 17:45:06 INFO - PID 4109 | |0;ai-astar;99;115;101;108;112;108;108;98;106;109 17:45:06 INFO - PID 4109 | |1;audio-beat-detection;150;117;153;182;118;150;148;119;172;120 17:45:06 INFO - PID 4109 | |2;audio-dft;165;164;164;162;162;163;162;169;170;162 17:45:06 INFO - PID 4109 | |3;audio-fft;75;76;76;174;76;76;75;75;156;78 17:45:06 INFO - PID 4109 | |4;audio-oscillator;79;79;129;79;78;78;132;80;79;130 17:45:06 INFO - PID 4109 | |5;imaging-gaussian-blur;115;115;114;115;114;114;114;115;114;114 17:45:06 INFO - PID 4109 | |6;imaging-darkroom;151;152;150;149;149;150;149;150;151;152 17:45:06 INFO - PID 4109 | |7;imaging-desaturate;95;93;94;97;94;94;95;97;95;95 17:45:06 INFO - PID 4109 | |8;json-parse-financial;55;55;55;55;56;55;55;54;55;58 17:45:06 INFO - PID 4109 | |9;json-stringify-tinderbox;55;54;54;54;54;54;54;54;54;53 17:45:06 INFO - PID 4109 | |10;stanford-crypto-aes;78;77;78;77;78;80;78;77;77;78 17:45:06 INFO - PID 4109 | |11;stanford-crypto-ccm;132;126;125;129;123;121;127;124;125;164 17:45:06 INFO - PID 4109 | |12;stanford-crypto-pbkdf2;188;176;185;176;176;180;173;176;177;183 17:45:06 INFO - PID 4109 | |13;stanford-crypto-sha256-iterative;67;68;70;69;69;72;69;67;68;66 17:45:06 INFO - PID 4109 | __end_tp_report 17:45:06 INFO - PID 4109 | __start_cc_report 17:45:06 INFO - PID 4109 | _x_x_mozilla_cycle_collect,984 17:45:06 INFO - PID 4109 | __end_cc_report 17:45:06 INFO - PID 4109 | __startTimestamp1502671506388__endTimestamp 17:45:06 INFO - PID 4109 | 17:45:06 INFO - PID 4109 | ------- Summary: start ------- 17:45:06 INFO - PID 4109 | Number of tests: 14 17:45:06 INFO - PID 4109 | 17:45:06 INFO - PID 4109 | [#0] ai-astar Cycles:10 Average:106.40 Median:110.50 stddev:5.52 (5.0%) stddev-sans-first:5.17 17:45:06 INFO - PID 4109 | Values: 99.0 115.0 101.0 108.0 112.0 108.0 108.0 98.0 106.0 109.0 17:45:06 INFO - PID 4109 | 17:45:06 INFO - PID 4109 | [#1] audio-beat-detection Cycles:10 Average:142.90 Median:150.00 stddev:23.55 (15.7%) stddev-sans-first:24.84 17:45:06 INFO - PID 4109 | Values: 150.0 117.0 153.0 182.0 118.0 150.0 148.0 119.0 172.0 120.0 17:45:06 INFO - PID 4109 | 17:45:06 INFO - PID 4109 | [#2] audio-dft Cycles:10 Average:164.30 Median:164.00 stddev:2.95 (1.8%) stddev-sans-first:3.11 17:45:06 INFO - PID 4109 | Values: 165.0 164.0 164.0 162.0 162.0 163.0 162.0 169.0 170.0 162.0 17:45:06 INFO - PID 4109 | 17:45:06 INFO - PID 4109 | [#3] audio-fft Cycles:10 Average:93.70 Median:76.00 stddev:37.83 (49.8%) stddev-sans-first:39.51 17:45:06 INFO - PID 4109 | Values: 75.0 76.0 76.0 174.0 76.0 76.0 75.0 75.0 156.0 78.0 17:45:06 INFO - PID 4109 | 17:45:06 INFO - PID 4109 | [#4] audio-oscillator Cycles:10 Average:94.30 Median:79.00 stddev:24.88 (31.5%) stddev-sans-first:25.77 17:45:06 INFO - PID 4109 | Values: 79.0 79.0 129.0 79.0 78.0 78.0 132.0 80.0 79.0 130.0 17:45:06 INFO - PID 4109 | 17:45:06 INFO - PID 4109 | [#5] imaging-gaussian-blur Cycles:10 Average:114.40 Median:114.50 stddev:0.52 (0.5%) stddev-sans-first:0.50 17:45:06 INFO - PID 4109 | Values: 115.0 115.0 114.0 115.0 114.0 114.0 114.0 115.0 114.0 114.0 17:45:06 INFO - PID 4109 | 17:45:06 INFO - PID 4109 | [#6] imaging-darkroom Cycles:10 Average:150.30 Median:150.50 stddev:1.16 (0.8%) stddev-sans-first:1.20 17:45:06 INFO - PID 4109 | Values: 151.0 152.0 150.0 149.0 149.0 150.0 149.0 150.0 151.0 152.0 17:45:06 INFO - PID 4109 | 17:45:06 INFO - PID 4109 | [#7] imaging-desaturate Cycles:10 Average:94.90 Median:95.00 stddev:1.29 (1.4%) stddev-sans-first:1.36 17:45:06 INFO - PID 4109 | Values: 95.0 93.0 94.0 97.0 94.0 94.0 95.0 97.0 95.0 95.0 17:45:06 INFO - PID 4109 | 17:45:06 INFO - PID 4109 | [#8] json-parse-financial Cycles:10 Average:55.30 Median:55.00 stddev:1.06 (1.9%) stddev-sans-first:1.12 17:45:06 INFO - PID 4109 | Values: 55.0 55.0 55.0 55.0 56.0 55.0 55.0 54.0 55.0 58.0 17:45:06 INFO - PID 4109 | 17:45:06 INFO - PID 4109 | [#9] json-stringify-tinderbox Cycles:10 Average:54.00 Median:54.00 stddev:0.47 (0.9%) stddev-sans-first:0.33 17:45:06 INFO - PID 4109 | Values: 55.0 54.0 54.0 54.0 54.0 54.0 54.0 54.0 54.0 53.0 17:45:06 INFO - PID 4109 | 17:45:06 INFO - PID 4109 | [#10] stanford-crypto-aes Cycles:10 Average:77.80 Median:78.00 stddev:0.92 (1.2%) stddev-sans-first:0.97 17:45:06 INFO - PID 4109 | Values: 78.0 77.0 78.0 77.0 78.0 80.0 78.0 77.0 77.0 78.0 17:45:06 INFO - PID 4109 | 17:45:06 INFO - PID 4109 | [#11] stanford-crypto-ccm Cycles:10 Average:129.60 Median:126.50 stddev:12.47 (9.9%) stddev-sans-first:13.20 17:45:06 INFO - PID 4109 | Values: 132.0 126.0 125.0 129.0 123.0 121.0 127.0 124.0 125.0 164.0 17:45:06 INFO - PID 4109 | 17:45:06 INFO - PID 4109 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:179.00 Median:178.50 stddev:4.83 (2.7%) stddev-sans-first:3.87 17:45:06 INFO - PID 4109 | Values: 188.0 176.0 185.0 176.0 176.0 180.0 173.0 176.0 177.0 183.0 17:45:06 INFO - PID 4109 | 17:45:06 INFO - PID 4109 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.50 Median:69.00 stddev:1.72 (2.5%) stddev-sans-first:1.73 17:45:06 INFO - PID 4109 | Values: 67.0 68.0 70.0 69.0 69.0 72.0 69.0 67.0 68.0 66.0 17:45:06 INFO - PID 4109 | -------- Summary: end -------- 17:45:06 INFO - PID 4109 | 17:45:06 INFO - PID 4109 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 17:45:07 INFO - TEST-INFO | 4109: exit 0 17:45:07 INFO - TEST-OK | kraken | took 61670ms 17:45:07 INFO - SUITE-END | took 1173s 17:45:07 INFO - Completed test suite (00:19:33) 17:45:07 INFO - javascript benchmark 17:45:07 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8610.323488738566, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3117.8596963136656, 3148.039847846406, 3181.793183443076, 3181.9522707159394, 3194.217416732901, 6122.326544080153, 6263.123162757206, 6293.930031894577, 6297.433231009209, 6332.556721029524, 6060.0, 6159.168512250845, 6172.969135154318, 6180.072989051644, 6201.286852012008, 5658.74535645897, 5666.631668941505, 5691.4877661010505, 5716.199732037498, 5771.538276937835, 5760.6255593386295, 5790.073588225885, 5793.362730099686, 5809.854753631151, 5811.0702287633985, 5521.365043020024, 5641.12562552805, 5741.569382296324, 5830.854228644275, 5846.152307915349, 5463.071277882769, 5700.429957004308, 5748.166515855178, 5776.59563830532, 5781.219535362757, 5635.915461268084, 5646.858828529279, 5730.799422020209, 5748.396418376052, 5758.510526605243, 6143.293521245069, 6148.415900489491, 6160.260768707739, 6161.075838624242, 6201.224846894138, 6584.572002819801, 6673.833154171136, 6705.932940670579, 6723.899141512881, 6725.66371681414, 6731.49513786468, 6745.696443660047, 6833.384995350442, 6836.897446538306, 6837.179538455367, 6087.4521293083835, 6155.815325540241, 6193.783217587363, 6249.406306400884, 6338.714757835908, 6901.896471552931, 6925.826854328581, 6932.272111428228, 6955.826104347432, 6973.4072603829245, 6535.411812936763, 6541.215054193527, 6544.443722283564, 6554.377334153248, 6642.0, 6649.667516624149, 6686.69909854048, 6711.63086030273, 6736.124303840469, 6752.729890804411, 6465.191851018622, 6585.901211481736, 6594.73621055162, 6668.0331351954665, 6693.263740988487, 6649.501287403464, 6698.129243198353, 6723.125993620798, 6736.5284430090405, 6741.629210393476, 5268.051750684914, 5278.81524146653, 5350.625456218105, 5403.891922161613, 5426.864328391743, 4599.701019433793, 4615.538446155358, 4637.072585482917, 4638.652101092432, 4645.883852903705, 5693.402192769782, 5768.451997060272, 5768.74040668171, 5770.711464426762, 5785.71071446426, 6683.365080317362, 6687.0, 6745.224299205556, 6783.796486105425, 6787.5588086774205, 5769.134629805479, 5782.017057100303, 5784.942150578525, 5809.50619197373, 5844.12338149281, 5733.226014487991, 5817.621854579439, 5851.356350801409, 5885.440883116183, 5918.2898052234, 6498.935010649928, 6505.121808555879, 6517.348265173445, 6526.869462610721, 6545.901811472737, 6696.799096026932, 6708.329167083252, 6724.596524208368, 6776.288489708608, 6799.728010879509, 6453.806385808433, 6469.708863101077, 6536.248331441945, 6543.1821022372205, 6547.083408322934, 6447.290798012309, 6463.127477790438, 6517.771877984248, 6526.575772574767, 6587.374199451045, 6754.5947243165565, 6765.932340676531, 6801.693923773343, 6812.216595091628, 6819.045333653194, 6498.317676643885, 6500.187476565429, 6509.218893732783, 6601.966990165019, 6610.933890661032, 6502.089707441057, 6503.341647879761, 6584.703688333941, 6591.538592298685, 6604.174478190226, 6315.842103947438, 6399.744010239725, 6407.839804004937, 6426.068220108152, 6459.321771214143, 6497.960326347762, 6509.056186852975, 6517.902231466626, 6549.541532092708, 6576.112224849775, 6303.180586523723, 6310.810675679737, 6383.553151279366, 6391.137196478602, 6392.808215753535], "value": 6099.8728407650215, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [780.2119858942466, 799.8040480082374, 834.2158371131136, 863.0808189278418, 864.7103220421161, 37848.81075594618, 40377.0, 41734.165316693645, 41810.37284440736, 41905.79047104764, 42022.36966445506, 42317.15365692684, 42359.576404236024, 42569.0, 42633.360499592454, 7332.413406927446, 7479.62601869907, 7483.887741683852, 7484.064491938508, 7485.139208990981, 7402.851942961164, 7530.887036694454, 7534.5855977921465, 7539.886901696479, 7540.0, 7575.659095340723, 7580.962095189517, 7601.657925393343, 7604.201558836326, 7605.505642133271, 7523.887141692851, 7546.735864244725, 7548.849023019564, 7549.962250188769, 7550.3582195513445, 7436.88844667325, 7496.062992125984, 7502.887456688154, 7505.812354691177, 7512.21121782216, 39237.60762392368, 39295.624653137005, 39569.20861582752, 39689.404658930136, 39730.80134599337, 3351.4302568563403, 3355.261842394669, 3389.6271410144864, 3391.3047825195777, 3391.440412331987, 31192.844035779675, 31301.217469563442, 31303.53044704331, 31328.530072048936, 31371.215719607193, 4784.114938736345, 5024.221245706921, 5025.346704928336, 5056.721880296583, 5073.644844860862, 200830.0, 201195.0, 201724.0, 201916.0, 202518.0, 48046.5195348049, 48206.27690584644, 48306.758466207444, 48480.27279590809, 48546.27180592294, 49154.50845491571, 49331.50668493341, 49384.0, 49410.0, 49447.0, 14889.181095039878, 15193.468228611946, 15255.313510892036, 15260.618484537976, 15284.847151528342, 12401.689957750948, 12416.689582760504, 12423.130380873252, 12425.130240883233, 12431.254124752544, 12779.552715655094, 12907.741845163044, 12920.870791292155, 12985.610431687064, 13075.738485230242, 5152.536271735562, 5174.197999310113, 5176.767045482962, 5272.314599102092, 5322.654027488201, 973.3284034016506, 985.2561316206362, 992.9950350248347, 996.8704068471197, 997.1773287038078, 22260.55478890413, 22456.88771556132, 22525.774742252368, 22637.320880373616, 22858.023985157215, 1096.5010920031366, 1096.8848270931596, 1101.388729255255, 1112.093643680398, 1113.2485572238706, 12103.273803571814, 12115.273083615011, 12132.332721700392, 12260.203086799507, 12269.815952760715, 221252.0, 223364.0, 223677.0, 247611.0, 255507.0, 56937.145942810894, 57033.714831425576, 57104.714476428184, 57315.14027289594, 57429.71285143548, 1478.2830327291256, 1479.8298195707416, 1490.567735356756, 1496.3416096917322, 1504.9097054176784, 28139.859300703367, 28435.0, 28583.571246430904, 28888.133355999355, 28977.275568110967, 37689.62310376861, 38088.0, 38135.0, 38179.0, 38254.42618360671, 227937.0, 229403.0, 229694.0, 229782.0, 229838.0, 37296.0, 37360.81319593385, 37440.812795935846, 37495.62504374921, 37549.0, 44342.55657443513, 44785.328220077376, 45624.54375456203, 45687.0, 45702.0, 33019.504707428925, 33186.83406582951, 33429.66570334265, 33597.83201083979, 33705.66294337124, 32969.67030329666, 33128.83435582807, 33135.668643314224, 33343.49984750279, 33756.49365259474, 35032.0, 36254.0, 36489.270214596094, 36579.817100914326, 36771.26457470889, 31189.8440507796, 31556.36887262196, 31600.36799263956, 31881.68118318787, 32334.514982275756, 23179.884100580064, 23699.52600947937, 23964.40088997789, 24027.159049433187, 24180.0], "value": 17254.67315527669, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [563.6082922368953, 567.5658121537025, 583.122400786816, 584.5323741007193, 591.7573794744155, 22369.888150559244, 22644.660330095063, 23136.88431557844, 23174.073037078495, 23214.65178022329, 25220.873895630542, 27212.59181112285, 27255.046073387435, 27308.5903711444, 27319.863400682967, 6336.0, 6489.059086432464, 6492.707828147721, 6494.902576461357, 6494.967525162368, 6396.968015159918, 6438.645874476902, 6478.449331806802, 6943.1668199816095, 6999.615021173833, 6953.269906659803, 6954.23503414624, 6958.930410695904, 6960.756373526928, 6964.965175174117, 6985.650717464132, 6986.720531178747, 6986.825329366756, 6987.860242795141, 6988.895166572505, 6837.692303846339, 6847.383735463783, 6856.657167141673, 6858.691358888862, 6862.210845752703, 32054.358912821845, 32288.515672264934, 32501.349973000644, 32558.348833023443, 32689.0, 1948.65898467769, 2002.2791794953805, 2003.4190084875368, 2005.0576229172266, 2006.4582562707988, 19824.504387390287, 20475.8976205118, 20502.487437814023, 20506.897465512728, 20520.38438846837, 2471.209213051824, 2482.987585062081, 2524.6591710119083, 2593.4164812916943, 2603.271084096456, 147463.0, 151547.24226378798, 152129.23935380252, 152156.0, 152343.0, 19760.455095328154, 22443.551128977328, 22575.548489030127, 23218.76781232166, 23388.415289617897, 45782.54217457849, 45936.5406345939, 45950.0, 46048.0, 46123.53876461193, 11958.461869215906, 12098.0, 12142.635720928387, 12180.878191218151, 12256.38718064111, 10089.243306752023, 10114.797704045877, 10147.238957078249, 10214.131798797036, 10261.794764104676, 11493.597724079784, 11712.70718232051, 12177.878221217852, 12245.32650704202, 12302.261864287992, 4353.4122893408985, 4594.287885377705, 4612.53874612536, 4614.054118905617, 4668.206404911173, 945.0407836046281, 962.8603852441357, 973.0366936732584, 976.3165783951121, 980.1766516126488, 20185.394438166877, 20340.389788306373, 20465.0, 20591.485212869797, 20794.896025519774, 1025.9692209233735, 1028.8148133336072, 1035.414990530348, 1037.4397825174472, 1043.1446214104512, 11067.778644427066, 11339.829902551468, 11525.596604118984, 11619.186656933933, 11630.127740419503, 531755.0, 540723.0, 548398.0, 551228.0, 556265.0, 117783.41108294403, 121591.0, 123740.38129809294, 124017.0, 124565.37717311537, 1257.4787550960448, 1271.4151490314373, 1311.3574348569132, 1312.744014917082, 1325.0062453160322, 21266.680999784705, 21289.148434062463, 21310.467238319165, 21387.25144619931, 21619.891900540395, 59115.0, 59213.40786592251, 59297.70351148216, 60769.0884636722, 61035.694821525605, 71012.64493677499, 72449.0, 73420.26579734348, 73877.0, 74000.25999739933, 12843.486260549847, 13290.534831280858, 14731.705365892836, 14905.701885962437, 15346.616334591725, 23301.76698232996, 23699.289021329387, 24402.877985609957, 24792.628110577996, 25001.499970000863, 18193.181306840957, 18244.543886402946, 18247.726284106015, 18354.449366519028, 18594.349197778014, 16495.34018639289, 17072.658546829243, 17128.40050598273, 17171.141442927554, 17312.913435432743, 18320.358787442376, 19565.217391304188, 19624.509387265432, 19840.60318793645, 20005.499862503555, 14730.410783568537, 15048.473303434328, 15072.321745521696, 15073.472428464951, 15077.396904123712, 17748.467545973643, 17949.64100717952, 17967.371142009968, 17979.011154386633, 18000.639987200444], "value": 13148.398140550158, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1338.3375229261515, 1396.4763213794827, 1409.964750881228, 1416.8795652369542, 1419.971600567988, 14058.718825623482, 14438.711225775505, 14717.632059198511, 14742.041767285133, 14836.332365043572, 14398.424063037492, 14721.41114355427, 14727.705445891075, 14728.852711472882, 14745.041572297792, 2647.3381654586356, 2671.505771432291, 2681.3430709476106, 2684.7181045990183, 2703.0, 2564.3204550794053, 2743.533599288126, 2748.367875388662, 2751.9036833710725, 2756.503829310723, 2611.0469678567283, 2623.5802271636544, 2629.1192450529097, 2633.7892968562564, 2634.5521261385516, 2604.374950011993, 2630.473905218964, 2644.352133727249, 2645.0742240215964, 2647.7749391301763, 2549.31168584483, 2563.717991020986, 2572.601246806748, 2583.354161459635, 2612.7517885800817, 14040.297985100806, 14162.291885405792, 14306.64233394163, 14308.21304828234, 14350.856491435057, 7469.626518674045, 7802.0, 7804.0635123785505, 7811.804704882366, 7821.804454888616, 4977.42759582649, 5137.922931156036, 5208.9739551302, 5240.4497527759795, 5263.973680131575, 1864.4220291709614, 1910.121344181678, 1913.885166889991, 1954.2280799084424, 1957.7357056797293, 24113.0, 24179.395515112086, 24354.878225608758, 24439.877800611062, 24459.143929962367, 6348.746050158034, 6414.326495717975, 6415.807525774234, 6637.834054148589, 6642.800715978528, 16401.917990409973, 16415.5896102596, 16419.507414777574, 16438.095904725116, 16454.84816062864, 7505.061867266591, 7658.157602663702, 7660.080790305199, 7661.616919154131, 7670.539767613961, 6891.448684105259, 7012.859742805217, 7081.610511421921, 7118.0, 7119.430445564342, 4831.4202295724735, 4983.078130545789, 5042.42012168598, 5049.0, 5085.593152547787, 1347.9258640774656, 1349.9392527336292, 1370.397025308861, 1372.1766939836018, 1394.079907261223, 882.580774132282, 901.531203774047, 903.5256490342623, 903.8915330160291, 920.6179435534312, 7665.61671916402, 7724.266194711493, 7739.264769846855, 7752.224777522202, 7766.0, 700.726716580534, 712.2983860897116, 719.413677852559, 723.6128671160903, 728.2208037399931, 4666.60333871618, 5710.857228569319, 5798.391168927202, 5907.675077870673, 5911.940880591225, 20182.89908550448, 20189.394318170478, 20453.0, 20532.692009619866, 20580.073896674687, 18895.52761180954, 20247.29134480286, 20249.696254556195, 20285.087171077335, 20321.89839050795, 9740.17208537268, 9756.170725488413, 10793.892061079288, 11160.832587511193, 11299.322040677422, 8384.496930184208, 8916.28669706435, 8934.687285944961, 8950.328725345755, 9046.773830654287, 16984.745228821826, 17612.207450664493, 17832.0, 18068.096595170453, 18177.81822181761, 17477.0, 17655.735163972808, 17879.73180402321, 18003.72994405059, 18154.092295385442, 11537.250078744855, 11674.70813229642, 11803.822942655695, 11806.114541409257, 11812.881871181178, 13060.738785224432, 13131.540396086091, 13264.33678316061, 13328.800067999182, 13359.398827052612, 10854.077403420797, 10927.453627318444, 11013.063889569476, 11073.944630276797, 11319.603813866475, 10431.061204491632, 10438.582456701646, 10439.321444106108, 10677.733056673334, 10683.626073087406, 9572.952135239279, 9658.661946831828, 9668.951655241679, 9671.758206044906, 9695.66065187715, 7108.893366599402, 7142.5714457132735, 7342.0, 7382.5570465772225, 7622.5426474411715, 7324.0, 7431.145418276751, 7459.738909138154, 7536.321731044232, 7551.622418879144], "value": 6436.404775413, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [500.1447524732708, 506.17998841876164, 513.5993924738704, 521.7260938007546, 531.3199105145413, 6214.06788981653, 6228.377162283769, 6249.46888012437, 6289.874202515947, 6357.8092657220295, 6109.877802443949, 6141.508679305656, 6157.722902469389, 6176.351483094278, 6255.687215639223, 4818.132736107499, 4960.578350840183, 5002.97439024999, 5057.898842023157, 5104.464031276718, 4961.816800607739, 4973.154563724158, 4989.226669866159, 5000.699958002513, 5027.1453852844925, 4906.5093490650825, 4945.604351651878, 4963.0, 4972.353594032771, 5008.39899212095, 4959.752012399384, 5003.349564556603, 5012.0, 5026.185336211734, 5026.874328141789, 4469.128519938581, 4491.393661855673, 4492.3710680504755, 4511.255642818931, 4532.4787649420405, 5990.101484777275, 6025.548083893726, 6028.487578555784, 6062.484688801457, 6087.969560152215, 5708.286464191976, 5726.337253177293, 5741.971290143564, 5769.336526299488, 5796.739146738407, 6573.769918052845, 6621.205455345341, 6632.8673426531195, 6635.236947751022, 6696.83257918551, 4841.661083724141, 4844.667716377989, 4844.878878028042, 4889.731064791435, 4900.338454308694, 6570.507211959074, 6701.074710088179, 6722.630255336004, 6841.418479429254, 7007.544509606859, 4992.625553083533, 4993.975030124826, 5019.29729837823, 5052.221278296922, 5055.747212639427, 5043.747812609355, 5050.267711181858, 5078.365204349457, 5078.822241221614, 5114.33513643224, 5658.405867383948, 5688.265079150899, 5696.658200507983, 5708.429157084258, 5743.224664670216, 6603.405693487609, 6655.733770649216, 6658.3341665834, 6708.664566771642, 6759.324067593201, 1747.772789537352, 1775.6271183051444, 1780.9848386419876, 1787.973180402295, 1798.2627122879558, 1194.2237545595433, 1201.405304374323, 1210.6126039667222, 1236.5239382837492, 1236.6413740015475, 5712.0, 5724.513416359656, 5743.684097374601, 5755.280589926259, 5773.653580785166, 6726.159230096238, 6755.18937727466, 6759.0, 6794.4033152209195, 6854.965725171442, 5708.914366284509, 5710.543156547466, 5711.685857277889, 5757.309122905278, 5788.913166302509, 3553.7157027437743, 3611.6749492545273, 3620.185458271868, 3626.220362622049, 3645.8177091145867, 6612.636305003271, 6613.0, 6614.239362473377, 6615.140031795836, 6656.267810540837, 6907.309269073053, 6958.130233720785, 6977.40692041172, 6980.581165130108, 7019.403350715144, 6492.383223593751, 6533.41199292066, 6546.541742078104, 6569.737210511526, 6596.274409814917, 6296.968515157395, 6630.204375474974, 6677.69950352245, 6784.525083244125, 6837.863242735018, 6646.401823835878, 6664.866702666017, 6702.430293424918, 6723.361280678328, 6761.087253220752, 6405.807825765234, 6461.450776684034, 6501.837454063686, 6547.70535325902, 6559.180102487189, 4977.8257760978195, 5026.547610715053, 5028.547430731252, 5046.747662616928, 5057.721825299644, 6588.703508342041, 6637.568558043905, 6670.899936501053, 6802.115724955724, 6875.690593923386, 6457.903131452938, 6576.704048317933, 6583.407493325623, 6587.769428069994, 6608.299352362692, 6430.935690643221, 6463.192100987377, 6516.305760502399, 6545.574537655038, 6580.7038683260325, 6378.182218067828, 6443.323451037761, 6461.741530338733, 6490.156279683611, 6556.311587283267, 6505.479561635152, 6601.174853143357, 6605.240397354173, 6630.436412904957, 6689.384324816056, 6322.968385158045, 6338.271098823694, 6341.573146042104, 6401.55189136756, 6402.711877965409], "value": 5071.7614401864585, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [911.2618778789185, 925.2736601767614, 933.0622724162216, 935.6584846531018, 952.3619175152647, 18610.81389186108, 18852.62294754104, 19539.12073956672, 19615.509612259702, 19620.90189549052, 21088.472788180265, 21828.563428731417, 21850.0, 21907.452313692167, 21970.45073873154, 1006.3810756384808, 1039.833626619741, 1044.8798388185342, 1045.513836066229, 1045.984310235347, 1010.5099026971913, 1041.8333066709329, 1068.636663534402, 1072.3351522056298, 1072.7050061233144, 1118.5022664914115, 1120.176670147441, 1124.083871644607, 1125.3979121170175, 1126.8028095083368, 1112.2047735868812, 1115.5872327238933, 1117.67587399654, 1119.0096764363557, 1119.2333251722596, 817.0930267403178, 819.6188772220886, 820.5568992743911, 820.6061090676449, 820.6676296100089, 19715.40853774389, 19968.70046949297, 20049.498762531053, 20058.699119513218, 20439.693404598944, 21483.892580536998, 21547.15718729555, 21652.783472165233, 21963.890180549155, 21986.670199947013, 17054.317827286894, 17112.058836763972, 17254.741178882326, 17308.221130049176, 17336.73994890065, 3538.752287339887, 3558.679718825292, 3560.2701446203464, 3562.1450851795644, 3574.1064733816547, 128936.0, 130160.0, 132129.99999999904, 132428.51864058018, 132672.33663831715, 16944.23750931211, 17076.487705368858, 17591.0, 17595.12024398775, 17605.559861003578, 30025.849870750506, 31123.84438077795, 31144.377112457623, 31225.219369515944, 31242.53136202959, 7700.730474433368, 7964.20357964199, 8006.679732810622, 8342.0, 8798.824023519493, 4097.733647312915, 4202.411662367271, 4202.894927626772, 4203.852865149705, 4208.810603522848, 5169.0, 5237.423883372826, 5243.711595862264, 5266.578673706094, 5295.046891559479, 960.6685693435753, 969.6024629901848, 979.1970584120952, 985.1970643925179, 987.5111819649176, 685.9622720750407, 697.3793323941696, 699.8355386484172, 711.5872793779596, 716.394646523697, 11558.826617600742, 12255.325957072268, 12264.570740024057, 12612.747745045048, 13034.674133146558, 676.932306769329, 677.3125277842993, 683.1528904158807, 697.052009267396, 707.0807949665415, 5860.253947663814, 5899.321578018497, 5949.9107513387335, 5959.940400596025, 6003.849903752353, 119157.40421297838, 119516.4024179891, 120936.0, 123369.14946275813, 126021.0, 100687.49656251672, 102919.0, 103513.48243258735, 104296.47851760844, 105104.0, 88812.5559372199, 88929.55535222283, 90264.0, 91129.54435227648, 91945.08054919365, 10313.74215644615, 10597.523111460157, 10752.0, 10832.620858269922, 11049.005589496985, 38923.22153556856, 40030.59969400269, 40087.59912400839, 41125.588744113375, 41433.96415089526, 51627.74186129045, 52184.0, 52679.736601318284, 53642.0, 54587.0, 16032.679346412773, 16105.677886441972, 16265.0, 16306.0, 16323.59191020234, 18163.45509634713, 18168.545786355447, 18256.543586410447, 18294.90852545729, 18394.356197533558, 15832.60418489547, 16099.275532601296, 16117.194140292704, 16228.269727862038, 16248.106354150636, 16259.0, 16278.51164465068, 16334.754978675091, 16378.0, 16485.505434836974, 15901.363945442054, 15932.522024339289, 15943.601409964844, 16054.0, 16090.034597923694, 11542.825722926262, 11599.362035088152, 11892.76214475723, 11900.345480998629, 11922.463489143183, 12127.332996685267, 12477.93761031189, 12557.183783054072, 12605.621831345074, 12614.243145411305], "value": 9019.578970215942, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1525.3999999999999, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [99.0, 115.0, 101.0, 108.0, 112.0, 108.0, 108.0, 98.0, 106.0, 109.0], "value": 106.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 117.0, 153.0, 182.0, 118.0, 150.0, 148.0, 119.0, 172.0, 120.0], "value": 142.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 164.0, 164.0, 162.0, 162.0, 163.0, 162.0, 169.0, 170.0, 162.0], "value": 164.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 76.0, 174.0, 76.0, 76.0, 75.0, 75.0, 156.0, 78.0], "value": 93.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 79.0, 129.0, 79.0, 78.0, 78.0, 132.0, 80.0, 79.0, 130.0], "value": 94.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 115.0, 114.0, 115.0, 114.0, 114.0, 114.0, 115.0, 114.0, 114.0], "value": 114.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 152.0, 150.0, 149.0, 149.0, 150.0, 149.0, 150.0, 151.0, 152.0], "value": 150.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 93.0, 94.0, 97.0, 94.0, 94.0, 95.0, 97.0, 95.0, 95.0], "value": 94.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 55.0, 55.0, 55.0, 56.0, 55.0, 55.0, 54.0, 55.0, 58.0], "value": 55.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 54.0, 54.0, 54.0, 54.0, 54.0, 54.0, 54.0, 54.0, 53.0], "value": 54.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 77.0, 78.0, 77.0, 78.0, 80.0, 78.0, 77.0, 77.0, 78.0], "value": 77.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [132.0, 126.0, 125.0, 129.0, 123.0, 121.0, 127.0, 124.0, 125.0, 164.0], "value": 129.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [188.0, 176.0, 185.0, 176.0, 176.0, 180.0, 173.0, 176.0, 177.0, 183.0], "value": 179.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 68.0, 70.0, 69.0, 69.0, 72.0, 69.0, 67.0, 68.0, 66.0], "value": 68.5, "unit": "score"}]}]} 17:45:07 INFO - Return code: 0 17:45:07 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 17:45:07 INFO - # TBPL SUCCESS # 17:45:07 INFO - Running post-action listener: _package_coverage_data 17:45:07 INFO - Running post-action listener: _resource_record_post_action 17:45:07 INFO - [mozharness: 2017-08-14 00:45:07.701830Z] Finished run-tests step (success) 17:45:07 INFO - Running post-run listener: _resource_record_post_run 17:45:07 INFO - Total resource usage - Wall time: 1193s; CPU: 13.0%; Read bytes: 6279168; Write bytes: 439107584; Read time: 3084; Write time: 393224 17:45:07 INFO - TinderboxPrint: CPU usage
13.1% 17:45:07 INFO - TinderboxPrint: I/O read bytes / time
6,279,168 / 3,084 17:45:07 INFO - TinderboxPrint: I/O write bytes / time
439,107,584 / 393,224 17:45:07 INFO - TinderboxPrint: CPU idle
8,262.0 (86.9%) 17:45:07 INFO - TinderboxPrint: CPU user
1,197.7 (12.6%) 17:45:07 INFO - TinderboxPrint: Swap in / out
0 / 0 17:45:07 INFO - install - Wall time: 18s; CPU: 14.0%; Read bytes: 4096; Write bytes: 228798464; Read time: 12; Write time: 261252 17:45:07 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 17:45:07 INFO - run-tests - Wall time: 1175s; CPU: 13.0%; Read bytes: 4124672; Write bytes: 153669632; Read time: 2660; Write time: 36628 17:45:08 INFO - Running post-run listener: _upload_blobber_files 17:45:08 INFO - Blob upload gear active. 17:45:08 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 17:45:08 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 17:45:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 17:45:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 17:45:08 INFO - (blobuploader) - INFO - Open directory for files ... 17:45:08 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 17:45:08 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:45:08 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:45:09 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 17:45:09 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:45:09 INFO - (blobuploader) - INFO - Done attempting. 17:45:09 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 17:45:09 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:45:09 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:45:16 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 17:45:16 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:45:16 INFO - (blobuploader) - INFO - Done attempting. 17:45:16 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 17:45:16 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:45:16 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:45:17 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 17:45:17 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:45:17 INFO - (blobuploader) - INFO - Done attempting. 17:45:17 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 17:45:17 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:45:17 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:45:18 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 17:45:18 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:45:18 INFO - (blobuploader) - INFO - Done attempting. 17:45:18 INFO - (blobuploader) - INFO - Iteration through files over. 17:45:18 INFO - Return code: 0 17:45:18 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 17:45:18 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 17:45:18 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/dcdcad6ca29d84f91ee0dc007f04f40d252bddfba29093bd687629b99dcee341b902f6be8fe4053c4d67e7040eb71cc23e257d3bec4c3e0fd5f595dc1f798270", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/4451fb5dc059e0d40883ad9fd172327ddb9f0d62e710d4caf88a4caaeb2fe052774c3167eaf8bd72dde49c59a308c4350c720ea50be06052160889e1b8a82a4a", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/2afd936288471ac9112e7f6ab608a203a7c8d34bc77b03439ee2041f5a885f391d239995c8891fe024e0f9a7093da4e56920359c9f1409decbb908cde321e682", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/c1670d49c0e9750190c61891cc5f9c133823b0282a69946083612634a9c3e3ccf307ba6a071499c0379612fba0b0279b5758b76f7adfe1b9f8b0341c2dc7ec9c"} 17:45:18 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 17:45:18 INFO - Writing to file /builds/slave/test/properties/blobber_files 17:45:18 INFO - Contents: 17:45:18 INFO - blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/dcdcad6ca29d84f91ee0dc007f04f40d252bddfba29093bd687629b99dcee341b902f6be8fe4053c4d67e7040eb71cc23e257d3bec4c3e0fd5f595dc1f798270", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/4451fb5dc059e0d40883ad9fd172327ddb9f0d62e710d4caf88a4caaeb2fe052774c3167eaf8bd72dde49c59a308c4350c720ea50be06052160889e1b8a82a4a", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/2afd936288471ac9112e7f6ab608a203a7c8d34bc77b03439ee2041f5a885f391d239995c8891fe024e0f9a7093da4e56920359c9f1409decbb908cde321e682", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/c1670d49c0e9750190c61891cc5f9c133823b0282a69946083612634a9c3e3ccf307ba6a071499c0379612fba0b0279b5758b76f7adfe1b9f8b0341c2dc7ec9c"} 17:45:18 INFO - Running post-run listener: copy_logs_to_upload_dir 17:45:18 INFO - Copying logs to upload dir... 17:45:18 INFO - mkdir: /builds/slave/test/build/upload/logs 17:45:18 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1257.693986 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 57 secs) (at 2017-08-13 17:45:18.187237) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-08-13 17:45:18.190376) ========= 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=934fc3100db09dcb9af4d4b6000001ab-1502669820.30246-1911042536 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/dcdcad6ca29d84f91ee0dc007f04f40d252bddfba29093bd687629b99dcee341b902f6be8fe4053c4d67e7040eb71cc23e257d3bec4c3e0fd5f595dc1f798270", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/4451fb5dc059e0d40883ad9fd172327ddb9f0d62e710d4caf88a4caaeb2fe052774c3167eaf8bd72dde49c59a308c4350c720ea50be06052160889e1b8a82a4a", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/2afd936288471ac9112e7f6ab608a203a7c8d34bc77b03439ee2041f5a885f391d239995c8891fe024e0f9a7093da4e56920359c9f1409decbb908cde321e682", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/c1670d49c0e9750190c61891cc5f9c133823b0282a69946083612634a9c3e3ccf307ba6a071499c0379612fba0b0279b5758b76f7adfe1b9f8b0341c2dc7ec9c"} build_url:https://queue.taskcluster.net/v1/task/LPo6Qd1VS8e-mSF6G8gTBA/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011058 build_url: 'https://queue.taskcluster.net/v1/task/LPo6Qd1VS8e-mSF6G8gTBA/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/dcdcad6ca29d84f91ee0dc007f04f40d252bddfba29093bd687629b99dcee341b902f6be8fe4053c4d67e7040eb71cc23e257d3bec4c3e0fd5f595dc1f798270", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/4451fb5dc059e0d40883ad9fd172327ddb9f0d62e710d4caf88a4caaeb2fe052774c3167eaf8bd72dde49c59a308c4350c720ea50be06052160889e1b8a82a4a", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/2afd936288471ac9112e7f6ab608a203a7c8d34bc77b03439ee2041f5a885f391d239995c8891fe024e0f9a7093da4e56920359c9f1409decbb908cde321e682", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/c1670d49c0e9750190c61891cc5f9c133823b0282a69946083612634a9c3e3ccf307ba6a071499c0379612fba0b0279b5758b76f7adfe1b9f8b0341c2dc7ec9c"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-08-13 17:45:18.216030) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-08-13 17:45:18.216693) ========= 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=934fc3100db09dcb9af4d4b6000001ab-1502669820.30246-1911042536 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004394 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-08-13 17:45:18.301345) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-08-13 17:45:18.301716) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-08-13 17:45:18.302090) ========= ========= Total master_lag: 0.23 =========