builder: mozilla-central_ubuntu64_hw_styloseq_test-dromaeojs-e10s slave: talos-linux64-ix-053 starttime: 1502473578.23 results: success (0) revision: 2261de3ebaaa934e43f4e12835e114ec0c8fec5c ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-08-11 10:46:18.230119) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-08-11 10:46:18.230536) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-08-11 10:46:18.230805) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-08-11 10:46:18.276817) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-11 10:46:18.277136) ========= 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=920470bf432669ad7e3a5387000001ca-1502472487.713932-41578209 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-08-11 10:46:18-- 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% 108M=0s 2017-08-11 10:46:18 (108 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.142683 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-11 10:46:18.435076) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-08-11 10:46:18.435363) ========= 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=920470bf432669ad7e3a5387000001ca-1502472487.713932-41578209 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018529 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-08-11 10:46:18.486624) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-11 10:46:18.487490) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 2261de3ebaaa934e43f4e12835e114ec0c8fec5c --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 2261de3ebaaa934e43f4e12835e114ec0c8fec5c --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=920470bf432669ad7e3a5387000001ca-1502472487.713932-41578209 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-08-11 10:46:18,717 truncating revision to first 12 chars 2017-08-11 10:46:18,717 Setting DEBUG logging. 2017-08-11 10:46:18,717 attempt 1/10 2017-08-11 10:46:18,717 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/2261de3ebaaa?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-08-11 10:46:19,176 unpacking tar archive at: mozilla-central-2261de3ebaaa/testing/mozharness/ program finished with exit code 0 elapsedTime=0.824882 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-11 10:46:19.337565) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-08-11 10:46:19.337890) ========= script_repo_revision: 2261de3ebaaa934e43f4e12835e114ec0c8fec5c ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-08-11 10:46:19.338418) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-08-11 10:46:19.338681) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-08-11 10:46:19.355721) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 3 secs) (at 2017-08-11 10:46:19.358021) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=920470bf432669ad7e3a5387000001ca-1502472487.713932-41578209 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 10:46:19 INFO - MultiFileLogger online at 20170811 10:46:19 in /builds/slave/test 10:46:19 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 10:46:19 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 10:46:19 INFO - {'append_to_log': False, 10:46:19 INFO - 'base_work_dir': '/builds/slave/test', 10:46:19 INFO - 'blob_upload_branch': 'Firefox', 10:46:19 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 10:46:19 INFO - 'branch': 'Firefox', 10:46:19 INFO - 'buildbot_json_path': 'buildprops.json', 10:46:19 INFO - 'code_coverage': False, 10:46:19 INFO - 'config_files': ('talos/linux_config.py',), 10:46:19 INFO - 'default_actions': ('clobber', 10:46:19 INFO - 'read-buildbot-config', 10:46:19 INFO - 'download-and-extract', 10:46:19 INFO - 'populate-webroot', 10:46:19 INFO - 'create-virtualenv', 10:46:19 INFO - 'install', 10:46:19 INFO - 'setup-mitmproxy', 10:46:19 INFO - 'run-tests'), 10:46:19 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 10:46:19 INFO - 'disable_ccov_upload': False, 10:46:19 INFO - 'download_minidump_stackwalk': True, 10:46:19 INFO - 'download_symbols': 'ondemand', 10:46:19 INFO - 'enable_stylo': False, 10:46:19 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 10:46:19 INFO - 'tooltool.py': '/tools/tooltool.py', 10:46:19 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 10:46:19 INFO - '/tools/misc-python/virtualenv.py')}, 10:46:19 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 10:46:19 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 10:46:19 INFO - 'gecko_profile': False, 10:46:19 INFO - 'gecko_profile_interval': 0, 10:46:19 INFO - 'installer_path': 'installer.exe', 10:46:19 INFO - 'log_level': 'info', 10:46:19 INFO - 'log_name': 'talos', 10:46:19 INFO - 'log_to_console': True, 10:46:19 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 10:46:19 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 10:46:19 INFO - 'opt_config_files': (), 10:46:19 INFO - 'pip_index': False, 10:46:19 INFO - 'suite': 'dromaeojs-e10s', 10:46:19 INFO - 'system_bits': '32', 10:46:19 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 10:46:19 INFO - 'title': 'talos-linux64-ix-053', 10:46:19 INFO - 'tooltool_cache': '/builds/tooltool_cache', 10:46:19 INFO - 'use_talos_json': True, 10:46:19 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 10:46:19 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 10:46:19 INFO - 'work_dir': 'build'} 10:46:19 INFO - [mozharness: 2017-08-11 17:46:19.764568Z] Running clobber step. 10:46:19 INFO - Running pre-action listener: _resource_record_pre_action 10:46:19 INFO - Running main action method: clobber 10:46:19 INFO - rmtree: /builds/slave/test/build 10:46:19 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 10:46:20 INFO - Running post-action listener: _resource_record_post_action 10:46:20 INFO - [mozharness: 2017-08-11 17:46:20.759781Z] Finished clobber step (success) 10:46:20 INFO - [mozharness: 2017-08-11 17:46:20.759883Z] Running read-buildbot-config step. 10:46:20 INFO - Running pre-action listener: _resource_record_pre_action 10:46:20 INFO - Running main action method: read_buildbot_config 10:46:20 INFO - Using buildbot properties: 10:46:20 INFO - { 10:46:20 INFO - "project": "", 10:46:20 INFO - "product": "firefox", 10:46:20 INFO - "who": "ffxbld@noreply.mozilla.org", 10:46:20 INFO - "installer_path": "public/build/target.tar.bz2", 10:46:20 INFO - "builddir": "mozilla-central_ubuntu64_hw_styloseq_test-dromaeojs-e10s", 10:46:20 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 10:46:20 INFO - "buildername": "Ubuntu HW 12.04 x64 stylo-sequential mozilla-central talos dromaeojs-e10s", 10:46:20 INFO - "stage_platform": "linux64-stylosequential", 10:46:20 INFO - "basedir": "/builds/slave/test", 10:46:20 INFO - "buildnumber": 28, 10:46:20 INFO - "platform": "ubuntu64_hw_styloseq", 10:46:20 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 10:46:20 INFO - "slavebuilddir": "test", 10:46:20 INFO - "taskId": "K-ehfJmFQNWMStP9hC7Klg", 10:46:20 INFO - "branch": "mozilla-central", 10:46:20 INFO - "script_repo_revision": "production", 10:46:20 INFO - "revision": "2261de3ebaaa934e43f4e12835e114ec0c8fec5c", 10:46:20 INFO - "slavename": "talos-linux64-ix-053", 10:46:20 INFO - "repo_path": "mozilla-central" 10:46:20 INFO - } 10:46:20 INFO - Finding installer, test and symbols from parent task. 10:46:20 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/K-ehfJmFQNWMStP9hC7Klg'}, attempt #1 10:46:21 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/K-ehfJmFQNWMStP9hC7Klg'}, attempt #1 10:46:21 INFO - Task dependencies: E4iAGlFXSzGuQDDtIxOgHQ 10:46:21 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/E4iAGlFXSzGuQDDtIxOgHQ'}, attempt #1 10:46:22 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/E4iAGlFXSzGuQDDtIxOgHQ/artifacts/public/build/target.tar.bz2 10:46:22 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/E4iAGlFXSzGuQDDtIxOgHQ/artifacts/public/build/target.test_packages.json 10:46:22 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/E4iAGlFXSzGuQDDtIxOgHQ/artifacts/public/build/target.crashreporter-symbols.zip 10:46:22 INFO - Running post-action listener: _resource_record_post_action 10:46:22 INFO - [mozharness: 2017-08-11 17:46:22.118435Z] Finished read-buildbot-config step (success) 10:46:22 INFO - [mozharness: 2017-08-11 17:46:22.118656Z] Running download-and-extract step. 10:46:22 INFO - Running pre-action listener: _resource_record_pre_action 10:46:22 INFO - Running main action method: download_and_extract 10:46:22 INFO - mkdir: /builds/slave/test/build/tests 10:46:22 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')]} 10:46:22 INFO - trying https://queue.taskcluster.net/v1/task/E4iAGlFXSzGuQDDtIxOgHQ/artifacts/public/build/target.test_packages.json 10:46:22 INFO - Downloading https://queue.taskcluster.net/v1/task/E4iAGlFXSzGuQDDtIxOgHQ/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 10:46:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/E4iAGlFXSzGuQDDtIxOgHQ/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 10:46:22 INFO - Downloaded 989 bytes. 10:46:22 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 10:46:22 INFO - Using the following test package requirements: 10:46:22 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 10:46:22 INFO - u'common': [u'target.common.tests.zip'], 10:46:22 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 10:46:22 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 10:46:22 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 10:46:22 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 10:46:22 INFO - u'mozbase': [u'target.common.tests.zip'], 10:46:22 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 10:46:22 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 10:46:22 INFO - u'web-platform': [u'target.common.tests.zip', 10:46:22 INFO - u'target.web-platform.tests.tar.gz'], 10:46:22 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 10:46:22 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 10:46:22 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/E4iAGlFXSzGuQDDtIxOgHQ/artifacts/public/build/target.common.tests.zip 10:46:22 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/E4iAGlFXSzGuQDDtIxOgHQ/artifacts/public/build/target.common.tests.zip'}, attempt #1 10:46:22 INFO - Fetch https://queue.taskcluster.net/v1/task/E4iAGlFXSzGuQDDtIxOgHQ/artifacts/public/build/target.common.tests.zip into memory 10:46:25 INFO - Content-Length response header: 54036669 10:46:25 INFO - Bytes received: 54036669 10:46:37 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 10:46:37 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/E4iAGlFXSzGuQDDtIxOgHQ/artifacts/public/build/target.common.tests.zip 10:46:37 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/E4iAGlFXSzGuQDDtIxOgHQ/artifacts/public/build/target.common.tests.zip'}, attempt #1 10:46:37 INFO - Fetch https://queue.taskcluster.net/v1/task/E4iAGlFXSzGuQDDtIxOgHQ/artifacts/public/build/target.common.tests.zip into memory 10:46:38 INFO - Content-Length response header: 54036669 10:46:38 INFO - Bytes received: 54036669 10:46:50 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/E4iAGlFXSzGuQDDtIxOgHQ/artifacts/public/build/target.talos.tests.zip 10:46:50 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/E4iAGlFXSzGuQDDtIxOgHQ/artifacts/public/build/target.talos.tests.zip'}, attempt #1 10:46:50 INFO - Fetch https://queue.taskcluster.net/v1/task/E4iAGlFXSzGuQDDtIxOgHQ/artifacts/public/build/target.talos.tests.zip into memory 10:46:51 INFO - Content-Length response header: 14496050 10:46:51 INFO - Bytes received: 14496050 10:46:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:46:51 INFO - trying https://queue.taskcluster.net/v1/task/E4iAGlFXSzGuQDDtIxOgHQ/artifacts/public/build/target.tar.bz2 10:46:51 INFO - Downloading https://queue.taskcluster.net/v1/task/E4iAGlFXSzGuQDDtIxOgHQ/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 10:46:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/E4iAGlFXSzGuQDDtIxOgHQ/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 10:46:54 INFO - Downloaded 61817910 bytes. 10:46:54 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/E4iAGlFXSzGuQDDtIxOgHQ/artifacts/public/build/target.tar.bz2 10:46:54 INFO - mkdir: /builds/slave/test/properties 10:46:54 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 10:46:54 INFO - Writing to file /builds/slave/test/properties/build_url 10:46:54 INFO - Contents: 10:46:54 INFO - build_url:https://queue.taskcluster.net/v1/task/E4iAGlFXSzGuQDDtIxOgHQ/artifacts/public/build/target.tar.bz2 10:46:54 INFO - Running post-action listener: _resource_record_post_action 10:46:54 INFO - Running post-action listener: set_extra_try_arguments 10:46:54 INFO - [mozharness: 2017-08-11 17:46:54.452362Z] Finished download-and-extract step (success) 10:46:54 INFO - [mozharness: 2017-08-11 17:46:54.452590Z] Running populate-webroot step. 10:46:54 INFO - Running pre-action listener: _resource_record_pre_action 10:46:54 INFO - Running main action method: populate_webroot 10:46:54 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 10:46:54 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 10:46:54 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 10:46:54 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:46:54 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 10:46:54 INFO - 'tests': ['damp', 'tps']}, 10:46:54 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 10:46:54 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 10:46:54 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 10:46:54 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 10:46:54 INFO - 'other-e10s': {'tests': ['a11yr', 10:46:54 INFO - 'ts_paint', 10:46:54 INFO - 'tpaint', 10:46:54 INFO - 'sessionrestore', 10:46:54 INFO - 'sessionrestore_many_windows', 10:46:54 INFO - 'sessionrestore_no_auto_restore', 10:46:54 INFO - 'tabpaint']}, 10:46:54 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 10:46:54 INFO - 'perf-reftest-singletons-e10s': {'tests': ['bloom_basic_singleton']}, 10:46:54 INFO - 'svgr-e10s': {'tests': ['tsvgx', 10:46:54 INFO - 'tsvgr_opacity', 10:46:54 INFO - 'tart', 10:46:54 INFO - 'tscrollx', 10:46:54 INFO - 'tsvg_static']}, 10:46:54 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 10:46:54 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 10:46:54 INFO - 'talos_options': ['--mitmproxy', 10:46:54 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 10:46:54 INFO - '--firstNonBlankPaint'], 10:46:54 INFO - 'tests': ['tp6_google', 10:46:54 INFO - 'tp6_youtube', 10:46:54 INFO - 'tp6_amazon', 10:46:54 INFO - 'tp6_facebook']}, 10:46:54 INFO - 'tp6-stylo-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 10:46:54 INFO - 'talos_options': ['--stylo', 10:46:54 INFO - '--mitmproxy', 10:46:54 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 10:46:54 INFO - '--firstNonBlankPaint'], 10:46:54 INFO - 'tests': ['tp6_google', 10:46:54 INFO - 'tp6_youtube', 10:46:54 INFO - 'tp6_amazon', 10:46:54 INFO - 'tp6_facebook']}, 10:46:54 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 10:46:54 INFO - 'talos_options': ['--stylo', 10:46:54 INFO - '--stylo-threads=1', 10:46:54 INFO - '--mitmproxy', 10:46:54 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 10:46:54 INFO - '--firstNonBlankPaint'], 10:46:54 INFO - 'tests': ['tp6_google', 10:46:54 INFO - 'tp6_youtube', 10:46:54 INFO - 'tp6_amazon', 10:46:54 INFO - 'tp6_facebook']}, 10:46:54 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 10:46:54 INFO - 'talos_options': ['--xperf_path', 10:46:54 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:46:54 INFO - 'tests': ['tp5n']}}} 10:46:54 INFO - Running post-action listener: _resource_record_post_action 10:46:54 INFO - [mozharness: 2017-08-11 17:46:54.461550Z] Finished populate-webroot step (success) 10:46:54 INFO - [mozharness: 2017-08-11 17:46:54.461640Z] Running create-virtualenv step. 10:46:54 INFO - Running pre-action listener: _resource_record_pre_action 10:46:54 INFO - Running main action method: create_virtualenv 10:46:54 INFO - Creating virtualenv /builds/slave/test/build/venv 10:46:54 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 10:46:54 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 10:46:54 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 10:46:54 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 10:46:54 INFO - Using real prefix '/usr' 10:46:54 INFO - New python executable in /builds/slave/test/build/venv/bin/python 10:46:55 INFO - Installing distribute.............................................................................................................................................................................................done. 10:46:57 INFO - Installing pip.................done. 10:46:57 INFO - Return code: 0 10:46:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 10:46:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 10:46:57 INFO - Reading from file tmpfile_stdout 10:46:57 INFO - Output received: 10:46:57 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) 10:46:57 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 10:46:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:46:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:46:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:46:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:46:57 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14d41f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16a0a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1843700>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18408a0>, '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 0x18417a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1841c30>, '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': '920470bf432669ad7e3a5387000001ca-1502472487.713932-41578209', '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 10:46:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 10:46:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 10:46:57 INFO - Using env: {'DISPLAY': ':0', 10:46:57 INFO - 'HOME': '/home/cltbld', 10:46:57 INFO - 'LANG': 'en_US.UTF-8', 10:46:57 INFO - 'LANGUAGE': 'en_US:en', 10:46:57 INFO - 'LOGNAME': 'cltbld', 10:46:57 INFO - 'MAIL': '/var/mail/cltbld', 10:46:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:46:57 INFO - 'MOZ_NO_REMOTE': '1', 10:46:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:46:57 INFO - 'NO_EM_RESTART': '1', 10:46:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:46:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:46:57 INFO - 'PWD': '/builds/slave/test', 10:46:57 INFO - 'SHELL': '/bin/bash', 10:46:57 INFO - 'SHLVL': '1', 10:46:57 INFO - 'TERM': 'linux', 10:46:57 INFO - 'TMOUT': '86400', 10:46:57 INFO - 'USER': 'cltbld', 10:46:57 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1502472487.713932-41578209', 10:46:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:46:57 INFO - '_': '/tools/buildbot/bin/python'} 10:46:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:46:57 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 10:46:57 INFO - Cleaning up... 10:46:57 INFO - Return code: 0 10:46:57 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 10:46:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:46:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:46:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:46:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:46:57 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x14d41f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16a0a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1843700>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18408a0>, '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 0x18417a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1841c30>, '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': '920470bf432669ad7e3a5387000001ca-1502472487.713932-41578209', '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 10:46:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 10:46:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 10:46:57 INFO - Using env: {'DISPLAY': ':0', 10:46:57 INFO - 'HOME': '/home/cltbld', 10:46:57 INFO - 'LANG': 'en_US.UTF-8', 10:46:57 INFO - 'LANGUAGE': 'en_US:en', 10:46:57 INFO - 'LOGNAME': 'cltbld', 10:46:57 INFO - 'MAIL': '/var/mail/cltbld', 10:46:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:46:57 INFO - 'MOZ_NO_REMOTE': '1', 10:46:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:46:57 INFO - 'NO_EM_RESTART': '1', 10:46:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:46:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:46:57 INFO - 'PWD': '/builds/slave/test', 10:46:57 INFO - 'SHELL': '/bin/bash', 10:46:57 INFO - 'SHLVL': '1', 10:46:57 INFO - 'TERM': 'linux', 10:46:57 INFO - 'TMOUT': '86400', 10:46:57 INFO - 'USER': 'cltbld', 10:46:57 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1502472487.713932-41578209', 10:46:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:46:57 INFO - '_': '/tools/buildbot/bin/python'} 10:46:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:46:57 INFO - Downloading/unpacking psutil>=3.1.1 10:46:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:46:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:46:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:46:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:46:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 10:46:59 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:46:59 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:46:59 INFO - Installing collected packages: psutil 10:46:59 INFO - Running setup.py install for psutil 10:46:59 INFO - building 'psutil._psutil_linux' extension 10:46:59 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 10:47:00 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 10:47:00 INFO - building 'psutil._psutil_posix' extension 10:47:00 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 10:47:00 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 10:47:00 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:47:00 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:47:00 INFO - Successfully installed psutil 10:47:00 INFO - Cleaning up... 10:47:00 INFO - Return code: 0 10:47:00 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 10:47:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:47:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:47:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:47:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:47:00 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14d41f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16a0a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1843700>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18408a0>, '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 0x18417a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1841c30>, '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': '920470bf432669ad7e3a5387000001ca-1502472487.713932-41578209', '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 10:47:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 10:47:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 10:47:00 INFO - Using env: {'DISPLAY': ':0', 10:47:00 INFO - 'HOME': '/home/cltbld', 10:47:00 INFO - 'LANG': 'en_US.UTF-8', 10:47:00 INFO - 'LANGUAGE': 'en_US:en', 10:47:00 INFO - 'LOGNAME': 'cltbld', 10:47:00 INFO - 'MAIL': '/var/mail/cltbld', 10:47:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:47:00 INFO - 'MOZ_NO_REMOTE': '1', 10:47:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:47:00 INFO - 'NO_EM_RESTART': '1', 10:47:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:47:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:47:00 INFO - 'PWD': '/builds/slave/test', 10:47:00 INFO - 'SHELL': '/bin/bash', 10:47:00 INFO - 'SHLVL': '1', 10:47:00 INFO - 'TERM': 'linux', 10:47:00 INFO - 'TMOUT': '86400', 10:47:00 INFO - 'USER': 'cltbld', 10:47:00 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1502472487.713932-41578209', 10:47:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:47:00 INFO - '_': '/tools/buildbot/bin/python'} 10:47:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:47:00 INFO - Downloading/unpacking mozsystemmonitor==0.3 10:47:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:47:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:47:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:47:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:47:02 INFO - Downloading mozsystemmonitor-0.3.tar.gz 10:47:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 10:47:02 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 10:47:02 INFO - Installing collected packages: mozsystemmonitor 10:47:02 INFO - Running setup.py install for mozsystemmonitor 10:47:02 INFO - Successfully installed mozsystemmonitor 10:47:02 INFO - Cleaning up... 10:47:02 INFO - Return code: 0 10:47:02 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 10:47: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')]} 10:47:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:47: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')]} 10:47:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:47: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', '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 0x14d41f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16a0a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1843700>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18408a0>, '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 0x18417a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1841c30>, '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': '920470bf432669ad7e3a5387000001ca-1502472487.713932-41578209', '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 10:47: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', 'jsonschema==2.5.1'] in /builds/slave/test/build 10:47: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 jsonschema==2.5.1 10:47:02 INFO - Using env: {'DISPLAY': ':0', 10:47:02 INFO - 'HOME': '/home/cltbld', 10:47:02 INFO - 'LANG': 'en_US.UTF-8', 10:47:02 INFO - 'LANGUAGE': 'en_US:en', 10:47:02 INFO - 'LOGNAME': 'cltbld', 10:47:02 INFO - 'MAIL': '/var/mail/cltbld', 10:47:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:47:02 INFO - 'MOZ_NO_REMOTE': '1', 10:47:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:47:02 INFO - 'NO_EM_RESTART': '1', 10:47:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:47:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:47:02 INFO - 'PWD': '/builds/slave/test', 10:47:02 INFO - 'SHELL': '/bin/bash', 10:47:02 INFO - 'SHLVL': '1', 10:47:02 INFO - 'TERM': 'linux', 10:47:02 INFO - 'TMOUT': '86400', 10:47:02 INFO - 'USER': 'cltbld', 10:47:02 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1502472487.713932-41578209', 10:47:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:47:02 INFO - '_': '/tools/buildbot/bin/python'} 10:47:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:47:02 INFO - Downloading/unpacking jsonschema==2.5.1 10:47: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 10:47: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 10:47: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 10:47: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 10:47:03 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 10:47:03 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 10:47: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 10:47: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 10:47: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 10:47: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 10:47:03 INFO - Downloading functools32-3.2.3-2.tar.gz 10:47:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 10:47:03 INFO - warning: no files found matching '*.txt' 10:47:03 INFO - no previously-included directories found matching 'build' 10:47:03 INFO - no previously-included directories found matching 'dist' 10:47:03 INFO - no previously-included directories found matching '.git*' 10:47:03 INFO - Installing collected packages: jsonschema, functools32 10:47:03 INFO - Running setup.py install for functools32 10:47:03 INFO - warning: no files found matching '*.txt' 10:47:03 INFO - no previously-included directories found matching 'build' 10:47:03 INFO - no previously-included directories found matching 'dist' 10:47:03 INFO - no previously-included directories found matching '.git*' 10:47:03 INFO - Successfully installed jsonschema functools32 10:47:03 INFO - Cleaning up... 10:47:04 INFO - Return code: 0 10:47:04 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 10:47:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:47:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:47:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:47:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:47:04 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x14d41f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16a0a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1843700>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18408a0>, '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 0x18417a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1841c30>, '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': '920470bf432669ad7e3a5387000001ca-1502472487.713932-41578209', '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 10:47:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 10:47:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 10:47:04 INFO - Using env: {'DISPLAY': ':0', 10:47:04 INFO - 'HOME': '/home/cltbld', 10:47:04 INFO - 'LANG': 'en_US.UTF-8', 10:47:04 INFO - 'LANGUAGE': 'en_US:en', 10:47:04 INFO - 'LOGNAME': 'cltbld', 10:47:04 INFO - 'MAIL': '/var/mail/cltbld', 10:47:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:47:04 INFO - 'MOZ_NO_REMOTE': '1', 10:47:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:47:04 INFO - 'NO_EM_RESTART': '1', 10:47:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:47:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:47:04 INFO - 'PWD': '/builds/slave/test', 10:47:04 INFO - 'SHELL': '/bin/bash', 10:47:04 INFO - 'SHLVL': '1', 10:47:04 INFO - 'TERM': 'linux', 10:47:04 INFO - 'TMOUT': '86400', 10:47:04 INFO - 'USER': 'cltbld', 10:47:04 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1502472487.713932-41578209', 10:47:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:47:04 INFO - '_': '/tools/buildbot/bin/python'} 10:47:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:47:04 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 10:47:04 INFO - Cleaning up... 10:47:04 INFO - Return code: 0 10:47:04 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 10:47:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:47:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:47:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:47:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:47:04 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x14d41f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16a0a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1843700>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18408a0>, '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 0x18417a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1841c30>, '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': '920470bf432669ad7e3a5387000001ca-1502472487.713932-41578209', '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 10:47:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 10:47:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 10:47:04 INFO - Using env: {'DISPLAY': ':0', 10:47:04 INFO - 'HOME': '/home/cltbld', 10:47:04 INFO - 'LANG': 'en_US.UTF-8', 10:47:04 INFO - 'LANGUAGE': 'en_US:en', 10:47:04 INFO - 'LOGNAME': 'cltbld', 10:47:04 INFO - 'MAIL': '/var/mail/cltbld', 10:47:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:47:04 INFO - 'MOZ_NO_REMOTE': '1', 10:47:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:47:04 INFO - 'NO_EM_RESTART': '1', 10:47:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:47:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:47:04 INFO - 'PWD': '/builds/slave/test', 10:47:04 INFO - 'SHELL': '/bin/bash', 10:47:04 INFO - 'SHLVL': '1', 10:47:04 INFO - 'TERM': 'linux', 10:47:04 INFO - 'TMOUT': '86400', 10:47:04 INFO - 'USER': 'cltbld', 10:47:04 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1502472487.713932-41578209', 10:47:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:47:04 INFO - '_': '/tools/buildbot/bin/python'} 10:47:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:47:04 INFO - Downloading/unpacking blobuploader==1.2.4 10:47: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 10:47: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 10:47: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 10:47: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 10:47:05 INFO - Downloading blobuploader-1.2.4.tar.gz 10:47:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 10:47:05 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 10:47:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:47:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:47:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:47:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:47:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 10:47:05 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 10:47:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:47:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:47:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:47:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:47:06 INFO - Downloading docopt-0.6.1.tar.gz 10:47:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 10:47:06 INFO - Installing collected packages: blobuploader, requests, docopt 10:47:06 INFO - Running setup.py install for blobuploader 10:47:06 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 10:47:06 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 10:47:06 INFO - Running setup.py install for requests 10:47:06 INFO - Running setup.py install for docopt 10:47:06 INFO - Successfully installed blobuploader requests docopt 10:47:06 INFO - Cleaning up... 10:47:06 INFO - Return code: 0 10:47:06 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:47:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:47:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:47:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:47:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:47:06 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 0x14d41f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16a0a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1843700>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18408a0>, '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 0x18417a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1841c30>, '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': '920470bf432669ad7e3a5387000001ca-1502472487.713932-41578209', '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 10:47:06 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 10:47:06 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 10:47:06 INFO - Using env: {'DISPLAY': ':0', 10:47:06 INFO - 'HOME': '/home/cltbld', 10:47:06 INFO - 'LANG': 'en_US.UTF-8', 10:47:06 INFO - 'LANGUAGE': 'en_US:en', 10:47:06 INFO - 'LOGNAME': 'cltbld', 10:47:06 INFO - 'MAIL': '/var/mail/cltbld', 10:47:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:47:06 INFO - 'MOZ_NO_REMOTE': '1', 10:47:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:47:06 INFO - 'NO_EM_RESTART': '1', 10:47:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:47:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:47:06 INFO - 'PWD': '/builds/slave/test', 10:47:06 INFO - 'SHELL': '/bin/bash', 10:47:06 INFO - 'SHLVL': '1', 10:47:06 INFO - 'TERM': 'linux', 10:47:06 INFO - 'TMOUT': '86400', 10:47:06 INFO - 'USER': 'cltbld', 10:47:06 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1502472487.713932-41578209', 10:47:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:47:06 INFO - '_': '/tools/buildbot/bin/python'} 10:47:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:47:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:47:06 INFO - Running setup.py (path:/tmp/pip-CZ8GkE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:47:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:47:07 INFO - Running setup.py (path:/tmp/pip-G782A6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:47:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:47:07 INFO - Running setup.py (path:/tmp/pip-FJm6gn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:47:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:47:07 INFO - Running setup.py (path:/tmp/pip-RNhTzm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:47:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:47:07 INFO - Running setup.py (path:/tmp/pip-C9X3cR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:47:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:47:07 INFO - Running setup.py (path:/tmp/pip-kajjmH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:47:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:47:07 INFO - Running setup.py (path:/tmp/pip-dfSk0A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:47:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:47:07 INFO - Running setup.py (path:/tmp/pip-SlYqF_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:47:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:47:07 INFO - Running setup.py (path:/tmp/pip-Q0uqTQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:47:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:47:07 INFO - Running setup.py (path:/tmp/pip-A74xHx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:47:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:47:07 INFO - Running setup.py (path:/tmp/pip-2kX8je-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:47:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:47:07 INFO - Running setup.py (path:/tmp/pip-NmdHGI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:47:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:47:07 INFO - Running setup.py (path:/tmp/pip-nrycD9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:47:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:47:07 INFO - Running setup.py (path:/tmp/pip-5_pyEd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:47:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:47:07 INFO - Running setup.py (path:/tmp/pip-d_5lNT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:47:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:47:08 INFO - Running setup.py (path:/tmp/pip-HgnfFF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:47:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:47:08 INFO - Running setup.py (path:/tmp/pip-8Ovthc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:47:08 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 10:47:08 INFO - Running setup.py install for manifestparser 10:47:08 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 10:47:08 INFO - Running setup.py install for mozcrash 10:47:08 INFO - Running setup.py install for mozdebug 10:47:08 INFO - Running setup.py install for mozdevice 10:47:08 INFO - Installing dm script to /builds/slave/test/build/venv/bin 10:47:08 INFO - Running setup.py install for mozfile 10:47:08 INFO - Running setup.py install for mozhttpd 10:47:08 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 10:47:08 INFO - Running setup.py install for mozinfo 10:47:08 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 10:47:08 INFO - Running setup.py install for mozInstall 10:47:08 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 10:47:08 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 10:47:08 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 10:47:08 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 10:47:08 INFO - Running setup.py install for mozleak 10:47:09 INFO - Running setup.py install for mozlog 10:47:09 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 10:47:09 INFO - Running setup.py install for moznetwork 10:47:09 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 10:47:09 INFO - Running setup.py install for mozprocess 10:47:09 INFO - Running setup.py install for mozprofile 10:47:09 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 10:47:09 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 10:47:09 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 10:47:09 INFO - Running setup.py install for mozrunner 10:47:09 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 10:47:09 INFO - Running setup.py install for mozscreenshot 10:47:09 INFO - Running setup.py install for moztest 10:47:09 INFO - Running setup.py install for mozversion 10:47:09 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 10:47:09 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 10:47:09 INFO - Cleaning up... 10:47:09 INFO - Return code: 0 10:47:09 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:47:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:47:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:47:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:47:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:47:09 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 0x14d41f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16a0a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1843700>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18408a0>, '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 0x18417a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1841c30>, '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': '920470bf432669ad7e3a5387000001ca-1502472487.713932-41578209', '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 10:47:09 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 10:47:09 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 10:47:09 INFO - Using env: {'DISPLAY': ':0', 10:47:09 INFO - 'HOME': '/home/cltbld', 10:47:09 INFO - 'LANG': 'en_US.UTF-8', 10:47:09 INFO - 'LANGUAGE': 'en_US:en', 10:47:09 INFO - 'LOGNAME': 'cltbld', 10:47:09 INFO - 'MAIL': '/var/mail/cltbld', 10:47:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:47:09 INFO - 'MOZ_NO_REMOTE': '1', 10:47:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:47:09 INFO - 'NO_EM_RESTART': '1', 10:47:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:47:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:47:09 INFO - 'PWD': '/builds/slave/test', 10:47:09 INFO - 'SHELL': '/bin/bash', 10:47:09 INFO - 'SHLVL': '1', 10:47:09 INFO - 'TERM': 'linux', 10:47:09 INFO - 'TMOUT': '86400', 10:47:09 INFO - 'USER': 'cltbld', 10:47:09 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1502472487.713932-41578209', 10:47:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:47:09 INFO - '_': '/tools/buildbot/bin/python'} 10:47:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:47:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:47:10 INFO - Running setup.py (path:/tmp/pip-1LyxTq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:47:10 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)) 10:47:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:47:10 INFO - Running setup.py (path:/tmp/pip-SvLr4s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:47:10 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)) 10:47:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:47:10 INFO - Running setup.py (path:/tmp/pip-3lHkod-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:47:10 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)) 10:47:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:47:10 INFO - Running setup.py (path:/tmp/pip-t5RGc6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:47:10 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)) 10:47:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:47:10 INFO - Running setup.py (path:/tmp/pip-q7wODL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:47:10 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)) 10:47:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:47:10 INFO - Running setup.py (path:/tmp/pip-zPw5JW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:47:10 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)) 10:47:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:47:10 INFO - Running setup.py (path:/tmp/pip-_w0dNf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:47:10 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)) 10:47:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:47:10 INFO - Running setup.py (path:/tmp/pip-Mz5byI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:47:10 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)) 10:47:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:47:10 INFO - Running setup.py (path:/tmp/pip-_dIJdV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:47:10 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)) 10:47:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:47:10 INFO - Running setup.py (path:/tmp/pip-hmkXC1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:47:10 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)) 10:47:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:47:10 INFO - Running setup.py (path:/tmp/pip-jPJOOU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:47:10 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)) 10:47:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:47:10 INFO - Running setup.py (path:/tmp/pip-el69KA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:47:11 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)) 10:47:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:47:11 INFO - Running setup.py (path:/tmp/pip-5ijO0w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:47:11 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)) 10:47:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:47:11 INFO - Running setup.py (path:/tmp/pip-7PhPGr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:47:11 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)) 10:47:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:47:11 INFO - Running setup.py (path:/tmp/pip-zhbKcs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:47:11 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)) 10:47:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:47:11 INFO - Running setup.py (path:/tmp/pip-VJ9A3c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:47:11 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)) 10:47:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:47:11 INFO - Running setup.py (path:/tmp/pip-4Bo4r0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:47:11 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)) 10:47:11 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)) 10:47:11 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)) 10:47:11 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)) 10:47:11 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)) 10:47:11 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)) 10:47:11 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)) 10:47:11 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 10:47:11 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 10:47:11 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 10:47:11 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 10:47:11 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 10:47:12 INFO - Downloading blessings-1.6.tar.gz 10:47:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 10:47:12 INFO - Installing collected packages: blessings 10:47:12 INFO - Running setup.py install for blessings 10:47:12 INFO - Successfully installed blessings 10:47:12 INFO - Cleaning up... 10:47:12 INFO - Return code: 0 10:47:12 INFO - Done creating virtualenv /builds/slave/test/build/venv. 10:47:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:47:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:47:12 INFO - Reading from file tmpfile_stdout 10:47:12 INFO - Current package versions: 10:47:12 INFO - argparse == 1.2.1 10:47:12 INFO - blessings == 1.6 10:47:12 INFO - blobuploader == 1.2.4 10:47:12 INFO - docopt == 0.6.1 10:47:12 INFO - functools32 == 3.2.3-2 10:47:12 INFO - jsonschema == 2.5.1 10:47:12 INFO - manifestparser == 1.1 10:47:12 INFO - mozInstall == 1.13 10:47:12 INFO - mozcrash == 1.0 10:47:12 INFO - mozdebug == 0.1 10:47:12 INFO - mozdevice == 0.51 10:47:12 INFO - mozfile == 1.2 10:47:12 INFO - mozhttpd == 0.7 10:47:12 INFO - mozinfo == 0.10 10:47:12 INFO - mozleak == 0.1 10:47:12 INFO - mozlog == 3.5 10:47:12 INFO - moznetwork == 0.27 10:47:12 INFO - mozprocess == 0.25 10:47:12 INFO - mozprofile == 0.28 10:47:12 INFO - mozrunner == 6.13 10:47:12 INFO - mozscreenshot == 0.1 10:47:12 INFO - mozsystemmonitor == 0.3 10:47:12 INFO - moztest == 0.8 10:47:12 INFO - mozversion == 1.4 10:47:12 INFO - psutil == 3.1.1 10:47:12 INFO - requests == 1.2.3 10:47:12 INFO - wsgiref == 0.1.2 10:47:12 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:47:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:47:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:47:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:47:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:47:12 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 0x14d41f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16a0a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1843700>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18408a0>, '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 0x18417a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1841c30>, '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': '920470bf432669ad7e3a5387000001ca-1502472487.713932-41578209', '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 10:47:12 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 10:47:12 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 10:47:12 INFO - Using env: {'DISPLAY': ':0', 10:47:12 INFO - 'HOME': '/home/cltbld', 10:47:12 INFO - 'LANG': 'en_US.UTF-8', 10:47:12 INFO - 'LANGUAGE': 'en_US:en', 10:47:12 INFO - 'LOGNAME': 'cltbld', 10:47:12 INFO - 'MAIL': '/var/mail/cltbld', 10:47:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:47:12 INFO - 'MOZ_NO_REMOTE': '1', 10:47:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:47:12 INFO - 'NO_EM_RESTART': '1', 10:47:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:47:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:47:12 INFO - 'PWD': '/builds/slave/test', 10:47:12 INFO - 'SHELL': '/bin/bash', 10:47:12 INFO - 'SHLVL': '1', 10:47:12 INFO - 'TERM': 'linux', 10:47:12 INFO - 'TMOUT': '86400', 10:47:12 INFO - 'USER': 'cltbld', 10:47:12 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1502472487.713932-41578209', 10:47:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:47:12 INFO - '_': '/tools/buildbot/bin/python'} 10:47:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:47:13 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)) 10:47:13 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)) 10:47:13 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)) 10:47:13 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)) 10:47:13 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)) 10:47:13 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)) 10:47:13 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)) 10:47:13 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)) 10:47:13 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)) 10:47:13 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 10:47:13 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 10:47:13 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 10:47:13 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 10:47:13 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 10:47:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 10:47:14 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)) 10:47:14 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)) 10:47:14 INFO - Installing collected packages: simplejson 10:47:14 INFO - Running setup.py install for simplejson 10:47:14 INFO - building 'simplejson._speedups' extension 10:47:14 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 10:47:15 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 10:47:15 INFO - Successfully installed simplejson 10:47:15 INFO - Cleaning up... 10:47:15 INFO - Return code: 0 10:47:15 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 10:47:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:47:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:47:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:47:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:47:15 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 0x14d41f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16a0a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1843700>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18408a0>, '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 0x18417a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1841c30>, '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': '920470bf432669ad7e3a5387000001ca-1502472487.713932-41578209', '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 10:47:15 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 10:47:15 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 10:47:15 INFO - Using env: {'DISPLAY': ':0', 10:47:15 INFO - 'HOME': '/home/cltbld', 10:47:15 INFO - 'LANG': 'en_US.UTF-8', 10:47:15 INFO - 'LANGUAGE': 'en_US:en', 10:47:15 INFO - 'LOGNAME': 'cltbld', 10:47:15 INFO - 'MAIL': '/var/mail/cltbld', 10:47:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:47:15 INFO - 'MOZ_NO_REMOTE': '1', 10:47:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:47:15 INFO - 'NO_EM_RESTART': '1', 10:47:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:47:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:47:15 INFO - 'PWD': '/builds/slave/test', 10:47:15 INFO - 'SHELL': '/bin/bash', 10:47:15 INFO - 'SHLVL': '1', 10:47:15 INFO - 'TERM': 'linux', 10:47:15 INFO - 'TMOUT': '86400', 10:47:15 INFO - 'USER': 'cltbld', 10:47:15 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1502472487.713932-41578209', 10:47:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:47:15 INFO - '_': '/tools/buildbot/bin/python'} 10:47:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:47:15 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 10:47:15 INFO - Cleaning up... 10:47:15 INFO - Return code: 0 10:47:15 INFO - Running post-action listener: _resource_record_post_action 10:47:15 INFO - Running post-action listener: _start_resource_monitoring 10:47:15 INFO - Starting resource monitoring. 10:47:15 INFO - [mozharness: 2017-08-11 17:47:15.696312Z] Finished create-virtualenv step (success) 10:47:15 INFO - [mozharness: 2017-08-11 17:47:15.697253Z] Running install step. 10:47:15 INFO - Running pre-action listener: _resource_record_pre_action 10:47:15 INFO - Running main action method: install 10:47:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:47:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:47:15 INFO - Reading from file tmpfile_stdout 10:47:15 INFO - Detecting whether we're running mozinstall >=1.0... 10:47:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 10:47:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 10:47:16 INFO - Reading from file tmpfile_stdout 10:47:16 INFO - Output received: 10:47:16 INFO - Usage: mozinstall [options] installer 10:47:16 INFO - Options: 10:47:16 INFO - -h, --help show this help message and exit 10:47:16 INFO - -d DEST, --destination=DEST 10:47:16 INFO - Directory to install application into. [default: 10:47:16 INFO - "/builds/slave/test"] 10:47:16 INFO - --app=APP Application being installed. [default: firefox] 10:47:16 INFO - mkdir: /builds/slave/test/build/application 10:47:16 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'] 10:47:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 10:47:33 INFO - Reading from file tmpfile_stdout 10:47:33 INFO - Output received: 10:47:33 INFO - /builds/slave/test/build/application/firefox/firefox 10:47:33 INFO - Running post-action listener: _resource_record_post_action 10:47:33 INFO - [mozharness: 2017-08-11 17:47:33.996958Z] Finished install step (success) 10:47:33 INFO - [mozharness: 2017-08-11 17:47:33.997362Z] Running setup-mitmproxy step. 10:47:33 INFO - Running pre-action listener: _resource_record_pre_action 10:47:33 INFO - Running main action method: setup_mitmproxy 10:47:33 INFO - Skipping: mitmproxy is not required 10:47:33 INFO - Running post-action listener: _resource_record_post_action 10:47:33 INFO - [mozharness: 2017-08-11 17:47:33.998994Z] Finished setup-mitmproxy step (success) 10:47:33 INFO - [mozharness: 2017-08-11 17:47:33.999303Z] Running run-tests step. 10:47:33 INFO - Running pre-action listener: _resource_record_pre_action 10:47:33 INFO - Running pre-action listener: _set_gcov_prefix 10:47:34 INFO - Running main action method: run_tests 10:47:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 10:47:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 10:47:34 INFO - Python 2.7.3 10:47:34 INFO - Return code: 0 10:47:34 INFO - grabbing minidump binary from tooltool 10:47:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:47:34 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 0x18408a0>, '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 0x18417a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1841c30>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 10:47:34 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 10:47:34 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 10:47:34 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 10:47:34 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 10:47:34 INFO - Return code: 0 10:47:34 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 10:47:34 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 10:47:34 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 10:47:34 INFO - ENV: RUST_BACKTRACE is now full 10:47:34 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 10:47:34 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 10:47:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/E4iAGlFXSzGuQDDtIxOgHQ/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-053', '--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 10:47:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/E4iAGlFXSzGuQDDtIxOgHQ/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-053 --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 10:47:34 INFO - Using env: {'DISPLAY': ':0', 10:47:34 INFO - 'HOME': '/home/cltbld', 10:47:34 INFO - 'LANG': 'en_US.UTF-8', 10:47:34 INFO - 'LANGUAGE': 'en_US:en', 10:47:34 INFO - 'LOGNAME': 'cltbld', 10:47:34 INFO - 'MAIL': '/var/mail/cltbld', 10:47:34 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 10:47:34 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 10:47:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:47:34 INFO - 'MOZ_NO_REMOTE': '1', 10:47:34 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 10:47:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:47:34 INFO - 'NO_EM_RESTART': '1', 10:47:34 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:47:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:47:34 INFO - 'PWD': '/builds/slave/test', 10:47:34 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 10:47:34 INFO - 'RUST_BACKTRACE': 'full', 10:47:34 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 10:47:34 INFO - 'SHELL': '/bin/bash', 10:47:34 INFO - 'SHLVL': '1', 10:47:34 INFO - 'STYLO_FORCE_ENABLED': '1', 10:47:34 INFO - 'TERM': 'linux', 10:47:34 INFO - 'TMOUT': '86400', 10:47:34 INFO - 'USER': 'cltbld', 10:47:34 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1502472487.713932-41578209', 10:47:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:47:34 INFO - '_': '/tools/buildbot/bin/python'} 10:47:34 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/E4iAGlFXSzGuQDDtIxOgHQ/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-053', '--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 10:47:34 INFO - mozversion application_buildid: 20170811170435 10:47:34 INFO - mozversion application_changeset: 2261de3ebaaa934e43f4e12835e114ec0c8fec5c 10:47:34 INFO - mozversion application_display_name: Nightly 10:47:34 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 10:47:34 INFO - mozversion application_name: Firefox 10:47:34 INFO - mozversion application_remotingname: firefox 10:47:34 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 10:47:34 INFO - mozversion application_vendor: Mozilla 10:47:34 INFO - mozversion application_version: 57.0a1 10:47:34 INFO - mozversion platform_buildid: 20170811170435 10:47:34 INFO - mozversion platform_changeset: 2261de3ebaaa934e43f4e12835e114ec0c8fec5c 10:47:34 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 10:47:34 INFO - mozversion platform_version: 57.0a1 10:47:34 INFO - using testdate: 1502473654 10:47:34 INFO - actual date: 1502473654 10:47:34 INFO - starting webserver on 'localhost:52092' 10:47:34 INFO - SUITE-START | Running 2 tests 10:47:34 INFO - TEST-START | dromaeo_css 10:47:34 INFO - Initialising browser for dromaeo_css test... 10:47:34 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:52092/getInfo.html -profile /tmp/tmpekaxIJ/profile 10:47:34 INFO - TEST-INFO | started process 3330 (/builds/slave/test/build/application/firefox/firefox http://localhost:52092/getInfo.html) 10:47:43 INFO - TEST-INFO | 3330: exit 0 10:47:43 INFO - Browser initialized. 10:47:43 INFO - Running cycle 1/1 for dromaeo_css test... 10:47:43 INFO - TEST-INFO | started process 3561 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpekaxIJ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 10:47:44 INFO - PID 3561 | 10:47:44 INFO - PID 3561 | (/builds/slave/test/build/application/firefox/firefox:3615): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 10:47:44 INFO - PID 3561 | 10:47:54 INFO - PID 3561 | RSS: Main: 171315200 10:47:54 INFO - PID 3561 | 10:50:53 INFO - PID 3561 | Cycle 1(1): loaded http://localhost:52092/tests/dromaeo/cssquery-dojo.html (next: http://localhost:52092/tests/dromaeo/cssquery-ext.html) 10:50:54 INFO - PID 3561 | RSS: Main: 175710208 10:50:54 INFO - PID 3561 | 10:53:56 INFO - PID 3561 | Cycle 1(1): loaded http://localhost:52092/tests/dromaeo/cssquery-ext.html (next: http://localhost:52092/tests/dromaeo/cssquery-jquery.html) 10:53:57 INFO - PID 3561 | RSS: Main: 173461504 10:53:57 INFO - PID 3561 | 10:56:58 INFO - PID 3561 | Cycle 1(1): loaded http://localhost:52092/tests/dromaeo/cssquery-jquery.html (next: http://localhost:52092/tests/dromaeo/cssquery-mootools.html) 10:56:59 INFO - PID 3561 | RSS: Main: 175730688 10:56:59 INFO - PID 3561 | 11:00:01 INFO - PID 3561 | Cycle 1(1): loaded http://localhost:52092/tests/dromaeo/cssquery-mootools.html (next: http://localhost:52092/tests/dromaeo/cssquery-prototype.html) 11:00:02 INFO - PID 3561 | RSS: Main: 173641728 11:00:02 INFO - PID 3561 | 11:03:05 INFO - PID 3561 | Cycle 1(1): loaded http://localhost:52092/tests/dromaeo/cssquery-prototype.html (next: http://localhost:52092/tests/dromaeo/cssquery-yui.html) 11:03:06 INFO - PID 3561 | RSS: Main: 177508352 11:03:06 INFO - PID 3561 | 11:06:08 INFO - PID 3561 | Cycle 1(1): loaded http://localhost:52092/tests/dromaeo/cssquery-yui.html (next: http://localhost:52092/tests/dromaeo/cssquery-dojo.html) 11:06:08 INFO - PID 3561 | RSS: Main: 176308224 11:06:08 INFO - PID 3561 | 11:06:08 INFO - PID 3561 | __start_tp_report 11:06:08 INFO - PID 3561 | _x_x_mozilla_page_load 11:06:08 INFO - PID 3561 | _x_x_mozilla_page_load_details 11:06:08 INFO - PID 3561 | |i|pagename|runs| 11:06:08 INFO - PID 3561 | |0;dojo.html;3139.623245210575;3181.347823696142;3186.0919637903203;3192.5211218317236;3202.3275112226434;6150.569460137781;6204.41058099481;6208.099825525302;6264.248290205176;6295.559310848237;6079.848003799896;6170.876582468348;6203.255609326876;6214.440700336969;6245.188125543685;5656.660600363971;5671.461211184931;5674.9716251418895;5710.914336284959;5794.768209271624;5749.626274292178;5759.049756790125;5769.04810706233;5771.134329850514;5773.711314434283;164.68495767596593;5566.972165139189;5654.519365853907;5734.79928202513;5737;5594.412586678381;5598.916016259759;5603.887922241533;5665.603407761459;5692.943070569324;5568.220449137124;5571.220029195916;5634.211210430543;5639.577031722637;5658.462446067617;6038.818835434944;6055.091736239599;6068.787592434288;6140.324564297924;6181.041938499539;6516.641584712839;6524.445422139124;6600.966995164993;6609.173853268341;6641.070250164981;6593.736250549972;6613.206415230203;6682.498812589075;6698.330166983312;6703.363180497845;6090.086487026937;6231.252249730016;6232;6232.3144454110015;6234.283057448406;6726.091977582963;6754.5609535380045;6832.555883867532;6848.178218613699;6848.589084654936;6425.228972523327;6462.450691691259;6526.771562995273;6543.247526534415;6560.3111673273615;6520.217573891164;6522;6592.604443733391;6647.966760166169;6666.899996500057;6633.1045308882685;6662.800115996528;6673.799786006428;6677.098591690156;6680.532362734659;6692.962590798434;6736.831579210461;6768.390844823989;6781.220159681699;6788;5380.219868119101;5434.538064264581;5438.184272359178;5513.338399392099;5528.44715528444;4610.492845786961;4629.745364004944;4648.3259927310355;4654.488006319302;4668.8132474701315;5699.430056994267;5754.309482862083;5755.827325180251;5757.107648314518;5760.337561180434;6751.819367427591;6757.054012438262;6825.317468253135;6833;6844.041834143224;5785.0454674978155;5815.156802263648;5869.559783016291;5870.354261031283;5895.55783316253;5748;5820.476157145878;5861.794837180678;5909.527237820964;5988.341282458926;6438.967805161038;6444.742210311535;6448.580842245239;6450.290468048511;6481.254655714559;6639.535232533676;6730.427913627396;6733.225679046776;6752.628605426748;6758.628275444701;6418.743250269937;6517.120188774455;6521.543491955517;6526.738930442729;6539.6403197824575;6527;6527.072800055557;6557.049227862029;6622.304658011032;6637.137172167587;6599.8020059398295;6671.499637527302;6691.5315927884585;6708.563943343667;6793.184817821695;6422.036694495863;6491.707873145625;6493.805185844432;6501.609903405811;6525.2169739631545;6532.118164047983;6575.243846957661;6584.637844918576;6602.438792702674;6605.57063790852;6439.291677915519;6441.935580644134;6444.162258906312;6515.02274658786;6534.738610455719;6242.469390101892;6362;6495.512836537373;6636.336366363325;6647.7008534617025;6327.152781248548;6365.777197798055;6376.458001069961;6395.136656551306;6395.680215989275 11:06:08 INFO - PID 3561 | |1;ext.html;799.8280369720509;852.1563651984534;873.9992708348941;882.9161229683178;1177.3583397048608;31433.84283078587;31904.521432178535;41757.16485670288;42848.78575607125;43020.56979430205;42619.36070958938;42955.57044429555;42987.35518967218;43039;43110.78444607781;7308.853822923538;7720.806979825507;7881.975343205404;7900.881486777703;7907.762767116996;7771.533707977539;7837.177096404881;7839.216078392172;7846.176151504095;7881.645325960346;7843.803904902366;7845.137034926153;7911.723089691862;7918.524888506708;7921.366290696759;7805.063392392893;7817.374610031184;7826.7651970440975;7849.45053846231;7890.210978902092;7729.072511298624;7777.494462859896;7781.26078022587;7793.805154871116;7802.180771019075;39900.20199596021;39956.200875982606;40121.59878401208;40146.79926600378;40268.597314026774;3317.0712200583876;3350.6314305426386;3353.899383018513;3357.798532088058;3362.0754292569495;32436.837815811006;32588.185295367806;32593;32613.836930815432;32639.83680081608;5032.572231360302;5042.1428357179;5060.367454068241;5067.949320506785;5074.797008119671;185319;186328.0683596587;186858;186919;187061;49602.50397496051;49620;49774.502254976986;49785.75107124441;49849;52769.472305277224;52809.47190528122;52816.73591632017;52829.73585132127;52863.73568132135;16358.918205409134;16668.249928753234;16676.916615416845;16679.749803752955;16693.415730449375;12227.877721222852;12429.564965226175;13587.932060339832;13831.170129792245;13858.376373063236;14522.709545809024;14606.707865842624;14621.342039608244;14707.558773236606;14798.852011479747;5804.593678442553;5858.150568167592;5928.436798504135;5938.109283607493;6045.667488288186;1007.3452256033637;1011.944343061124;1017.8676772019738;1024.666983230453;1026.3021145621049;22957.73732444698;23113;23241.53516929652;23366.7663323368;23460.296191114296;1132.5526417065214;1134.546181527379;1139.2708666453477;1143.1540659911605;1145.169751929844;12186.81719774204;12451.377431128407;12469.501219951282;12541.561045363369;12574.748505030031;225085;226886;227057;227271;228675;54452.183217251775;54753;54759;54939.45060549343;54972.17541736877;1448.7681970884607;1489.6424858033993;1513.5988962924835;1520.3918432627038;1528.7936128622716;23131.884340578188;23251.76748232496;23288;23361.182358618047;23375.883120584287;38065.096745162075;38099.23801523899;38109;38160.80919595384;38207.42688859725;193348;194458;194482;194585;195337;34014.319713606084;34525.827370862986;36201.275974480886;36243;36358.8182059088;46176;46271.76864115658;46318.53681463142;46452.30321545112;46876;33893;34027.14932126716;34345.48481772726;34450.65549344474;34727.65272347345;33980.66019339874;34100;34322.82838585891;34496.655033449344;34662.13344666403;37085.07287317839;37188.6281137196;37246.25507489781;37299.25401491901;37429.251414972096;32701.345973080883;32815.179620509676;32828.835855820565;32982.835085825376;33211.50182747309;24223;24285.271441856774;24384.146554870495;24788.132415365377;24816.255512334657 11:06:08 INFO - PID 3561 | |2;jquery.html;576.4667682393786;577.2409281794443;580.9970950145249;582.4466756581248;599.8710277290384;22808.42978925528;23198.88400557997;24041.759582404193;24042.158524451646;24094.87952560237;26865;27420.177394678143;27464.17607471774;27531;27633.44733105337;6642.800715978528;6792.18493780747;6797.52417330787;6798.422134118606;6804.319568043205;5892.823215303548;6462.838429039288;6482.675866206694;6706.530542862001;6781.694823732919;6413.518986076039;6440.967795161041;6453.2256129264315;6456.612603243821;6468.74125034998;6436.839079023015;6447.645379504125;6453.354664533556;6455.903161452582;6458.354164583504;6022.3074346450285;6027.216461859974;6029.276486821565;6033.849153771147;6043.153958445821;29558;30954.226144346347;30996;31108.222294442592;31554;1924.788273289937;1950.658634738929;1956.9510762230916;1957.3540731558694;1962.077823422989;19442.805571944242;20171;20174.092165852424;20195.293164739163;20198.798012019986;2350.2714158610715;2439.524292762912;2483.8261321707487;2495.3761559610098;2501.5122051200024;139035;142431;142600.28699856537;143122.2843885774;143315.2834235822;14274.85725142756;14543.563693089225;15263.465778697693;15355.539333820003;15554.22228888551;22900.31299061031;23959.281221563382;23970.640440393407;23997.28008159758;24025.879870600536;10631.627893023708;10733.892661073445;10816;10851.40317282557;10932.836007459895;10199.235057370726;10204.591816327264;10250.64122755715;10258.794824103476;10325.896741032644;9528.952355238318;9552.331336806357;9756.512174391251;9846.359986600848;9848.162906153057;2605.726398728144;2647.8676066196613;2719.1434698070043;2748.477789220042;2834.4331133773326;952.3524003677566;969.8846326724182;980.5636491761098;982.872226610536;986.5905649155663;19534;19991.40025799228;20434.386968390972;20497.692534611993;20614.484637884172;1020.6580795433613;1022.120975960688;1023.7850051489122;1034.0848349211003;1036.896310368957;11097.556097756;11149.331040137455;11312.717182070513;11357.886421135849;11562.94218528902;473311;475088;484966;486021;492827;112652;114976.42511787555;115279.42360288145;117568;117614;1199.8440202773584;1209.6189700244395;1239.863615002349;1241.522014024589;1246.569933372985;17270.309187632352;17600.20799064071;17872.195751191488;17899.105044747972;18182.81817181811;56160.719196403756;56259.71870140623;59454.40545594662;59583.10625340536;61614.383856160865;70167.64916175387;70857;71774.28225717676;71809.6409517949;72069.63965180141;14589.05171163871;14915.32881020335;15084.019538729948;15174.165420901956;15274.694506110038;23636.29091127269;23809.523809523365;23947.40131496657;23961.16135935234;24115.276541703777;18626.627467450846;18740;18747.90626046861;18880.43358699241;18893.90553047281;15220.238988050332;16378.181090945644;16824.158792060593;17157.828421716124;17768.733468998234;18327.533797295917;19052.809471905104;19175.712364314266;19473;19538.706919395936;14588.978771485894;14713.043652162574;14812.407503700162;14832.851671483148;14885.181315027778;18796.154173061972;18883.622327553647;18915.243390264237;19013;19033.333833316323 11:06:08 INFO - PID 3561 | |3;mootools.html;1321.121454232935;1364.7785232217166;1398.5874167120699;1401.0332870319482;1405.4027038508639;13997.440102395905;15073.397064117436;15076.47232346868;15084.773728394055;15090.773638395432;14692.118472891634;14972.850271497282;14972.850271497282;14976.850231497681;14985.325660345283;2604.4140068484535;2706.9593956090675;2800.2439341377817;2805.7615102716295;2807.8174918630225;2675.933101672464;2707.241972247774;2738.2332946774836;2742.1088146352417;2743.245607457955;2643.1145566235236;2715.551933930909;2754.848483333416;2781.207355903568;2804.214819850435;2693.6498255226793;2695.245331307237;2696.28548434665;2711.769499592537;2713.1046754570943;2645.113886847889;2690.5291573974673;2710.91867243983;2741.4105967216947;2749.3264150283107;13872.098313609584;13937.09408888419;14146.717065658731;14150.716985660229;14174.291285435687;7706.730264440717;7922.485038472539;8003.599820008976;8018.639161237758;8025.95987020067;5151.278820965068;5373.489518495737;5460.590455715797;5462.453754624546;5479.205515200313;1827.4883032750852;1891.063923357933;1922.5097600111883;1946.425804387709;1957.9118939647751;23509.76490235093;23559.646605300935;23878.16426425084;24505.387365316008;24612.876935615386;6617.702203400762;6742.325767423218;6758.560693554903;6761.425278851254;6931.341522555349;16153;16159.757603635955;16172.595685107966;16184.83815161857;16193.190340482928;7640.465167438226;7766.068071831416;7788.844223115506;7790.2599253072;7809.3752499799875;7083.610401427868;7148.678309476086;7208.24313447091;7340.4861659684375;7376.704931802775;5185.611079169077;5295.470452954751;5304.310439642899;5351.143816989263;5353.330833645794;1504.646408094097;1505.1495904813746;1512.7125846089427;1514.5077849698891;1529.1971714849572;876.1194999025938;898.308302606989;907.4827348411342;912.5300470257822;913.8081002989313;6832.043513908056;6931.4108300795;8446.873296900552;8973.32700047499;8993.955030224806;955.47926380123;964.628617982082;970.5050424283667;974.8537719342155;996.2976101848179;5193.714345711022;5283.101872681654;5387.730613469311;5473.75368108436;5729.742161602738;19887.502812429804;20106.497337566387;20400.183992640425;20650.277240296517;20659.17363305481;19106.61786764257;20034.799652003585;20055.899720501304;20105.095270712853;20471.590568188552;9414.340996130206;9685.32202745801;9993.750156246151;11074.944625276983;11238.887611123948;7965.641546130322;8406.28546573548;8491.95754021226;8577.82844343122;8663.48019118855;17457.38899138524;17539.298428062735;17762.289508420035;17925.820741792417;18105.275788968294;17747.29010839552;17872.463826085237;18025.819741802938;18287.908560457112;18405.171767270236;11307.773844523228;11573.321868328876;11590.304581725124;11590.478428470908;11593.710157246136;13311.334433278103;13490.460381584626;13603.455861765418;13617.591472255848;13629.659258518617;10914.399708015817;10971.396573188551;11088.722781930517;11091.833622495831;11325.603603873826;10621;10622.415767132881;10656.307340022873;10844.837327439936;11031.282966607145;9394.67118650844;9499.572519236513;9502.85745713801;9514.762130946781;9583.137517623447;6710.530262881747;6778.7288508459105;6784.3554862288;6821.795346139624;6990.545614535039;6584.374484423972;6688.83277918056;6728.158980127484;6795.116634837637;6861.313868613099 11:06:08 INFO - PID 3561 | |4;prototype.html;499.1389852504433;515.8143068495342;517.8446466060182;530.8566686994509;534.3320848938827;6166.414190651892;6193.814185574434;6201.720922558485;6238.594491358059;6247.219542430408;6055.669381839993;6075.210222671058;6129.111278864562;6137.6931153442265;6173.839156295295;5074.8477545673595;5101.744912754366;5107.3105130807235;5126.384833819947;5136.922946155811;4775.9761201194115;4867.561919427251;5068.923966140511;5093.388793344804;5137.460566640505;4879.682485728851;4893.608511319086;4934.950650493485;4945.282933974571;4968.975155124237;4883.12103821312;4884.658073934844;4925.876853078666;4970.453250142481;4971.975140124277;4479.619232365253;4488.596026357611;4495.415595972535;4500.09998000398;4528.524504926968;5976.581639285252;5981.760729570812;5989.9101513477335;5990.610610310316;6044.516438684895;5612.915806262909;5652.180433837112;5680.971595141998;5696.231008813798;5723.255976723041;6395.968020159869;6413.711382987777;6466.191726034246;6477.190351206099;6491.805245842632;4880.487548807395;4918.2376731606655;4929.926051109236;4931.506849315076;4933.407991041062;6570.273336565319;6606.174228221473;6743.797686069377;6900.482463815184;6987.82530436738;4958.57852082577;4974.403071631355;4982.451930287665;5005.424376196784;5013.649044566845;5034.848954531297;5056.9494305057215;5085.567726743268;5089.720065396365;5093.567046800989;5729.8567535811935;5734.1077444443235;5742.540596752333;5754.74103665336;5762.859241713276;6645.700943457556;6654.301298363699;6656.467482601381;6669.566478178903;6682.5322227444585;1773.698471259889;1782.2514543891596;1789.2753434858903;1791.3192986665244;1792.5518620344915;1166.7083229192701;1211.9212251203644;1223.5411720604773;1240.6960294727849;1248.6878280429892;5802.274715660543;5804.622699524517;5823.388544202798;5824.1560570023585;5849.766009359663;6634.104395906587;6718.361755633207;6726.697298621574;6744.393004629607;6748.223954245226;5744.167095771089;5749.878773639184;5754.424557544212;5779.942200578024;5804.709764511842;3537.646235376442;3556;3598.4602309653237;3614.204874927512;3635.4546817977516;6466.224053113562;6505.902411463831;6544.803655890331;6565.409113179837;6571.868562628721;6739.93260067393;6896.172459304815;6905.75829845963;6912.758053468105;6915.585064896122;6347.333529979285;6407.7436902524305;6412.839679008062;6452.387023232879;6542.378474044958;6082.384574632773;6676.198856137295;6683.73009128264;6720.596764194164;6839.213490448463;6485.221773387224;6502.674866256573;6544.447665410589;6637.2699003108655;6687.832804179934;6354.301026887131;6422.389872962061;6475.93147130737;6489.967550162219;6514.57655252407;4770.212914869007;4933.432655244549;4970.3290055843445;5014;5042.042012017705;6346.777862774781;6558.245801732862;6582.341765823379;6648.9002664961035;6759;6501.609903405811;6530.706118224786;6533.67331633426;6557.475401967927;6591.813473574803;6476.935230647633;6524.445422139172;6531.412172904462;6533.640649764118;6536.215654121535;6442.710078046405;6499.967500162469;6500.187476565429;6523.771667991788;6532.379423954717;6588.209414870054;6590.80227593173;6609.4712423007;6643.269240383457;6644.368784965421;6337.429631333202;6374.728931615736;6417.010726674559;6428.453581445629;6439.581427207404 11:06:08 INFO - PID 3561 | |5;yui.html;893.8033632600825;919.9586018629161;925.2551695884812;927.9931274567094;939.7744541310087;19079.61840763184;19867.50331241718;19924.103415346326;19930.800691993074;22167.44581385466;21653.242136525223;22061.22785702501;22071.66892496614;22105.889470552665;22108.55782884341;1010.525053224985;1014.9746256343576;1015.527779582494;1017.1811691588268;1017.3641474078701;1005.4068099821104;1034.3897100710578;1037.6731329631143;1037.6835065305079;1037.8183817831887;1075.1882328841752;1079.3847506921059;1079.5088234853163;1079.7624522605015;1081.7133459633203;1068.1401471815186;1069.385103565453;1069.802086613975;1070.5931745936573;1070.9946450267776;787.2796391301952;789.3842802613971;789.4355535791879;790.1584812175015;790.2729488870253;18426.262949482003;18450.446486605422;18807.529811754677;18999.335023274118;20629.071691773905;19763.703544446846;20046.89976550108;20049.79950200494;20331.593368132555;20344.389668309974;16317.428889988794;16390.426335078217;16483.6703265934;16495;16939.576510587212;3658.9451158232646;3725.590185079639;3726.366517691999;3726.571444283915;3729.1982223821738;127458;130290;133747;134089.32955335258;134800;16643.41748038837;17035.829641703425;17100.401485947932;17261.482155535356;17368.913155434395;30651;31609;31675.524867127013;31685.20786980298;32128.03615891527;7630.847383052308;7940.364770818321;8811.162939520735;8972.685955991508;9217.308701847389;4258.829646814154;4335.414719012956;4340.240457919851;4346.391505189276;4347.934780978288;5204.115300398941;5215.269862219292;5281.471852814765;5327.38735045467;5335.119705248668;1036.9118624916816;1079.773247618009;1085.9565617375374;1095.0801326885296;1099.263493459384;683.3951952522053;712.3517598984898;715.6815217228284;724.2142275630894;735.9374453171433;11860.288382696894;12090;12155.635330940086;12374.876251237552;12694.619161425171;709.6558169287891;711.921688614252;715.5170260074428;717.9712811487586;723.8118089296715;5405.729713514309;5407.756650950717;5421.349438067457;5450;5486.177073439016;112452;115408;116428;120006.39996800135;121817.39091304663;95855.52072239594;99905.50047249717;100723;102512.48743756233;104003.47998260111;88679.9999999987;90266.54866725624;90600.5469972646;90627;91354.54322728344;12796.872031279569;13380.866191337962;13383.732325353632;13387.732245355233;13454.192748435125;39715.60284397119;40163.72984575474;40446.393304099875;40790.59209407868;40900.79549602233;51186.488135118176;51940;52138.217926731886;53537;54007.459925400246;18624.255029798656;18997.050147492293;19088.904555477133;19143.425697229104;19344.613107737485;19999.900000499903;20376.28682996088;20511.589768204252;21716.34850954474;22411.88794056019;19987.700184497535;20202.797972020093;20425.69361459609;20444.28445004418;20485.59028819445;17425.47723568295;17452.389166379115;17806.643867122842;19679.60640787205;20150.59698806045;19517.902410487855;19863.702044469057;20485;20603.896980515;21474.14103435845;12821.935890320488;12974.286414247306;13037.653222420055;13212.075154739461;13907.58277251684;14609.634759131106;14664;14698.41206351734;14713.411463541766;15433.69132617319 11:06:08 INFO - PID 3561 | __end_tp_report 11:06:08 INFO - PID 3561 | __start_cc_report 11:06:08 INFO - PID 3561 | _x_x_mozilla_cycle_collect,388 11:06:08 INFO - PID 3561 | __end_cc_report 11:06:08 INFO - PID 3561 | __startTimestamp1502474768319__endTimestamp 11:06:08 INFO - PID 3561 | 11:06:08 INFO - PID 3561 | ------- Summary: start ------- 11:06:08 INFO - PID 3561 | Number of tests: 6 11:06:08 INFO - PID 3561 | 11:06:08 INFO - PID 3561 | [#0] dojo.html Cycles:165 Average:6103.73 Median:6418.74 stddev:855.58 (13.3%) stddev-sans-first:826.01 11:06:08 INFO - PID 3561 | Values: 3139.6 3181.3 3186.1 3192.5 3202.3 6150.6 6204.4 6208.1 6264.2 6295.6 6079.8 6170.9 6203.3 6214.4 6245.2 5656.7 5671.5 5675.0 5710.9 5794.8 5749.6 5759.0 5769.0 5771.1 5773.7 164.7 5567.0 5654.5 5734.8 5737.0 5594.4 5598.9 5603.9 5665.6 5692.9 5568.2 5571.2 5634.2 5639.6 5658.5 6038.8 6055.1 6068.8 6140.3 6181.0 6516.6 6524.4 6601.0 6609.2 6641.1 6593.7 6613.2 6682.5 6698.3 6703.4 6090.1 6231.3 6232.0 6232.3 6234.3 6726.1 6754.6 6832.6 6848.2 6848.6 6425.2 6462.5 6526.8 6543.2 6560.3 6520.2 6522.0 6592.6 6648.0 6666.9 6633.1 6662.8 6673.8 6677.1 6680.5 6693.0 6736.8 6768.4 6781.2 6788.0 5380.2 5434.5 5438.2 5513.3 5528.4 4610.5 4629.7 4648.3 4654.5 4668.8 5699.4 5754.3 5755.8 5757.1 5760.3 6751.8 6757.1 6825.3 6833.0 6844.0 5785.0 5815.2 5869.6 5870.4 5895.6 5748.0 5820.5 5861.8 5909.5 5988.3 6439.0 6444.7 6448.6 6450.3 6481.3 6639.5 6730.4 6733.2 6752.6 6758.6 6418.7 6517.1 6521.5 6526.7 6539.6 6527.0 6527.1 6557.0 6622.3 6637.1 6599.8 6671.5 6691.5 6708.6 6793.2 6422.0 6491.7 6493.8 6501.6 6525.2 6532.1 6575.2 6584.6 6602.4 6605.6 6439.3 6441.9 6444.2 6515.0 6534.7 6242.5 6362.0 6495.5 6636.3 6647.7 6327.2 6365.8 6376.5 6395.1 6395.7 11:06:08 INFO - PID 3561 | 11:06:08 INFO - PID 3561 | [#1] ext.html Cycles:180 Average:37880.52 Median:34473.66 stddev:52665.69 (152.8%) stddev-sans-first:52739.83 11:06:08 INFO - PID 3561 | Values: 799.8 852.2 874.0 882.9 1177.4 31433.8 31904.5 41757.2 42848.8 43020.6 42619.4 42955.6 42987.4 43039.0 43110.8 7308.9 7720.8 7882.0 7900.9 7907.8 7771.5 7837.2 7839.2 7846.2 7881.6 7843.8 7845.1 7911.7 7918.5 7921.4 7805.1 7817.4 7826.8 7849.5 7890.2 7729.1 7777.5 7781.3 7793.8 7802.2 39900.2 39956.2 40121.6 40146.8 40268.6 3317.1 3350.6 3353.9 3357.8 3362.1 32436.8 32588.2 32593.0 32613.8 32639.8 5032.6 5042.1 5060.4 5067.9 5074.8 185319.0 186328.1 186858.0 186919.0 187061.0 49602.5 49620.0 49774.5 49785.8 49849.0 52769.5 52809.5 52816.7 52829.7 52863.7 16358.9 16668.2 16676.9 16679.7 16693.4 12227.9 12429.6 13587.9 13831.2 13858.4 14522.7 14606.7 14621.3 14707.6 14798.9 5804.6 5858.2 5928.4 5938.1 6045.7 1007.3 1011.9 1017.9 1024.7 1026.3 22957.7 23113.0 23241.5 23366.8 23460.3 1132.6 1134.5 1139.3 1143.2 1145.2 12186.8 12451.4 12469.5 12541.6 12574.7 225085.0 226886.0 227057.0 227271.0 228675.0 54452.2 54753.0 54759.0 54939.5 54972.2 1448.8 1489.6 1513.6 1520.4 1528.8 23131.9 23251.8 23288.0 23361.2 23375.9 38065.1 38099.2 38109.0 38160.8 38207.4 193348.0 194458.0 194482.0 194585.0 195337.0 34014.3 34525.8 36201.3 36243.0 36358.8 46176.0 46271.8 46318.5 46452.3 46876.0 33893.0 34027.1 34345.5 34450.7 34727.7 33980.7 34100.0 34322.8 34496.7 34662.1 37085.1 37188.6 37246.3 37299.3 37429.3 32701.3 32815.2 32828.8 32982.8 33211.5 24223.0 24285.3 24384.1 24788.1 24816.3 11:06:08 INFO - PID 3561 | 11:06:08 INFO - PID 3561 | [#2] jquery.html Cycles:180 Average:35028.89 Median:22854.37 stddev:81525.92 (356.7%) stddev-sans-first:81713.59 11:06:08 INFO - PID 3561 | Values: 576.5 577.2 581.0 582.4 599.9 22808.4 23198.9 24041.8 24042.2 24094.9 26865.0 27420.2 27464.2 27531.0 27633.4 6642.8 6792.2 6797.5 6798.4 6804.3 5892.8 6462.8 6482.7 6706.5 6781.7 6413.5 6441.0 6453.2 6456.6 6468.7 6436.8 6447.6 6453.4 6455.9 6458.4 6022.3 6027.2 6029.3 6033.8 6043.2 29558.0 30954.2 30996.0 31108.2 31554.0 1924.8 1950.7 1957.0 1957.4 1962.1 19442.8 20171.0 20174.1 20195.3 20198.8 2350.3 2439.5 2483.8 2495.4 2501.5 139035.0 142431.0 142600.3 143122.3 143315.3 14274.9 14543.6 15263.5 15355.5 15554.2 22900.3 23959.3 23970.6 23997.3 24025.9 10631.6 10733.9 10816.0 10851.4 10932.8 10199.2 10204.6 10250.6 10258.8 10325.9 9529.0 9552.3 9756.5 9846.4 9848.2 2605.7 2647.9 2719.1 2748.5 2834.4 952.4 969.9 980.6 982.9 986.6 19534.0 19991.4 20434.4 20497.7 20614.5 1020.7 1022.1 1023.8 1034.1 1036.9 11097.6 11149.3 11312.7 11357.9 11562.9 473311.0 475088.0 484966.0 486021.0 492827.0 112652.0 114976.4 115279.4 117568.0 117614.0 1199.8 1209.6 1239.9 1241.5 1246.6 17270.3 17600.2 17872.2 17899.1 18182.8 56160.7 56259.7 59454.4 59583.1 61614.4 70167.6 70857.0 71774.3 71809.6 72069.6 14589.1 14915.3 15084.0 15174.2 15274.7 23636.3 23809.5 23947.4 23961.2 24115.3 18626.6 18740.0 18747.9 18880.4 18893.9 15220.2 16378.2 16824.2 17157.8 17768.7 18327.5 19052.8 19175.7 19473.0 19538.7 14589.0 14713.0 14812.4 14832.9 14885.2 18796.2 18883.6 18915.2 19013.0 19033.3 11:06:08 INFO - PID 3561 | 11:06:08 INFO - PID 3561 | [#3] mootools.html Cycles:180 Average:8969.56 Median:2707.10 stddev:6188.91 (228.6%) stddev-sans-first:6179.59 11:06:08 INFO - PID 3561 | Values: 1321.1 1364.8 1398.6 1401.0 1405.4 13997.4 15073.4 15076.5 15084.8 15090.8 14692.1 14972.9 14972.9 14976.9 14985.3 2604.4 2707.0 2800.2 2805.8 2807.8 2675.9 2707.2 2738.2 2742.1 2743.2 2643.1 2715.6 2754.8 2781.2 2804.2 2693.6 2695.2 2696.3 2711.8 2713.1 2645.1 2690.5 2710.9 2741.4 2749.3 13872.1 13937.1 14146.7 14150.7 14174.3 7706.7 7922.5 8003.6 8018.6 8026.0 5151.3 5373.5 5460.6 5462.5 5479.2 1827.5 1891.1 1922.5 1946.4 1957.9 23509.8 23559.6 23878.2 24505.4 24612.9 6617.7 6742.3 6758.6 6761.4 6931.3 16153.0 16159.8 16172.6 16184.8 16193.2 7640.5 7766.1 7788.8 7790.3 7809.4 7083.6 7148.7 7208.2 7340.5 7376.7 5185.6 5295.5 5304.3 5351.1 5353.3 1504.6 1505.1 1512.7 1514.5 1529.2 876.1 898.3 907.5 912.5 913.8 6832.0 6931.4 8446.9 8973.3 8994.0 955.5 964.6 970.5 974.9 996.3 5193.7 5283.1 5387.7 5473.8 5729.7 19887.5 20106.5 20400.2 20650.3 20659.2 19106.6 20034.8 20055.9 20105.1 20471.6 9414.3 9685.3 9993.8 11074.9 11238.9 7965.6 8406.3 8492.0 8577.8 8663.5 17457.4 17539.3 17762.3 17925.8 18105.3 17747.3 17872.5 18025.8 18287.9 18405.2 11307.8 11573.3 11590.3 11590.5 11593.7 13311.3 13490.5 13603.5 13617.6 13629.7 10914.4 10971.4 11088.7 11091.8 11325.6 10621.0 10622.4 10656.3 10844.8 11031.3 9394.7 9499.6 9502.9 9514.8 9583.1 6710.5 6778.7 6784.4 6821.8 6990.5 6584.4 6688.8 6728.2 6795.1 6861.3 11:06:08 INFO - PID 3561 | 11:06:08 INFO - PID 3561 | [#4] prototype.html Cycles:180 Average:5500.41 Median:6065.44 stddev:1532.49 (25.3%) stddev-sans-first:1490.11 11:06:08 INFO - PID 3561 | Values: 499.1 515.8 517.8 530.9 534.3 6166.4 6193.8 6201.7 6238.6 6247.2 6055.7 6075.2 6129.1 6137.7 6173.8 5074.8 5101.7 5107.3 5126.4 5136.9 4776.0 4867.6 5068.9 5093.4 5137.5 4879.7 4893.6 4935.0 4945.3 4969.0 4883.1 4884.7 4925.9 4970.5 4972.0 4479.6 4488.6 4495.4 4500.1 4528.5 5976.6 5981.8 5989.9 5990.6 6044.5 5612.9 5652.2 5681.0 5696.2 5723.3 6396.0 6413.7 6466.2 6477.2 6491.8 4880.5 4918.2 4929.9 4931.5 4933.4 6570.3 6606.2 6743.8 6900.5 6987.8 4958.6 4974.4 4982.5 5005.4 5013.6 5034.8 5056.9 5085.6 5089.7 5093.6 5729.9 5734.1 5742.5 5754.7 5762.9 6645.7 6654.3 6656.5 6669.6 6682.5 1773.7 1782.3 1789.3 1791.3 1792.6 1166.7 1211.9 1223.5 1240.7 1248.7 5802.3 5804.6 5823.4 5824.2 5849.8 6634.1 6718.4 6726.7 6744.4 6748.2 5744.2 5749.9 5754.4 5779.9 5804.7 3537.6 3556.0 3598.5 3614.2 3635.5 6466.2 6505.9 6544.8 6565.4 6571.9 6739.9 6896.2 6905.8 6912.8 6915.6 6347.3 6407.7 6412.8 6452.4 6542.4 6082.4 6676.2 6683.7 6720.6 6839.2 6485.2 6502.7 6544.4 6637.3 6687.8 6354.3 6422.4 6475.9 6490.0 6514.6 4770.2 4933.4 4970.3 5014.0 5042.0 6346.8 6558.2 6582.3 6648.9 6759.0 6501.6 6530.7 6533.7 6557.5 6591.8 6476.9 6524.4 6531.4 6533.6 6536.2 6442.7 6500.0 6500.2 6523.8 6532.4 6588.2 6590.8 6609.5 6643.3 6644.4 6337.4 6374.7 6417.0 6428.5 6439.6 11:06:08 INFO - PID 3561 | 11:06:08 INFO - PID 3561 | [#5] yui.html Cycles:180 Average:24115.01 Median:20048.35 stddev:33022.43 (164.7%) stddev-sans-first:33069.03 11:06:08 INFO - PID 3561 | Values: 893.8 920.0 925.3 928.0 939.8 19079.6 19867.5 19924.1 19930.8 22167.4 21653.2 22061.2 22071.7 22105.9 22108.6 1010.5 1015.0 1015.5 1017.2 1017.4 1005.4 1034.4 1037.7 1037.7 1037.8 1075.2 1079.4 1079.5 1079.8 1081.7 1068.1 1069.4 1069.8 1070.6 1071.0 787.3 789.4 789.4 790.2 790.3 18426.3 18450.4 18807.5 18999.3 20629.1 19763.7 20046.9 20049.8 20331.6 20344.4 16317.4 16390.4 16483.7 16495.0 16939.6 3658.9 3725.6 3726.4 3726.6 3729.2 127458.0 130290.0 133747.0 134089.3 134800.0 16643.4 17035.8 17100.4 17261.5 17368.9 30651.0 31609.0 31675.5 31685.2 32128.0 7630.8 7940.4 8811.2 8972.7 9217.3 4258.8 4335.4 4340.2 4346.4 4347.9 5204.1 5215.3 5281.5 5327.4 5335.1 1036.9 1079.8 1086.0 1095.1 1099.3 683.4 712.4 715.7 724.2 735.9 11860.3 12090.0 12155.6 12374.9 12694.6 709.7 711.9 715.5 718.0 723.8 5405.7 5407.8 5421.3 5450.0 5486.2 112452.0 115408.0 116428.0 120006.4 121817.4 95855.5 99905.5 100723.0 102512.5 104003.5 88680.0 90266.5 90600.5 90627.0 91354.5 12796.9 13380.9 13383.7 13387.7 13454.2 39715.6 40163.7 40446.4 40790.6 40900.8 51186.5 51940.0 52138.2 53537.0 54007.5 18624.3 18997.1 19088.9 19143.4 19344.6 19999.9 20376.3 20511.6 21716.3 22411.9 19987.7 20202.8 20425.7 20444.3 20485.6 17425.5 17452.4 17806.6 19679.6 20150.6 19517.9 19863.7 20485.0 20603.9 21474.1 12821.9 12974.3 13037.7 13212.1 13907.6 14609.6 14664.0 14698.4 14713.4 15433.7 11:06:08 INFO - PID 3561 | -------- Summary: end -------- 11:06:08 INFO - PID 3561 | 11:06:09 INFO - TEST-INFO | 3561: exit 0 11:06:09 INFO - TEST-OK | dromaeo_css | took 1114421ms 11:06:09 INFO - TEST-START | kraken 11:06:09 INFO - Initialising browser for kraken test... 11:06:09 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:52092/getInfo.html -profile /tmp/tmpl7v3vK/profile 11:06:09 INFO - TEST-INFO | started process 3932 (/builds/slave/test/build/application/firefox/firefox http://localhost:52092/getInfo.html) 11:06:15 INFO - TEST-INFO | 3932: exit 0 11:06:15 INFO - Browser initialized. 11:06:15 INFO - Running cycle 1/1 for kraken test... 11:06:15 INFO - TEST-INFO | started process 4167 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpl7v3vK/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 11:06:16 INFO - PID 4167 | 11:06:16 INFO - PID 4167 | (/builds/slave/test/build/application/firefox/firefox:4221): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 11:06:16 INFO - PID 4167 | 11:06:26 INFO - PID 4167 | RSS: Main: 167907328 11:06:26 INFO - PID 4167 | 11:06:29 INFO - PID 4167 | Cycle 1(1): loaded http://localhost:52092/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:52092/tests/kraken/driver.html?testName=audio-beat-detection) 11:06:30 INFO - PID 4167 | RSS: Main: 174551040 11:06:30 INFO - PID 4167 | 11:06:33 INFO - PID 4167 | Cycle 1(1): loaded http://localhost:52092/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:52092/tests/kraken/driver.html?testName=audio-dft) 11:06:33 INFO - PID 4167 | RSS: Main: 177799168 11:06:33 INFO - PID 4167 | 11:06:36 INFO - PID 4167 | Cycle 1(1): loaded http://localhost:52092/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:52092/tests/kraken/driver.html?testName=audio-fft) 11:06:37 INFO - PID 4167 | RSS: Main: 172261376 11:06:37 INFO - PID 4167 | 11:06:39 INFO - PID 4167 | Cycle 1(1): loaded http://localhost:52092/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:52092/tests/kraken/driver.html?testName=audio-oscillator) 11:06:40 INFO - PID 4167 | RSS: Main: 172724224 11:06:40 INFO - PID 4167 | 11:06:42 INFO - PID 4167 | Cycle 1(1): loaded http://localhost:52092/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:52092/tests/kraken/driver.html?testName=imaging-gaussian-blur) 11:06:43 INFO - PID 4167 | RSS: Main: 173105152 11:06:43 INFO - PID 4167 | 11:06:46 INFO - PID 4167 | Cycle 1(1): loaded http://localhost:52092/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:52092/tests/kraken/driver.html?testName=imaging-darkroom) 11:06:46 INFO - PID 4167 | RSS: Main: 174018560 11:06:46 INFO - PID 4167 | 11:06:50 INFO - PID 4167 | Cycle 1(1): loaded http://localhost:52092/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:52092/tests/kraken/driver.html?testName=imaging-desaturate) 11:06:50 INFO - PID 4167 | RSS: Main: 173559808 11:06:50 INFO - PID 4167 | 11:06:53 INFO - PID 4167 | Cycle 1(1): loaded http://localhost:52092/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:52092/tests/kraken/driver.html?testName=json-parse-financial) 11:06:54 INFO - PID 4167 | RSS: Main: 174284800 11:06:54 INFO - PID 4167 | 11:06:56 INFO - PID 4167 | Cycle 1(1): loaded http://localhost:52092/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:52092/tests/kraken/driver.html?testName=json-stringify-tinderbox) 11:06:56 INFO - PID 4167 | RSS: Main: 174415872 11:06:56 INFO - PID 4167 | 11:06:58 INFO - PID 4167 | Cycle 1(1): loaded http://localhost:52092/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:52092/tests/kraken/driver.html?testName=stanford-crypto-aes) 11:06:59 INFO - PID 4167 | RSS: Main: 173920256 11:06:59 INFO - PID 4167 | 11:07:01 INFO - PID 4167 | Cycle 1(1): loaded http://localhost:52092/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:52092/tests/kraken/driver.html?testName=stanford-crypto-ccm) 11:07:02 INFO - PID 4167 | RSS: Main: 174100480 11:07:02 INFO - PID 4167 | 11:07:04 INFO - PID 4167 | Cycle 1(1): loaded http://localhost:52092/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:52092/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 11:07:05 INFO - PID 4167 | RSS: Main: 174469120 11:07:05 INFO - PID 4167 | 11:07:08 INFO - PID 4167 | Cycle 1(1): loaded http://localhost:52092/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:52092/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 11:07:09 INFO - PID 4167 | RSS: Main: 174587904 11:07:09 INFO - PID 4167 | 11:07:11 INFO - PID 4167 | Cycle 1(1): loaded http://localhost:52092/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:52092/tests/kraken/driver.html?testName=ai-astar) 11:07:11 INFO - PID 4167 | RSS: Main: 176156672 11:07:11 INFO - PID 4167 | 11:07:11 INFO - PID 4167 | __start_tp_report 11:07:11 INFO - PID 4167 | _x_x_mozilla_page_load 11:07:11 INFO - PID 4167 | _x_x_mozilla_page_load_details 11:07:11 INFO - PID 4167 | |i|pagename|runs| 11:07:11 INFO - PID 4167 | |0;ai-astar;98;112;100;107;111;121;109;102;107;110 11:07:11 INFO - PID 4167 | |1;audio-beat-detection;142;117;145;186;120;159;144;120;171;127 11:07:11 INFO - PID 4167 | |2;audio-dft;163;161;164;162;170;167;170;161;168;164 11:07:11 INFO - PID 4167 | |3;audio-fft;82;74;75;167;73;75;75;77;180;76 11:07:11 INFO - PID 4167 | |4;audio-oscillator;79;78;128;80;79;79;129;81;82;133 11:07:11 INFO - PID 4167 | |5;imaging-gaussian-blur;114;114;114;114;114;114;113;113;115;114 11:07:11 INFO - PID 4167 | |6;imaging-darkroom;151;156;149;150;149;151;151;150;150;152 11:07:11 INFO - PID 4167 | |7;imaging-desaturate;94;95;102;95;96;94;95;94;93;94 11:07:11 INFO - PID 4167 | |8;json-parse-financial;54;56;54;64;53;52;54;53;56;61 11:07:11 INFO - PID 4167 | |9;json-stringify-tinderbox;55;62;54;60;55;54;54;55;54;57 11:07:11 INFO - PID 4167 | |10;stanford-crypto-aes;78;79;81;79;80;85;82;85;78;77 11:07:11 INFO - PID 4167 | |11;stanford-crypto-ccm;126;132;123;131;123;127;134;124;128;164 11:07:11 INFO - PID 4167 | |12;stanford-crypto-pbkdf2;178;188;178;176;187;176;178;179;177;183 11:07:11 INFO - PID 4167 | |13;stanford-crypto-sha256-iterative;70;80;79;72;67;72;66;73;66;68 11:07:11 INFO - PID 4167 | __end_tp_report 11:07:11 INFO - PID 4167 | __start_cc_report 11:07:11 INFO - PID 4167 | _x_x_mozilla_cycle_collect,974 11:07:11 INFO - PID 4167 | __end_cc_report 11:07:11 INFO - PID 4167 | __startTimestamp1502474831432__endTimestamp 11:07:11 INFO - PID 4167 | 11:07:11 INFO - PID 4167 | ------- Summary: start ------- 11:07:11 INFO - PID 4167 | Number of tests: 14 11:07:11 INFO - PID 4167 | 11:07:11 INFO - PID 4167 | [#0] ai-astar Cycles:10 Average:107.70 Median:110.50 stddev:6.67 (6.0%) stddev-sans-first:6.08 11:07:11 INFO - PID 4167 | Values: 98.0 112.0 100.0 107.0 111.0 121.0 109.0 102.0 107.0 110.0 11:07:11 INFO - PID 4167 | 11:07:11 INFO - PID 4167 | [#1] audio-beat-detection Cycles:10 Average:143.10 Median:144.50 stddev:23.30 (16.1%) stddev-sans-first:24.71 11:07:11 INFO - PID 4167 | Values: 142.0 117.0 145.0 186.0 120.0 159.0 144.0 120.0 171.0 127.0 11:07:11 INFO - PID 4167 | 11:07:11 INFO - PID 4167 | [#2] audio-dft Cycles:10 Average:165.00 Median:165.50 stddev:3.50 (2.1%) stddev-sans-first:3.63 11:07:11 INFO - PID 4167 | Values: 163.0 161.0 164.0 162.0 170.0 167.0 170.0 161.0 168.0 164.0 11:07:11 INFO - PID 4167 | 11:07:11 INFO - PID 4167 | [#3] audio-fft Cycles:10 Average:95.40 Median:75.00 stddev:41.35 (55.1%) stddev-sans-first:43.57 11:07:11 INFO - PID 4167 | Values: 82.0 74.0 75.0 167.0 73.0 75.0 75.0 77.0 180.0 76.0 11:07:11 INFO - PID 4167 | 11:07:11 INFO - PID 4167 | [#4] audio-oscillator Cycles:10 Average:94.80 Median:79.00 stddev:24.35 (30.8%) stddev-sans-first:25.15 11:07:11 INFO - PID 4167 | Values: 79.0 78.0 128.0 80.0 79.0 79.0 129.0 81.0 82.0 133.0 11:07:11 INFO - PID 4167 | 11:07:11 INFO - PID 4167 | [#5] imaging-gaussian-blur Cycles:10 Average:113.90 Median:114.00 stddev:0.57 (0.5%) stddev-sans-first:0.60 11:07:11 INFO - PID 4167 | Values: 114.0 114.0 114.0 114.0 114.0 114.0 113.0 113.0 115.0 114.0 11:07:11 INFO - PID 4167 | 11:07:11 INFO - PID 4167 | [#6] imaging-darkroom Cycles:10 Average:150.90 Median:151.00 stddev:2.02 (1.3%) stddev-sans-first:2.15 11:07:11 INFO - PID 4167 | Values: 151.0 156.0 149.0 150.0 149.0 151.0 151.0 150.0 150.0 152.0 11:07:11 INFO - PID 4167 | 11:07:11 INFO - PID 4167 | [#7] imaging-desaturate Cycles:10 Average:95.20 Median:94.50 stddev:2.53 (2.7%) stddev-sans-first:2.65 11:07:11 INFO - PID 4167 | Values: 94.0 95.0 102.0 95.0 96.0 94.0 95.0 94.0 93.0 94.0 11:07:11 INFO - PID 4167 | 11:07:11 INFO - PID 4167 | [#8] json-parse-financial Cycles:10 Average:55.70 Median:55.00 stddev:3.86 (7.0%) stddev-sans-first:4.04 11:07:11 INFO - PID 4167 | Values: 54.0 56.0 54.0 64.0 53.0 52.0 54.0 53.0 56.0 61.0 11:07:11 INFO - PID 4167 | 11:07:11 INFO - PID 4167 | [#9] json-stringify-tinderbox Cycles:10 Average:56.00 Median:55.00 stddev:2.83 (5.1%) stddev-sans-first:2.98 11:07:11 INFO - PID 4167 | Values: 55.0 62.0 54.0 60.0 55.0 54.0 54.0 55.0 54.0 57.0 11:07:11 INFO - PID 4167 | 11:07:11 INFO - PID 4167 | [#10] stanford-crypto-aes Cycles:10 Average:80.40 Median:80.50 stddev:2.84 (3.5%) stddev-sans-first:2.87 11:07:11 INFO - PID 4167 | Values: 78.0 79.0 81.0 79.0 80.0 85.0 82.0 85.0 78.0 77.0 11:07:11 INFO - PID 4167 | 11:07:11 INFO - PID 4167 | [#11] stanford-crypto-ccm Cycles:10 Average:131.20 Median:129.50 stddev:12.14 (9.4%) stddev-sans-first:12.73 11:07:11 INFO - PID 4167 | Values: 126.0 132.0 123.0 131.0 123.0 127.0 134.0 124.0 128.0 164.0 11:07:11 INFO - PID 4167 | 11:07:11 INFO - PID 4167 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:180.00 Median:178.50 stddev:4.42 (2.5%) stddev-sans-first:4.63 11:07:11 INFO - PID 4167 | Values: 178.0 188.0 178.0 176.0 187.0 176.0 178.0 179.0 177.0 183.0 11:07:11 INFO - PID 4167 | 11:07:11 INFO - PID 4167 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:71.30 Median:72.00 stddev:5.01 (7.0%) stddev-sans-first:5.29 11:07:11 INFO - PID 4167 | Values: 70.0 80.0 79.0 72.0 67.0 72.0 66.0 73.0 66.0 68.0 11:07:11 INFO - PID 4167 | -------- Summary: end -------- 11:07:11 INFO - PID 4167 | 11:07:11 INFO - PID 4167 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 11:07:12 INFO - TEST-INFO | 4167: exit 0 11:07:12 INFO - TEST-OK | kraken | took 63078ms 11:07:12 INFO - SUITE-END | took 1177s 11:07:12 INFO - Completed test suite (00:19:37) 11:07:12 INFO - javascript benchmark 11:07:12 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8574.447038268336, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3139.623245210575, 3181.347823696142, 3186.0919637903203, 3192.5211218317236, 3202.3275112226434, 6150.569460137781, 6204.41058099481, 6208.099825525302, 6264.248290205176, 6295.559310848237, 6079.848003799896, 6170.876582468348, 6203.255609326876, 6214.440700336969, 6245.188125543685, 5656.660600363971, 5671.461211184931, 5674.9716251418895, 5710.914336284959, 5794.768209271624, 5749.626274292178, 5759.049756790125, 5769.04810706233, 5771.134329850514, 5773.711314434283, 164.68495767596593, 5566.972165139189, 5654.519365853907, 5734.79928202513, 5737.0, 5594.412586678381, 5598.916016259759, 5603.887922241533, 5665.603407761459, 5692.943070569324, 5568.220449137124, 5571.220029195916, 5634.211210430543, 5639.577031722637, 5658.462446067617, 6038.818835434944, 6055.091736239599, 6068.787592434288, 6140.324564297924, 6181.041938499539, 6516.641584712839, 6524.445422139124, 6600.966995164993, 6609.173853268341, 6641.070250164981, 6593.736250549972, 6613.206415230203, 6682.498812589075, 6698.330166983312, 6703.363180497845, 6090.086487026937, 6231.252249730016, 6232.0, 6232.3144454110015, 6234.283057448406, 6726.091977582963, 6754.5609535380045, 6832.555883867532, 6848.178218613699, 6848.589084654936, 6425.228972523327, 6462.450691691259, 6526.771562995273, 6543.247526534415, 6560.3111673273615, 6520.217573891164, 6522.0, 6592.604443733391, 6647.966760166169, 6666.899996500057, 6633.1045308882685, 6662.800115996528, 6673.799786006428, 6677.098591690156, 6680.532362734659, 6692.962590798434, 6736.831579210461, 6768.390844823989, 6781.220159681699, 6788.0, 5380.219868119101, 5434.538064264581, 5438.184272359178, 5513.338399392099, 5528.44715528444, 4610.492845786961, 4629.745364004944, 4648.3259927310355, 4654.488006319302, 4668.8132474701315, 5699.430056994267, 5754.309482862083, 5755.827325180251, 5757.107648314518, 5760.337561180434, 6751.819367427591, 6757.054012438262, 6825.317468253135, 6833.0, 6844.041834143224, 5785.0454674978155, 5815.156802263648, 5869.559783016291, 5870.354261031283, 5895.55783316253, 5748.0, 5820.476157145878, 5861.794837180678, 5909.527237820964, 5988.341282458926, 6438.967805161038, 6444.742210311535, 6448.580842245239, 6450.290468048511, 6481.254655714559, 6639.535232533676, 6730.427913627396, 6733.225679046776, 6752.628605426748, 6758.628275444701, 6418.743250269937, 6517.120188774455, 6521.543491955517, 6526.738930442729, 6539.6403197824575, 6527.0, 6527.072800055557, 6557.049227862029, 6622.304658011032, 6637.137172167587, 6599.8020059398295, 6671.499637527302, 6691.5315927884585, 6708.563943343667, 6793.184817821695, 6422.036694495863, 6491.707873145625, 6493.805185844432, 6501.609903405811, 6525.2169739631545, 6532.118164047983, 6575.243846957661, 6584.637844918576, 6602.438792702674, 6605.57063790852, 6439.291677915519, 6441.935580644134, 6444.162258906312, 6515.02274658786, 6534.738610455719, 6242.469390101892, 6362.0, 6495.512836537373, 6636.336366363325, 6647.7008534617025, 6327.152781248548, 6365.777197798055, 6376.458001069961, 6395.136656551306, 6395.680215989275], "value": 6044.1354829671345, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [799.8280369720509, 852.1563651984534, 873.9992708348941, 882.9161229683178, 1177.3583397048608, 31433.84283078587, 31904.521432178535, 41757.16485670288, 42848.78575607125, 43020.56979430205, 42619.36070958938, 42955.57044429555, 42987.35518967218, 43039.0, 43110.78444607781, 7308.853822923538, 7720.806979825507, 7881.975343205404, 7900.881486777703, 7907.762767116996, 7771.533707977539, 7837.177096404881, 7839.216078392172, 7846.176151504095, 7881.645325960346, 7843.803904902366, 7845.137034926153, 7911.723089691862, 7918.524888506708, 7921.366290696759, 7805.063392392893, 7817.374610031184, 7826.7651970440975, 7849.45053846231, 7890.210978902092, 7729.072511298624, 7777.494462859896, 7781.26078022587, 7793.805154871116, 7802.180771019075, 39900.20199596021, 39956.200875982606, 40121.59878401208, 40146.79926600378, 40268.597314026774, 3317.0712200583876, 3350.6314305426386, 3353.899383018513, 3357.798532088058, 3362.0754292569495, 32436.837815811006, 32588.185295367806, 32593.0, 32613.836930815432, 32639.83680081608, 5032.572231360302, 5042.1428357179, 5060.367454068241, 5067.949320506785, 5074.797008119671, 185319.0, 186328.0683596587, 186858.0, 186919.0, 187061.0, 49602.50397496051, 49620.0, 49774.502254976986, 49785.75107124441, 49849.0, 52769.472305277224, 52809.47190528122, 52816.73591632017, 52829.73585132127, 52863.73568132135, 16358.918205409134, 16668.249928753234, 16676.916615416845, 16679.749803752955, 16693.415730449375, 12227.877721222852, 12429.564965226175, 13587.932060339832, 13831.170129792245, 13858.376373063236, 14522.709545809024, 14606.707865842624, 14621.342039608244, 14707.558773236606, 14798.852011479747, 5804.593678442553, 5858.150568167592, 5928.436798504135, 5938.109283607493, 6045.667488288186, 1007.3452256033637, 1011.944343061124, 1017.8676772019738, 1024.666983230453, 1026.3021145621049, 22957.73732444698, 23113.0, 23241.53516929652, 23366.7663323368, 23460.296191114296, 1132.5526417065214, 1134.546181527379, 1139.2708666453477, 1143.1540659911605, 1145.169751929844, 12186.81719774204, 12451.377431128407, 12469.501219951282, 12541.561045363369, 12574.748505030031, 225085.0, 226886.0, 227057.0, 227271.0, 228675.0, 54452.183217251775, 54753.0, 54759.0, 54939.45060549343, 54972.17541736877, 1448.7681970884607, 1489.6424858033993, 1513.5988962924835, 1520.3918432627038, 1528.7936128622716, 23131.884340578188, 23251.76748232496, 23288.0, 23361.182358618047, 23375.883120584287, 38065.096745162075, 38099.23801523899, 38109.0, 38160.80919595384, 38207.42688859725, 193348.0, 194458.0, 194482.0, 194585.0, 195337.0, 34014.319713606084, 34525.827370862986, 36201.275974480886, 36243.0, 36358.8182059088, 46176.0, 46271.76864115658, 46318.53681463142, 46452.30321545112, 46876.0, 33893.0, 34027.14932126716, 34345.48481772726, 34450.65549344474, 34727.65272347345, 33980.66019339874, 34100.0, 34322.82838585891, 34496.655033449344, 34662.13344666403, 37085.07287317839, 37188.6281137196, 37246.25507489781, 37299.25401491901, 37429.251414972096, 32701.345973080883, 32815.179620509676, 32828.835855820565, 32982.835085825376, 33211.50182747309, 24223.0, 24285.271441856774, 24384.146554870495, 24788.132415365377, 24816.255512334657], "value": 17505.6935803569, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [576.4667682393786, 577.2409281794443, 580.9970950145249, 582.4466756581248, 599.8710277290384, 22808.42978925528, 23198.88400557997, 24041.759582404193, 24042.158524451646, 24094.87952560237, 26865.0, 27420.177394678143, 27464.17607471774, 27531.0, 27633.44733105337, 6642.800715978528, 6792.18493780747, 6797.52417330787, 6798.422134118606, 6804.319568043205, 5892.823215303548, 6462.838429039288, 6482.675866206694, 6706.530542862001, 6781.694823732919, 6413.518986076039, 6440.967795161041, 6453.2256129264315, 6456.612603243821, 6468.74125034998, 6436.839079023015, 6447.645379504125, 6453.354664533556, 6455.903161452582, 6458.354164583504, 6022.3074346450285, 6027.216461859974, 6029.276486821565, 6033.849153771147, 6043.153958445821, 29558.0, 30954.226144346347, 30996.0, 31108.222294442592, 31554.0, 1924.788273289937, 1950.658634738929, 1956.9510762230916, 1957.3540731558694, 1962.077823422989, 19442.805571944242, 20171.0, 20174.092165852424, 20195.293164739163, 20198.798012019986, 2350.2714158610715, 2439.524292762912, 2483.8261321707487, 2495.3761559610098, 2501.5122051200024, 139035.0, 142431.0, 142600.28699856537, 143122.2843885774, 143315.2834235822, 14274.85725142756, 14543.563693089225, 15263.465778697693, 15355.539333820003, 15554.22228888551, 22900.31299061031, 23959.281221563382, 23970.640440393407, 23997.28008159758, 24025.879870600536, 10631.627893023708, 10733.892661073445, 10816.0, 10851.40317282557, 10932.836007459895, 10199.235057370726, 10204.591816327264, 10250.64122755715, 10258.794824103476, 10325.896741032644, 9528.952355238318, 9552.331336806357, 9756.512174391251, 9846.359986600848, 9848.162906153057, 2605.726398728144, 2647.8676066196613, 2719.1434698070043, 2748.477789220042, 2834.4331133773326, 952.3524003677566, 969.8846326724182, 980.5636491761098, 982.872226610536, 986.5905649155663, 19534.0, 19991.40025799228, 20434.386968390972, 20497.692534611993, 20614.484637884172, 1020.6580795433613, 1022.120975960688, 1023.7850051489122, 1034.0848349211003, 1036.896310368957, 11097.556097756, 11149.331040137455, 11312.717182070513, 11357.886421135849, 11562.94218528902, 473311.0, 475088.0, 484966.0, 486021.0, 492827.0, 112652.0, 114976.42511787555, 115279.42360288145, 117568.0, 117614.0, 1199.8440202773584, 1209.6189700244395, 1239.863615002349, 1241.522014024589, 1246.569933372985, 17270.309187632352, 17600.20799064071, 17872.195751191488, 17899.105044747972, 18182.81817181811, 56160.719196403756, 56259.71870140623, 59454.40545594662, 59583.10625340536, 61614.383856160865, 70167.64916175387, 70857.0, 71774.28225717676, 71809.6409517949, 72069.63965180141, 14589.05171163871, 14915.32881020335, 15084.019538729948, 15174.165420901956, 15274.694506110038, 23636.29091127269, 23809.523809523365, 23947.40131496657, 23961.16135935234, 24115.276541703777, 18626.627467450846, 18740.0, 18747.90626046861, 18880.43358699241, 18893.90553047281, 15220.238988050332, 16378.181090945644, 16824.158792060593, 17157.828421716124, 17768.733468998234, 18327.533797295917, 19052.809471905104, 19175.712364314266, 19473.0, 19538.706919395936, 14588.978771485894, 14713.043652162574, 14812.407503700162, 14832.851671483148, 14885.181315027778, 18796.154173061972, 18883.622327553647, 18915.243390264237, 19013.0, 19033.333833316323], "value": 12194.87418061853, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1321.121454232935, 1364.7785232217166, 1398.5874167120699, 1401.0332870319482, 1405.4027038508639, 13997.440102395905, 15073.397064117436, 15076.47232346868, 15084.773728394055, 15090.773638395432, 14692.118472891634, 14972.850271497282, 14972.850271497282, 14976.850231497681, 14985.325660345283, 2604.4140068484535, 2706.9593956090675, 2800.2439341377817, 2805.7615102716295, 2807.8174918630225, 2675.933101672464, 2707.241972247774, 2738.2332946774836, 2742.1088146352417, 2743.245607457955, 2643.1145566235236, 2715.551933930909, 2754.848483333416, 2781.207355903568, 2804.214819850435, 2693.6498255226793, 2695.245331307237, 2696.28548434665, 2711.769499592537, 2713.1046754570943, 2645.113886847889, 2690.5291573974673, 2710.91867243983, 2741.4105967216947, 2749.3264150283107, 13872.098313609584, 13937.09408888419, 14146.717065658731, 14150.716985660229, 14174.291285435687, 7706.730264440717, 7922.485038472539, 8003.599820008976, 8018.639161237758, 8025.95987020067, 5151.278820965068, 5373.489518495737, 5460.590455715797, 5462.453754624546, 5479.205515200313, 1827.4883032750852, 1891.063923357933, 1922.5097600111883, 1946.425804387709, 1957.9118939647751, 23509.76490235093, 23559.646605300935, 23878.16426425084, 24505.387365316008, 24612.876935615386, 6617.702203400762, 6742.325767423218, 6758.560693554903, 6761.425278851254, 6931.341522555349, 16153.0, 16159.757603635955, 16172.595685107966, 16184.83815161857, 16193.190340482928, 7640.465167438226, 7766.068071831416, 7788.844223115506, 7790.2599253072, 7809.3752499799875, 7083.610401427868, 7148.678309476086, 7208.24313447091, 7340.4861659684375, 7376.704931802775, 5185.611079169077, 5295.470452954751, 5304.310439642899, 5351.143816989263, 5353.330833645794, 1504.646408094097, 1505.1495904813746, 1512.7125846089427, 1514.5077849698891, 1529.1971714849572, 876.1194999025938, 898.308302606989, 907.4827348411342, 912.5300470257822, 913.8081002989313, 6832.043513908056, 6931.4108300795, 8446.873296900552, 8973.32700047499, 8993.955030224806, 955.47926380123, 964.628617982082, 970.5050424283667, 974.8537719342155, 996.2976101848179, 5193.714345711022, 5283.101872681654, 5387.730613469311, 5473.75368108436, 5729.742161602738, 19887.502812429804, 20106.497337566387, 20400.183992640425, 20650.277240296517, 20659.17363305481, 19106.61786764257, 20034.799652003585, 20055.899720501304, 20105.095270712853, 20471.590568188552, 9414.340996130206, 9685.32202745801, 9993.750156246151, 11074.944625276983, 11238.887611123948, 7965.641546130322, 8406.28546573548, 8491.95754021226, 8577.82844343122, 8663.48019118855, 17457.38899138524, 17539.298428062735, 17762.289508420035, 17925.820741792417, 18105.275788968294, 17747.29010839552, 17872.463826085237, 18025.819741802938, 18287.908560457112, 18405.171767270236, 11307.773844523228, 11573.321868328876, 11590.304581725124, 11590.478428470908, 11593.710157246136, 13311.334433278103, 13490.460381584626, 13603.455861765418, 13617.591472255848, 13629.659258518617, 10914.399708015817, 10971.396573188551, 11088.722781930517, 11091.833622495831, 11325.603603873826, 10621.0, 10622.415767132881, 10656.307340022873, 10844.837327439936, 11031.282966607145, 9394.67118650844, 9499.572519236513, 9502.85745713801, 9514.762130946781, 9583.137517623447, 6710.530262881747, 6778.7288508459105, 6784.3554862288, 6821.795346139624, 6990.545614535039, 6584.374484423972, 6688.83277918056, 6728.158980127484, 6795.116634837637, 6861.313868613099], "value": 6529.592166313831, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [499.1389852504433, 515.8143068495342, 517.8446466060182, 530.8566686994509, 534.3320848938827, 6166.414190651892, 6193.814185574434, 6201.720922558485, 6238.594491358059, 6247.219542430408, 6055.669381839993, 6075.210222671058, 6129.111278864562, 6137.6931153442265, 6173.839156295295, 5074.8477545673595, 5101.744912754366, 5107.3105130807235, 5126.384833819947, 5136.922946155811, 4775.9761201194115, 4867.561919427251, 5068.923966140511, 5093.388793344804, 5137.460566640505, 4879.682485728851, 4893.608511319086, 4934.950650493485, 4945.282933974571, 4968.975155124237, 4883.12103821312, 4884.658073934844, 4925.876853078666, 4970.453250142481, 4971.975140124277, 4479.619232365253, 4488.596026357611, 4495.415595972535, 4500.09998000398, 4528.524504926968, 5976.581639285252, 5981.760729570812, 5989.9101513477335, 5990.610610310316, 6044.516438684895, 5612.915806262909, 5652.180433837112, 5680.971595141998, 5696.231008813798, 5723.255976723041, 6395.968020159869, 6413.711382987777, 6466.191726034246, 6477.190351206099, 6491.805245842632, 4880.487548807395, 4918.2376731606655, 4929.926051109236, 4931.506849315076, 4933.407991041062, 6570.273336565319, 6606.174228221473, 6743.797686069377, 6900.482463815184, 6987.82530436738, 4958.57852082577, 4974.403071631355, 4982.451930287665, 5005.424376196784, 5013.649044566845, 5034.848954531297, 5056.9494305057215, 5085.567726743268, 5089.720065396365, 5093.567046800989, 5729.8567535811935, 5734.1077444443235, 5742.540596752333, 5754.74103665336, 5762.859241713276, 6645.700943457556, 6654.301298363699, 6656.467482601381, 6669.566478178903, 6682.5322227444585, 1773.698471259889, 1782.2514543891596, 1789.2753434858903, 1791.3192986665244, 1792.5518620344915, 1166.7083229192701, 1211.9212251203644, 1223.5411720604773, 1240.6960294727849, 1248.6878280429892, 5802.274715660543, 5804.622699524517, 5823.388544202798, 5824.1560570023585, 5849.766009359663, 6634.104395906587, 6718.361755633207, 6726.697298621574, 6744.393004629607, 6748.223954245226, 5744.167095771089, 5749.878773639184, 5754.424557544212, 5779.942200578024, 5804.709764511842, 3537.646235376442, 3556.0, 3598.4602309653237, 3614.204874927512, 3635.4546817977516, 6466.224053113562, 6505.902411463831, 6544.803655890331, 6565.409113179837, 6571.868562628721, 6739.93260067393, 6896.172459304815, 6905.75829845963, 6912.758053468105, 6915.585064896122, 6347.333529979285, 6407.7436902524305, 6412.839679008062, 6452.387023232879, 6542.378474044958, 6082.384574632773, 6676.198856137295, 6683.73009128264, 6720.596764194164, 6839.213490448463, 6485.221773387224, 6502.674866256573, 6544.447665410589, 6637.2699003108655, 6687.832804179934, 6354.301026887131, 6422.389872962061, 6475.93147130737, 6489.967550162219, 6514.57655252407, 4770.212914869007, 4933.432655244549, 4970.3290055843445, 5014.0, 5042.042012017705, 6346.777862774781, 6558.245801732862, 6582.341765823379, 6648.9002664961035, 6759.0, 6501.609903405811, 6530.706118224786, 6533.67331633426, 6557.475401967927, 6591.813473574803, 6476.935230647633, 6524.445422139172, 6531.412172904462, 6533.640649764118, 6536.215654121535, 6442.710078046405, 6499.967500162469, 6500.187476565429, 6523.771667991788, 6532.379423954717, 6588.209414870054, 6590.80227593173, 6609.4712423007, 6643.269240383457, 6644.368784965421, 6337.429631333202, 6374.728931615736, 6417.010726674559, 6428.453581445629, 6439.581427207404], "value": 5051.853284534427, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [893.8033632600825, 919.9586018629161, 925.2551695884812, 927.9931274567094, 939.7744541310087, 19079.61840763184, 19867.50331241718, 19924.103415346326, 19930.800691993074, 22167.44581385466, 21653.242136525223, 22061.22785702501, 22071.66892496614, 22105.889470552665, 22108.55782884341, 1010.525053224985, 1014.9746256343576, 1015.527779582494, 1017.1811691588268, 1017.3641474078701, 1005.4068099821104, 1034.3897100710578, 1037.6731329631143, 1037.6835065305079, 1037.8183817831887, 1075.1882328841752, 1079.3847506921059, 1079.5088234853163, 1079.7624522605015, 1081.7133459633203, 1068.1401471815186, 1069.385103565453, 1069.802086613975, 1070.5931745936573, 1070.9946450267776, 787.2796391301952, 789.3842802613971, 789.4355535791879, 790.1584812175015, 790.2729488870253, 18426.262949482003, 18450.446486605422, 18807.529811754677, 18999.335023274118, 20629.071691773905, 19763.703544446846, 20046.89976550108, 20049.79950200494, 20331.593368132555, 20344.389668309974, 16317.428889988794, 16390.426335078217, 16483.6703265934, 16495.0, 16939.576510587212, 3658.9451158232646, 3725.590185079639, 3726.366517691999, 3726.571444283915, 3729.1982223821738, 127458.0, 130290.0, 133747.0, 134089.32955335258, 134800.0, 16643.41748038837, 17035.829641703425, 17100.401485947932, 17261.482155535356, 17368.913155434395, 30651.0, 31609.0, 31675.524867127013, 31685.20786980298, 32128.03615891527, 7630.847383052308, 7940.364770818321, 8811.162939520735, 8972.685955991508, 9217.308701847389, 4258.829646814154, 4335.414719012956, 4340.240457919851, 4346.391505189276, 4347.934780978288, 5204.115300398941, 5215.269862219292, 5281.471852814765, 5327.38735045467, 5335.119705248668, 1036.9118624916816, 1079.773247618009, 1085.9565617375374, 1095.0801326885296, 1099.263493459384, 683.3951952522053, 712.3517598984898, 715.6815217228284, 724.2142275630894, 735.9374453171433, 11860.288382696894, 12090.0, 12155.635330940086, 12374.876251237552, 12694.619161425171, 709.6558169287891, 711.921688614252, 715.5170260074428, 717.9712811487586, 723.8118089296715, 5405.729713514309, 5407.756650950717, 5421.349438067457, 5450.0, 5486.177073439016, 112452.0, 115408.0, 116428.0, 120006.39996800135, 121817.39091304663, 95855.52072239594, 99905.50047249717, 100723.0, 102512.48743756233, 104003.47998260111, 88679.9999999987, 90266.54866725624, 90600.5469972646, 90627.0, 91354.54322728344, 12796.872031279569, 13380.866191337962, 13383.732325353632, 13387.732245355233, 13454.192748435125, 39715.60284397119, 40163.72984575474, 40446.393304099875, 40790.59209407868, 40900.79549602233, 51186.488135118176, 51940.0, 52138.217926731886, 53537.0, 54007.459925400246, 18624.255029798656, 18997.050147492293, 19088.904555477133, 19143.425697229104, 19344.613107737485, 19999.900000499903, 20376.28682996088, 20511.589768204252, 21716.34850954474, 22411.88794056019, 19987.700184497535, 20202.797972020093, 20425.69361459609, 20444.28445004418, 20485.59028819445, 17425.47723568295, 17452.389166379115, 17806.643867122842, 19679.60640787205, 20150.59698806045, 19517.902410487855, 19863.702044469057, 20485.0, 20603.896980515, 21474.14103435845, 12821.935890320488, 12974.286414247306, 13037.653222420055, 13212.075154739461, 13907.58277251684, 14609.634759131106, 14664.0, 14698.41206351734, 14713.411463541766, 15433.69132617319], "value": 9336.449348802647, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1540.6000000000001, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [98.0, 112.0, 100.0, 107.0, 111.0, 121.0, 109.0, 102.0, 107.0, 110.0], "value": 107.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [142.0, 117.0, 145.0, 186.0, 120.0, 159.0, 144.0, 120.0, 171.0, 127.0], "value": 143.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 161.0, 164.0, 162.0, 170.0, 167.0, 170.0, 161.0, 168.0, 164.0], "value": 165.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 74.0, 75.0, 167.0, 73.0, 75.0, 75.0, 77.0, 180.0, 76.0], "value": 95.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 78.0, 128.0, 80.0, 79.0, 79.0, 129.0, 81.0, 82.0, 133.0], "value": 94.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 114.0, 114.0, 114.0, 114.0, 114.0, 113.0, 113.0, 115.0, 114.0], "value": 113.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 156.0, 149.0, 150.0, 149.0, 151.0, 151.0, 150.0, 150.0, 152.0], "value": 150.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 102.0, 95.0, 96.0, 94.0, 95.0, 94.0, 93.0, 94.0], "value": 95.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 56.0, 54.0, 64.0, 53.0, 52.0, 54.0, 53.0, 56.0, 61.0], "value": 55.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 62.0, 54.0, 60.0, 55.0, 54.0, 54.0, 55.0, 54.0, 57.0], "value": 56.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 79.0, 81.0, 79.0, 80.0, 85.0, 82.0, 85.0, 78.0, 77.0], "value": 80.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [126.0, 132.0, 123.0, 131.0, 123.0, 127.0, 134.0, 124.0, 128.0, 164.0], "value": 131.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [178.0, 188.0, 178.0, 176.0, 187.0, 176.0, 178.0, 179.0, 177.0, 183.0], "value": 180.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 80.0, 79.0, 72.0, 67.0, 72.0, 66.0, 73.0, 66.0, 68.0], "value": 71.3, "unit": "score"}]}]} 11:07:12 INFO - Return code: 0 11:07:12 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 11:07:12 INFO - # TBPL SUCCESS # 11:07:12 INFO - Running post-action listener: _package_coverage_data 11:07:12 INFO - Running post-action listener: _resource_record_post_action 11:07:12 INFO - [mozharness: 2017-08-11 18:07:12.723354Z] Finished run-tests step (success) 11:07:12 INFO - Running post-run listener: _resource_record_post_run 11:07:12 INFO - Total resource usage - Wall time: 1196s; CPU: 13.0%; Read bytes: 5705728; Write bytes: 441180160; Read time: 2056; Write time: 416140 11:07:12 INFO - TinderboxPrint: CPU usage
13.2% 11:07:12 INFO - TinderboxPrint: I/O read bytes / time
5,705,728 / 2,056 11:07:12 INFO - TinderboxPrint: I/O write bytes / time
441,180,160 / 416,140 11:07:12 INFO - TinderboxPrint: CPU idle
8,279.1 (86.8%) 11:07:12 INFO - TinderboxPrint: CPU user
1,202.8 (12.6%) 11:07:12 INFO - TinderboxPrint: Swap in / out
0 / 0 11:07:12 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 118255616; Read time: 0; Write time: 80356 11:07:12 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 11:07:12 INFO - run-tests - Wall time: 1179s; CPU: 13.0%; Read bytes: 3518464; Write bytes: 286740480; Read time: 1704; Write time: 322548 11:07:13 INFO - Running post-run listener: _upload_blobber_files 11:07:13 INFO - Blob upload gear active. 11:07:13 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 11:07:13 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 11:07:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 11:07:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 11:07:13 INFO - (blobuploader) - INFO - Open directory for files ... 11:07:13 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 11:07:13 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:07:13 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:07:14 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 11:07:14 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:07:14 INFO - (blobuploader) - INFO - Done attempting. 11:07:14 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 11:07:14 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:07:14 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:07:15 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 11:07:15 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:07:15 INFO - (blobuploader) - INFO - Done attempting. 11:07:15 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 11:07:15 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:07:15 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:07:16 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 11:07:16 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:07:16 INFO - (blobuploader) - INFO - Done attempting. 11:07:16 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 11:07:16 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:07:16 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:07:23 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 11:07:23 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:07:23 INFO - (blobuploader) - INFO - Done attempting. 11:07:23 INFO - (blobuploader) - INFO - Iteration through files over. 11:07:23 INFO - Return code: 0 11:07:23 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 11:07:23 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 11:07:23 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/efb39564da1344eb81f300557230c0dba551e15b0f17682e535ff35f5a2a2db9aacd5e0da24c901eb16a82db4687272498f8b872a145403b59d9f405882d390d", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/797f257bdb6e0ff04c70bd80f905c3ecc01000bd1dae12a13c901ff078dcf4c96292be5e89ad0c17aabcfe53c0744bdc60b8cb643880561ab4c168a4bc40413e", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/35ba5e852a53fc1f636f8a633e258b4abb9a39c44cb6a822fcb24646ace34328e22c27ea4158551ce05488fa11aab5028a01d1879a70fcb211cf23bf92baae3e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ecbb1ad304ab0b0147834e6a5043af44ec551f204007fa14acc604b1ede0609ea4feb58aa87c1a16bc778102493fcaf4a90f310d1a10e653947664dce4c1e019"} 11:07:23 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 11:07:23 INFO - Writing to file /builds/slave/test/properties/blobber_files 11:07:23 INFO - Contents: 11:07:23 INFO - blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/efb39564da1344eb81f300557230c0dba551e15b0f17682e535ff35f5a2a2db9aacd5e0da24c901eb16a82db4687272498f8b872a145403b59d9f405882d390d", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/797f257bdb6e0ff04c70bd80f905c3ecc01000bd1dae12a13c901ff078dcf4c96292be5e89ad0c17aabcfe53c0744bdc60b8cb643880561ab4c168a4bc40413e", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/35ba5e852a53fc1f636f8a633e258b4abb9a39c44cb6a822fcb24646ace34328e22c27ea4158551ce05488fa11aab5028a01d1879a70fcb211cf23bf92baae3e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ecbb1ad304ab0b0147834e6a5043af44ec551f204007fa14acc604b1ede0609ea4feb58aa87c1a16bc778102493fcaf4a90f310d1a10e653947664dce4c1e019"} 11:07:23 INFO - Running post-run listener: copy_logs_to_upload_dir 11:07:23 INFO - Copying logs to upload dir... 11:07:23 INFO - mkdir: /builds/slave/test/build/upload/logs 11:07:23 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1263.890394 ========= master_lag: -0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 3 secs) (at 2017-08-11 11:07:23.230492) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-08-11 11:07:23.234883) ========= 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=920470bf432669ad7e3a5387000001ca-1502472487.713932-41578209 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/sha512/efb39564da1344eb81f300557230c0dba551e15b0f17682e535ff35f5a2a2db9aacd5e0da24c901eb16a82db4687272498f8b872a145403b59d9f405882d390d", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/797f257bdb6e0ff04c70bd80f905c3ecc01000bd1dae12a13c901ff078dcf4c96292be5e89ad0c17aabcfe53c0744bdc60b8cb643880561ab4c168a4bc40413e", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/35ba5e852a53fc1f636f8a633e258b4abb9a39c44cb6a822fcb24646ace34328e22c27ea4158551ce05488fa11aab5028a01d1879a70fcb211cf23bf92baae3e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ecbb1ad304ab0b0147834e6a5043af44ec551f204007fa14acc604b1ede0609ea4feb58aa87c1a16bc778102493fcaf4a90f310d1a10e653947664dce4c1e019"} build_url:https://queue.taskcluster.net/v1/task/E4iAGlFXSzGuQDDtIxOgHQ/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011221 build_url: 'https://queue.taskcluster.net/v1/task/E4iAGlFXSzGuQDDtIxOgHQ/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/efb39564da1344eb81f300557230c0dba551e15b0f17682e535ff35f5a2a2db9aacd5e0da24c901eb16a82db4687272498f8b872a145403b59d9f405882d390d", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/797f257bdb6e0ff04c70bd80f905c3ecc01000bd1dae12a13c901ff078dcf4c96292be5e89ad0c17aabcfe53c0744bdc60b8cb643880561ab4c168a4bc40413e", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/35ba5e852a53fc1f636f8a633e258b4abb9a39c44cb6a822fcb24646ace34328e22c27ea4158551ce05488fa11aab5028a01d1879a70fcb211cf23bf92baae3e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ecbb1ad304ab0b0147834e6a5043af44ec551f204007fa14acc604b1ede0609ea4feb58aa87c1a16bc778102493fcaf4a90f310d1a10e653947664dce4c1e019"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-08-11 11:07:23.262282) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-08-11 11:07:23.262653) ========= 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=920470bf432669ad7e3a5387000001ca-1502472487.713932-41578209 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004371 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-08-11 11:07:23.342546) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-08-11 11:07:23.342900) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-08-11 11:07:23.343243) ========= ========= Total master_lag: 0.15 =========