builder: mozilla-central_ubuntu64_hw_qr_test-dromaeojs-e10s slave: talos-linux64-ix-020 starttime: 1502906880.48 results: success (0) revision: 07ce8c96222d533fc89c02802143d35d7c351f9c ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-08-16 11:08:00.484591) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-08-16 11:08:00.485002) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-08-16 11:08:00.485290) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-08-16 11:08:00.497870) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-16 11:08:00.498146) ========= 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=af724c981e2a0f424dbabf99000001e7-1502906880.52806-1546123981 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-08-16 11:08:00-- 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% 109M=0s 2017-08-16 11:08:01 (109 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.153689 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-16 11:08:00.666888) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-08-16 11:08:00.670219) ========= 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=af724c981e2a0f424dbabf99000001e7-1502906880.52806-1546123981 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.023834 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-08-16 11:08:00.719912) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2017-08-16 11:08:00.723256) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 07ce8c96222d533fc89c02802143d35d7c351f9c --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 07ce8c96222d533fc89c02802143d35d7c351f9c --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=af724c981e2a0f424dbabf99000001e7-1502906880.52806-1546123981 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-08-16 11:08:01,191 truncating revision to first 12 chars 2017-08-16 11:08:01,191 Setting DEBUG logging. 2017-08-16 11:08:01,191 attempt 1/10 2017-08-16 11:08:01,191 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/07ce8c96222d?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-08-16 11:08:01,622 unpacking tar archive at: mozilla-central-07ce8c96222d/testing/mozharness/ program finished with exit code 0 elapsedTime=2.049461 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2017-08-16 11:08:02.787491) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-08-16 11:08:02.787812) ========= script_repo_revision: 07ce8c96222d533fc89c02802143d35d7c351f9c ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-08-16 11:08:02.788192) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-08-16 11:08:02.788457) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-08-16 11:08:02.802610) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 0 secs) (at 2017-08-16 11:08:02.802874) ========= /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=af724c981e2a0f424dbabf99000001e7-1502906880.52806-1546123981 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 11:08:03 INFO - MultiFileLogger online at 20170816 11:08:03 in /builds/slave/test 11:08:03 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 11:08:03 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 11:08:03 INFO - {'append_to_log': False, 11:08:03 INFO - 'base_work_dir': '/builds/slave/test', 11:08:03 INFO - 'blob_upload_branch': 'Firefox', 11:08:03 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 11:08:03 INFO - 'branch': 'Firefox', 11:08:03 INFO - 'buildbot_json_path': 'buildprops.json', 11:08:03 INFO - 'code_coverage': False, 11:08:03 INFO - 'config_files': ('talos/linux_config.py',), 11:08:03 INFO - 'default_actions': ('clobber', 11:08:03 INFO - 'read-buildbot-config', 11:08:03 INFO - 'download-and-extract', 11:08:03 INFO - 'populate-webroot', 11:08:03 INFO - 'create-virtualenv', 11:08:03 INFO - 'install', 11:08:03 INFO - 'setup-mitmproxy', 11:08:03 INFO - 'run-tests'), 11:08:03 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 11:08:03 INFO - 'disable_ccov_upload': False, 11:08:03 INFO - 'download_minidump_stackwalk': True, 11:08:03 INFO - 'download_symbols': 'ondemand', 11:08:03 INFO - 'enable_stylo': False, 11:08:03 INFO - 'enable_webrender': False, 11:08:03 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 11:08:03 INFO - 'tooltool.py': '/tools/tooltool.py', 11:08:03 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 11:08:03 INFO - '/tools/misc-python/virtualenv.py')}, 11:08:03 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 11:08:03 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 11:08:03 INFO - 'gecko_profile': False, 11:08:03 INFO - 'gecko_profile_interval': 0, 11:08:03 INFO - 'installer_path': 'installer.exe', 11:08:03 INFO - 'log_level': 'info', 11:08:03 INFO - 'log_name': 'talos', 11:08:03 INFO - 'log_to_console': True, 11:08:03 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 11:08:03 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 11:08:03 INFO - 'opt_config_files': (), 11:08:03 INFO - 'pip_index': False, 11:08:03 INFO - 'suite': 'dromaeojs-e10s', 11:08:03 INFO - 'system_bits': '32', 11:08:03 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 11:08:03 INFO - 'title': 'talos-linux64-ix-020', 11:08:03 INFO - 'tooltool_cache': '/builds/tooltool_cache', 11:08:03 INFO - 'use_talos_json': True, 11:08:03 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 11:08:03 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 11:08:03 INFO - 'work_dir': 'build'} 11:08:03 INFO - [mozharness: 2017-08-16 18:08:03.379011Z] Running clobber step. 11:08:03 INFO - Running pre-action listener: _resource_record_pre_action 11:08:03 INFO - Running main action method: clobber 11:08:03 INFO - rmtree: /builds/slave/test/build 11:08:03 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 11:08:04 INFO - Running post-action listener: _resource_record_post_action 11:08:04 INFO - [mozharness: 2017-08-16 18:08:04.424545Z] Finished clobber step (success) 11:08:04 INFO - [mozharness: 2017-08-16 18:08:04.424646Z] Running read-buildbot-config step. 11:08:04 INFO - Running pre-action listener: _resource_record_pre_action 11:08:04 INFO - Running main action method: read_buildbot_config 11:08:04 INFO - Using buildbot properties: 11:08:04 INFO - { 11:08:04 INFO - "project": "", 11:08:04 INFO - "product": "firefox", 11:08:04 INFO - "who": "ffxbld@noreply.mozilla.org", 11:08:04 INFO - "installer_path": "public/build/target.tar.bz2", 11:08:04 INFO - "builddir": "mozilla-central_ubuntu64_hw_qr_test-dromaeojs-e10s", 11:08:04 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 11:08:04 INFO - "buildername": "Ubuntu HW 12.04 x64 qr mozilla-central talos dromaeojs-e10s", 11:08:04 INFO - "stage_platform": "linux64-qr", 11:08:04 INFO - "basedir": "/builds/slave/test", 11:08:04 INFO - "buildnumber": 4, 11:08:04 INFO - "platform": "ubuntu64_hw_qr", 11:08:04 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 11:08:04 INFO - "slavebuilddir": "test", 11:08:04 INFO - "taskId": "W24q8BgRSe2N6i8h1dVaiA", 11:08:04 INFO - "branch": "mozilla-central", 11:08:04 INFO - "script_repo_revision": "production", 11:08:04 INFO - "revision": "07ce8c96222d533fc89c02802143d35d7c351f9c", 11:08:04 INFO - "slavename": "talos-linux64-ix-020", 11:08:04 INFO - "repo_path": "mozilla-central" 11:08:04 INFO - } 11:08:04 INFO - Finding installer, test and symbols from parent task. 11:08:04 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/W24q8BgRSe2N6i8h1dVaiA'}, attempt #1 11:08:04 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/W24q8BgRSe2N6i8h1dVaiA'}, attempt #1 11:08:05 INFO - Task dependencies: YbqntiLNQ_uKrat-Wa379w 11:08:05 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/YbqntiLNQ_uKrat-Wa379w'}, attempt #1 11:08:05 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/YbqntiLNQ_uKrat-Wa379w/artifacts/public/build/target.tar.bz2 11:08:05 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/YbqntiLNQ_uKrat-Wa379w/artifacts/public/build/target.test_packages.json 11:08:05 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/YbqntiLNQ_uKrat-Wa379w/artifacts/public/build/target.crashreporter-symbols.zip 11:08:05 INFO - Running post-action listener: _resource_record_post_action 11:08:05 INFO - [mozharness: 2017-08-16 18:08:05.824430Z] Finished read-buildbot-config step (success) 11:08:05 INFO - [mozharness: 2017-08-16 18:08:05.824651Z] Running download-and-extract step. 11:08:05 INFO - Running pre-action listener: _resource_record_pre_action 11:08:05 INFO - Running main action method: download_and_extract 11:08:05 INFO - mkdir: /builds/slave/test/build/tests 11:08:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:08:05 INFO - trying https://queue.taskcluster.net/v1/task/YbqntiLNQ_uKrat-Wa379w/artifacts/public/build/target.test_packages.json 11:08:05 INFO - Downloading https://queue.taskcluster.net/v1/task/YbqntiLNQ_uKrat-Wa379w/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 11:08:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/YbqntiLNQ_uKrat-Wa379w/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 11:08:06 INFO - Downloaded 989 bytes. 11:08:06 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 11:08:06 INFO - Using the following test package requirements: 11:08:06 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 11:08:06 INFO - u'common': [u'target.common.tests.zip'], 11:08:06 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 11:08:06 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 11:08:06 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 11:08:06 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 11:08:06 INFO - u'mozbase': [u'target.common.tests.zip'], 11:08:06 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 11:08:06 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 11:08:06 INFO - u'web-platform': [u'target.common.tests.zip', 11:08:06 INFO - u'target.web-platform.tests.tar.gz'], 11:08:06 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 11:08:06 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 11:08:06 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/YbqntiLNQ_uKrat-Wa379w/artifacts/public/build/target.common.tests.zip 11:08:06 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/YbqntiLNQ_uKrat-Wa379w/artifacts/public/build/target.common.tests.zip'}, attempt #1 11:08:06 INFO - Fetch https://queue.taskcluster.net/v1/task/YbqntiLNQ_uKrat-Wa379w/artifacts/public/build/target.common.tests.zip into memory 11:08:07 INFO - Content-Length response header: 54003849 11:08:07 INFO - Bytes received: 54003849 11:08:18 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 11:08:18 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/YbqntiLNQ_uKrat-Wa379w/artifacts/public/build/target.common.tests.zip 11:08:18 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/YbqntiLNQ_uKrat-Wa379w/artifacts/public/build/target.common.tests.zip'}, attempt #1 11:08:18 INFO - Fetch https://queue.taskcluster.net/v1/task/YbqntiLNQ_uKrat-Wa379w/artifacts/public/build/target.common.tests.zip into memory 11:08:19 INFO - Content-Length response header: 54003849 11:08:19 INFO - Bytes received: 54003849 11:08:31 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/YbqntiLNQ_uKrat-Wa379w/artifacts/public/build/target.talos.tests.zip 11:08:31 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/YbqntiLNQ_uKrat-Wa379w/artifacts/public/build/target.talos.tests.zip'}, attempt #1 11:08:31 INFO - Fetch https://queue.taskcluster.net/v1/task/YbqntiLNQ_uKrat-Wa379w/artifacts/public/build/target.talos.tests.zip into memory 11:08:32 INFO - Content-Length response header: 14496050 11:08:32 INFO - Bytes received: 14496050 11:08:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:08:32 INFO - trying https://queue.taskcluster.net/v1/task/YbqntiLNQ_uKrat-Wa379w/artifacts/public/build/target.tar.bz2 11:08:32 INFO - Downloading https://queue.taskcluster.net/v1/task/YbqntiLNQ_uKrat-Wa379w/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 11:08:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/YbqntiLNQ_uKrat-Wa379w/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 11:08:33 INFO - Downloaded 61902147 bytes. 11:08:33 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/YbqntiLNQ_uKrat-Wa379w/artifacts/public/build/target.tar.bz2 11:08:33 INFO - mkdir: /builds/slave/test/properties 11:08:33 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 11:08:33 INFO - Writing to file /builds/slave/test/properties/build_url 11:08:33 INFO - Contents: 11:08:33 INFO - build_url:https://queue.taskcluster.net/v1/task/YbqntiLNQ_uKrat-Wa379w/artifacts/public/build/target.tar.bz2 11:08:33 INFO - Running post-action listener: _resource_record_post_action 11:08:33 INFO - Running post-action listener: set_extra_try_arguments 11:08:33 INFO - [mozharness: 2017-08-16 18:08:33.902325Z] Finished download-and-extract step (success) 11:08:33 INFO - [mozharness: 2017-08-16 18:08:33.902423Z] Running populate-webroot step. 11:08:33 INFO - Running pre-action listener: _resource_record_pre_action 11:08:33 INFO - Running main action method: populate_webroot 11:08:33 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 11:08:33 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 11:08:33 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 11:08:33 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:08:33 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 11:08:33 INFO - 'tests': ['damp', 'tps']}, 11:08:33 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 11:08:33 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 11:08:33 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 11:08:33 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 11:08:33 INFO - 'other-e10s': {'tests': ['a11yr', 11:08:33 INFO - 'ts_paint', 11:08:33 INFO - 'tpaint', 11:08:33 INFO - 'sessionrestore', 11:08:33 INFO - 'sessionrestore_many_windows', 11:08:33 INFO - 'sessionrestore_no_auto_restore', 11:08:33 INFO - 'tabpaint']}, 11:08:33 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 11:08:33 INFO - 'perf-reftest-singletons-e10s': {'tests': ['bloom_basic_singleton']}, 11:08:33 INFO - 'svgr-e10s': {'tests': ['tsvgx', 11:08:33 INFO - 'tsvgr_opacity', 11:08:33 INFO - 'tart', 11:08:33 INFO - 'tscrollx', 11:08:33 INFO - 'tsvg_static']}, 11:08:33 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 11:08:33 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 11:08:33 INFO - 'talos_options': ['--mitmproxy', 11:08:33 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 11:08:33 INFO - '--firstNonBlankPaint'], 11:08:33 INFO - 'tests': ['tp6_google', 11:08:33 INFO - 'tp6_youtube', 11:08:33 INFO - 'tp6_amazon', 11:08:33 INFO - 'tp6_facebook']}, 11:08:33 INFO - 'tp6-stylo-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 11:08:33 INFO - 'talos_options': ['--stylo', 11:08:33 INFO - '--mitmproxy', 11:08:33 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 11:08:33 INFO - '--firstNonBlankPaint'], 11:08:33 INFO - 'tests': ['tp6_google', 11:08:33 INFO - 'tp6_youtube', 11:08:33 INFO - 'tp6_amazon', 11:08:33 INFO - 'tp6_facebook']}, 11:08:33 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 11:08:33 INFO - 'talos_options': ['--stylo', 11:08:33 INFO - '--stylo-threads=1', 11:08:33 INFO - '--mitmproxy', 11:08:33 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 11:08:33 INFO - '--firstNonBlankPaint'], 11:08:33 INFO - 'tests': ['tp6_google', 11:08:33 INFO - 'tp6_youtube', 11:08:33 INFO - 'tp6_amazon', 11:08:33 INFO - 'tp6_facebook']}, 11:08:33 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 11:08:33 INFO - 'talos_options': ['--xperf_path', 11:08:33 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:08:33 INFO - 'tests': ['tp5n']}}} 11:08:33 INFO - Running post-action listener: _resource_record_post_action 11:08:33 INFO - [mozharness: 2017-08-16 18:08:33.910867Z] Finished populate-webroot step (success) 11:08:33 INFO - [mozharness: 2017-08-16 18:08:33.910958Z] Running create-virtualenv step. 11:08:33 INFO - Running pre-action listener: _resource_record_pre_action 11:08:33 INFO - Running main action method: create_virtualenv 11:08:33 INFO - Creating virtualenv /builds/slave/test/build/venv 11:08:33 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 11:08:33 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 11:08:33 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 11:08:34 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 11:08:34 INFO - Using real prefix '/usr' 11:08:34 INFO - New python executable in /builds/slave/test/build/venv/bin/python 11:08:34 INFO - Installing distribute.............................................................................................................................................................................................done. 11:08:36 INFO - Installing pip.................done. 11:08:36 INFO - Return code: 0 11:08:36 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 11:08:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 11:08:36 INFO - Reading from file tmpfile_stdout 11:08:36 INFO - Output received: 11:08:36 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) 11:08:36 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 11:08:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:08:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:08:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:08:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:08:36 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 0xe341f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf38a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10dbef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d90b0>, '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 0x10d9fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10da440>, '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': 'af724c981e2a0f424dbabf99000001e7-1502906880.52806-1546123981', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:08:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 11:08:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 11:08:36 INFO - Using env: {'DISPLAY': ':0', 11:08:36 INFO - 'HOME': '/home/cltbld', 11:08:36 INFO - 'LANG': 'en_US.UTF-8', 11:08:36 INFO - 'LANGUAGE': 'en_US:en', 11:08:36 INFO - 'LOGNAME': 'cltbld', 11:08:36 INFO - 'MAIL': '/var/mail/cltbld', 11:08:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:08:36 INFO - 'MOZ_NO_REMOTE': '1', 11:08:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:08:36 INFO - 'NO_EM_RESTART': '1', 11:08:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:08:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:08:36 INFO - 'PWD': '/builds/slave/test', 11:08:36 INFO - 'SHELL': '/bin/bash', 11:08:36 INFO - 'SHLVL': '1', 11:08:36 INFO - 'TERM': 'linux', 11:08:36 INFO - 'TMOUT': '86400', 11:08:36 INFO - 'USER': 'cltbld', 11:08:36 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1502906880.52806-1546123981', 11:08:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:08:36 INFO - '_': '/tools/buildbot/bin/python'} 11:08:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:08:36 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 11:08:36 INFO - Cleaning up... 11:08:36 INFO - Return code: 0 11:08:36 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 11:08:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:08:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:08:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:08:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:08:36 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 0xe341f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf38a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10dbef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d90b0>, '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 0x10d9fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10da440>, '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': 'af724c981e2a0f424dbabf99000001e7-1502906880.52806-1546123981', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:08:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 11:08:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 11:08:36 INFO - Using env: {'DISPLAY': ':0', 11:08:36 INFO - 'HOME': '/home/cltbld', 11:08:36 INFO - 'LANG': 'en_US.UTF-8', 11:08:36 INFO - 'LANGUAGE': 'en_US:en', 11:08:36 INFO - 'LOGNAME': 'cltbld', 11:08:36 INFO - 'MAIL': '/var/mail/cltbld', 11:08:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:08:36 INFO - 'MOZ_NO_REMOTE': '1', 11:08:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:08:36 INFO - 'NO_EM_RESTART': '1', 11:08:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:08:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:08:36 INFO - 'PWD': '/builds/slave/test', 11:08:36 INFO - 'SHELL': '/bin/bash', 11:08:36 INFO - 'SHLVL': '1', 11:08:36 INFO - 'TERM': 'linux', 11:08:36 INFO - 'TMOUT': '86400', 11:08:36 INFO - 'USER': 'cltbld', 11:08:36 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1502906880.52806-1546123981', 11:08:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:08:36 INFO - '_': '/tools/buildbot/bin/python'} 11:08:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:08:37 INFO - Downloading/unpacking psutil>=3.1.1 11:08:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:08:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:08:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:08:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:08:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 11:08:38 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:08:38 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:08:38 INFO - Installing collected packages: psutil 11:08:38 INFO - Running setup.py install for psutil 11:08:38 INFO - building 'psutil._psutil_linux' extension 11:08:38 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 11:08:38 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 11:08:38 INFO - building 'psutil._psutil_posix' extension 11:08:38 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 11:08:38 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 11:08:38 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:08:38 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:08:38 INFO - Successfully installed psutil 11:08:38 INFO - Cleaning up... 11:08:38 INFO - Return code: 0 11:08:38 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 11:08:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:08:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:08:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:08:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:08:38 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 0xe341f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf38a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10dbef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d90b0>, '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 0x10d9fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10da440>, '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': 'af724c981e2a0f424dbabf99000001e7-1502906880.52806-1546123981', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:08:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 11:08:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 11:08:38 INFO - Using env: {'DISPLAY': ':0', 11:08:38 INFO - 'HOME': '/home/cltbld', 11:08:38 INFO - 'LANG': 'en_US.UTF-8', 11:08:38 INFO - 'LANGUAGE': 'en_US:en', 11:08:38 INFO - 'LOGNAME': 'cltbld', 11:08:38 INFO - 'MAIL': '/var/mail/cltbld', 11:08:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:08:38 INFO - 'MOZ_NO_REMOTE': '1', 11:08:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:08:38 INFO - 'NO_EM_RESTART': '1', 11:08:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:08:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:08:38 INFO - 'PWD': '/builds/slave/test', 11:08:38 INFO - 'SHELL': '/bin/bash', 11:08:38 INFO - 'SHLVL': '1', 11:08:38 INFO - 'TERM': 'linux', 11:08:38 INFO - 'TMOUT': '86400', 11:08:38 INFO - 'USER': 'cltbld', 11:08:38 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1502906880.52806-1546123981', 11:08:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:08:38 INFO - '_': '/tools/buildbot/bin/python'} 11:08:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:08:39 INFO - Downloading/unpacking mozsystemmonitor==0.3 11:08:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:08:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:08:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:08:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:08:40 INFO - Downloading mozsystemmonitor-0.3.tar.gz 11:08:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 11:08:40 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 11:08:40 INFO - Installing collected packages: mozsystemmonitor 11:08:40 INFO - Running setup.py install for mozsystemmonitor 11:08:40 INFO - Successfully installed mozsystemmonitor 11:08:40 INFO - Cleaning up... 11:08:40 INFO - Return code: 0 11:08:40 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 11:08:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:08:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:08:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:08:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:08:40 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 0xe341f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf38a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10dbef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d90b0>, '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 0x10d9fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10da440>, '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': 'af724c981e2a0f424dbabf99000001e7-1502906880.52806-1546123981', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:08:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 11:08:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 11:08:40 INFO - Using env: {'DISPLAY': ':0', 11:08:40 INFO - 'HOME': '/home/cltbld', 11:08:40 INFO - 'LANG': 'en_US.UTF-8', 11:08:40 INFO - 'LANGUAGE': 'en_US:en', 11:08:40 INFO - 'LOGNAME': 'cltbld', 11:08:40 INFO - 'MAIL': '/var/mail/cltbld', 11:08:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:08:40 INFO - 'MOZ_NO_REMOTE': '1', 11:08:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:08:40 INFO - 'NO_EM_RESTART': '1', 11:08:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:08:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:08:40 INFO - 'PWD': '/builds/slave/test', 11:08:40 INFO - 'SHELL': '/bin/bash', 11:08:40 INFO - 'SHLVL': '1', 11:08:40 INFO - 'TERM': 'linux', 11:08:40 INFO - 'TMOUT': '86400', 11:08:40 INFO - 'USER': 'cltbld', 11:08:40 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1502906880.52806-1546123981', 11:08:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:08:40 INFO - '_': '/tools/buildbot/bin/python'} 11:08:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:08:40 INFO - Downloading/unpacking jsonschema==2.5.1 11:08:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:08:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:08:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:08:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:08:41 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 11:08:41 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 11:08:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:08:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:08:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:08:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:08:41 INFO - Downloading functools32-3.2.3-2.tar.gz 11:08:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 11:08:41 INFO - warning: no files found matching '*.txt' 11:08:41 INFO - no previously-included directories found matching 'build' 11:08:41 INFO - no previously-included directories found matching 'dist' 11:08:41 INFO - no previously-included directories found matching '.git*' 11:08:41 INFO - Installing collected packages: jsonschema, functools32 11:08:41 INFO - Running setup.py install for functools32 11:08:42 INFO - warning: no files found matching '*.txt' 11:08:42 INFO - no previously-included directories found matching 'build' 11:08:42 INFO - no previously-included directories found matching 'dist' 11:08:42 INFO - no previously-included directories found matching '.git*' 11:08:42 INFO - Successfully installed jsonschema functools32 11:08:42 INFO - Cleaning up... 11:08:42 INFO - Return code: 0 11:08:42 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 11:08:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:08:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:08:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:08:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:08:42 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 0xe341f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf38a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10dbef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d90b0>, '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 0x10d9fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10da440>, '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': 'af724c981e2a0f424dbabf99000001e7-1502906880.52806-1546123981', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:08:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 11:08:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 11:08:42 INFO - Using env: {'DISPLAY': ':0', 11:08:42 INFO - 'HOME': '/home/cltbld', 11:08:42 INFO - 'LANG': 'en_US.UTF-8', 11:08:42 INFO - 'LANGUAGE': 'en_US:en', 11:08:42 INFO - 'LOGNAME': 'cltbld', 11:08:42 INFO - 'MAIL': '/var/mail/cltbld', 11:08:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:08:42 INFO - 'MOZ_NO_REMOTE': '1', 11:08:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:08:42 INFO - 'NO_EM_RESTART': '1', 11:08:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:08:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:08:42 INFO - 'PWD': '/builds/slave/test', 11:08:42 INFO - 'SHELL': '/bin/bash', 11:08:42 INFO - 'SHLVL': '1', 11:08:42 INFO - 'TERM': 'linux', 11:08:42 INFO - 'TMOUT': '86400', 11:08:42 INFO - 'USER': 'cltbld', 11:08:42 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1502906880.52806-1546123981', 11:08:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:08:42 INFO - '_': '/tools/buildbot/bin/python'} 11:08:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:08:42 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 11:08:42 INFO - Cleaning up... 11:08:42 INFO - Return code: 0 11:08:42 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 11:08:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:08:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:08:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:08:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:08:42 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 0xe341f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf38a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10dbef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d90b0>, '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 0x10d9fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10da440>, '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': 'af724c981e2a0f424dbabf99000001e7-1502906880.52806-1546123981', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:08:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 11:08:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 11:08:42 INFO - Using env: {'DISPLAY': ':0', 11:08:42 INFO - 'HOME': '/home/cltbld', 11:08:42 INFO - 'LANG': 'en_US.UTF-8', 11:08:42 INFO - 'LANGUAGE': 'en_US:en', 11:08:42 INFO - 'LOGNAME': 'cltbld', 11:08:42 INFO - 'MAIL': '/var/mail/cltbld', 11:08:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:08:42 INFO - 'MOZ_NO_REMOTE': '1', 11:08:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:08:42 INFO - 'NO_EM_RESTART': '1', 11:08:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:08:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:08:42 INFO - 'PWD': '/builds/slave/test', 11:08:42 INFO - 'SHELL': '/bin/bash', 11:08:42 INFO - 'SHLVL': '1', 11:08:42 INFO - 'TERM': 'linux', 11:08:42 INFO - 'TMOUT': '86400', 11:08:42 INFO - 'USER': 'cltbld', 11:08:42 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1502906880.52806-1546123981', 11:08:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:08:42 INFO - '_': '/tools/buildbot/bin/python'} 11:08:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:08:42 INFO - Downloading/unpacking blobuploader==1.2.4 11:08:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:08:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:08:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:08:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:08:43 INFO - Downloading blobuploader-1.2.4.tar.gz 11:08:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 11:08:43 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 11:08:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:08:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:08:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:08:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:08:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 11:08:44 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 11:08:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:08:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:08:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:08:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:08:44 INFO - Downloading docopt-0.6.1.tar.gz 11:08:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 11:08:44 INFO - Installing collected packages: blobuploader, requests, docopt 11:08:44 INFO - Running setup.py install for blobuploader 11:08:44 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 11:08:44 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 11:08:44 INFO - Running setup.py install for requests 11:08:44 INFO - Running setup.py install for docopt 11:08:44 INFO - Successfully installed blobuploader requests docopt 11:08:44 INFO - Cleaning up... 11:08:44 INFO - Return code: 0 11:08:44 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:08:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:08:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:08:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:08:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:08:44 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 0xe341f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf38a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10dbef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d90b0>, '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 0x10d9fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10da440>, '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': 'af724c981e2a0f424dbabf99000001e7-1502906880.52806-1546123981', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:08:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 11:08:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 11:08:44 INFO - Using env: {'DISPLAY': ':0', 11:08:44 INFO - 'HOME': '/home/cltbld', 11:08:44 INFO - 'LANG': 'en_US.UTF-8', 11:08:44 INFO - 'LANGUAGE': 'en_US:en', 11:08:44 INFO - 'LOGNAME': 'cltbld', 11:08:44 INFO - 'MAIL': '/var/mail/cltbld', 11:08:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:08:44 INFO - 'MOZ_NO_REMOTE': '1', 11:08:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:08:44 INFO - 'NO_EM_RESTART': '1', 11:08:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:08:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:08:44 INFO - 'PWD': '/builds/slave/test', 11:08:44 INFO - 'SHELL': '/bin/bash', 11:08:44 INFO - 'SHLVL': '1', 11:08:44 INFO - 'TERM': 'linux', 11:08:44 INFO - 'TMOUT': '86400', 11:08:44 INFO - 'USER': 'cltbld', 11:08:44 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1502906880.52806-1546123981', 11:08:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:08:44 INFO - '_': '/tools/buildbot/bin/python'} 11:08:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:08:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:08:45 INFO - Running setup.py (path:/tmp/pip-AC5N7m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:08:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:08:45 INFO - Running setup.py (path:/tmp/pip-IaslPF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:08:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:08:45 INFO - Running setup.py (path:/tmp/pip-pTjvKz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:08:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:08:45 INFO - Running setup.py (path:/tmp/pip-71o0iA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:08:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:08:45 INFO - Running setup.py (path:/tmp/pip-loW3mD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:08:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:08:45 INFO - Running setup.py (path:/tmp/pip-FPEzWY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:08:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:08:45 INFO - Running setup.py (path:/tmp/pip-14ifBn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:08:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:08:45 INFO - Running setup.py (path:/tmp/pip-J5WEkP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:08:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:08:45 INFO - Running setup.py (path:/tmp/pip-mAMxa6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:08:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:08:45 INFO - Running setup.py (path:/tmp/pip-s0Hq5P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:08:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:08:45 INFO - Running setup.py (path:/tmp/pip-P4gFxz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:08:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:08:45 INFO - Running setup.py (path:/tmp/pip-Ib2Mk6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:08:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:08:45 INFO - Running setup.py (path:/tmp/pip-UdhaJO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:08:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:08:46 INFO - Running setup.py (path:/tmp/pip-w3P202-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:08:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:08:46 INFO - Running setup.py (path:/tmp/pip-u3uajZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:08:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:08:46 INFO - Running setup.py (path:/tmp/pip-5YO54C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:08:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:08:46 INFO - Running setup.py (path:/tmp/pip-yWfF_g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:08:46 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 11:08:46 INFO - Running setup.py install for manifestparser 11:08:46 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 11:08:46 INFO - Running setup.py install for mozcrash 11:08:46 INFO - Running setup.py install for mozdebug 11:08:46 INFO - Running setup.py install for mozdevice 11:08:46 INFO - Installing dm script to /builds/slave/test/build/venv/bin 11:08:46 INFO - Running setup.py install for mozfile 11:08:46 INFO - Running setup.py install for mozhttpd 11:08:46 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 11:08:46 INFO - Running setup.py install for mozinfo 11:08:46 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 11:08:47 INFO - Running setup.py install for mozInstall 11:08:47 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 11:08:47 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 11:08:47 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 11:08:47 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 11:08:47 INFO - Running setup.py install for mozleak 11:08:47 INFO - Running setup.py install for mozlog 11:08:47 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 11:08:47 INFO - Running setup.py install for moznetwork 11:08:47 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 11:08:47 INFO - Running setup.py install for mozprocess 11:08:47 INFO - Running setup.py install for mozprofile 11:08:47 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 11:08:47 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 11:08:47 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 11:08:47 INFO - Running setup.py install for mozrunner 11:08:47 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 11:08:47 INFO - Running setup.py install for mozscreenshot 11:08:47 INFO - Running setup.py install for moztest 11:08:47 INFO - Running setup.py install for mozversion 11:08:48 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 11:08:48 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 11:08:48 INFO - Cleaning up... 11:08:48 INFO - Return code: 0 11:08:48 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:08:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:08:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:08:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:08:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:08:48 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 0xe341f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf38a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10dbef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d90b0>, '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 0x10d9fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10da440>, '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': 'af724c981e2a0f424dbabf99000001e7-1502906880.52806-1546123981', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:08:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 11:08:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 11:08:48 INFO - Using env: {'DISPLAY': ':0', 11:08:48 INFO - 'HOME': '/home/cltbld', 11:08:48 INFO - 'LANG': 'en_US.UTF-8', 11:08:48 INFO - 'LANGUAGE': 'en_US:en', 11:08:48 INFO - 'LOGNAME': 'cltbld', 11:08:48 INFO - 'MAIL': '/var/mail/cltbld', 11:08:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:08:48 INFO - 'MOZ_NO_REMOTE': '1', 11:08:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:08:48 INFO - 'NO_EM_RESTART': '1', 11:08:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:08:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:08:48 INFO - 'PWD': '/builds/slave/test', 11:08:48 INFO - 'SHELL': '/bin/bash', 11:08:48 INFO - 'SHLVL': '1', 11:08:48 INFO - 'TERM': 'linux', 11:08:48 INFO - 'TMOUT': '86400', 11:08:48 INFO - 'USER': 'cltbld', 11:08:48 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1502906880.52806-1546123981', 11:08:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:08:48 INFO - '_': '/tools/buildbot/bin/python'} 11:08:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:08:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:08:48 INFO - Running setup.py (path:/tmp/pip-TcMrgQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:08:48 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 11:08:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:08:48 INFO - Running setup.py (path:/tmp/pip-j9MAEu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:08:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 11:08:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:08:48 INFO - Running setup.py (path:/tmp/pip-fEQoVT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:08:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 11:08:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:08:48 INFO - Running setup.py (path:/tmp/pip-Rq__sY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:08:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.51 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 11:08:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:08:48 INFO - Running setup.py (path:/tmp/pip-RjzIzO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:08:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 11:08:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:08:48 INFO - Running setup.py (path:/tmp/pip-hKcGaC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:08:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 11:08:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:08:48 INFO - Running setup.py (path:/tmp/pip-x3vqht-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:08:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.10 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 11:08:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:08:48 INFO - Running setup.py (path:/tmp/pip-3zpAlB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:08:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.13 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 11:08:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:08:48 INFO - Running setup.py (path:/tmp/pip-3MIYuo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:08:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 11:08:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:08:48 INFO - Running setup.py (path:/tmp/pip-YrM4pf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:08:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.5 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:08:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:08:49 INFO - Running setup.py (path:/tmp/pip-t1SUFr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:08:49 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 11:08:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:08:49 INFO - Running setup.py (path:/tmp/pip-uQS3A_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:08:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 11:08:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:08:49 INFO - Running setup.py (path:/tmp/pip-HIG6bK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:08:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 11:08:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:08:49 INFO - Running setup.py (path:/tmp/pip-WTaXx_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:08:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 11:08:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:08:49 INFO - Running setup.py (path:/tmp/pip-Y6Jl30-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:08:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 11:08:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:08:49 INFO - Running setup.py (path:/tmp/pip-8K0gGf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:08:49 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 11:08:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:08:49 INFO - Running setup.py (path:/tmp/pip-ENkLdv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:08:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 11:08:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 11:08:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 11:08:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 11:08:49 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.51->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 11:08:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.51->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 11:08:49 INFO - Requirement already satisfied (use --upgrade to upgrade): requests in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozInstall==1.13->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 11:08:49 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:08:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:08:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:08:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:08:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:08:50 INFO - Downloading blessings-1.6.tar.gz 11:08:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 11:08:50 INFO - Installing collected packages: blessings 11:08:50 INFO - Running setup.py install for blessings 11:08:50 INFO - Successfully installed blessings 11:08:50 INFO - Cleaning up... 11:08:50 INFO - Return code: 0 11:08:50 INFO - Done creating virtualenv /builds/slave/test/build/venv. 11:08:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:08:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:08:51 INFO - Reading from file tmpfile_stdout 11:08:51 INFO - Current package versions: 11:08:51 INFO - argparse == 1.2.1 11:08:51 INFO - blessings == 1.6 11:08:51 INFO - blobuploader == 1.2.4 11:08:51 INFO - docopt == 0.6.1 11:08:51 INFO - functools32 == 3.2.3-2 11:08:51 INFO - jsonschema == 2.5.1 11:08:51 INFO - manifestparser == 1.1 11:08:51 INFO - mozInstall == 1.13 11:08:51 INFO - mozcrash == 1.0 11:08:51 INFO - mozdebug == 0.1 11:08:51 INFO - mozdevice == 0.51 11:08:51 INFO - mozfile == 1.2 11:08:51 INFO - mozhttpd == 0.7 11:08:51 INFO - mozinfo == 0.10 11:08:51 INFO - mozleak == 0.1 11:08:51 INFO - mozlog == 3.5 11:08:51 INFO - moznetwork == 0.27 11:08:51 INFO - mozprocess == 0.25 11:08:51 INFO - mozprofile == 0.28 11:08:51 INFO - mozrunner == 6.13 11:08:51 INFO - mozscreenshot == 0.1 11:08:51 INFO - mozsystemmonitor == 0.3 11:08:51 INFO - moztest == 0.8 11:08:51 INFO - mozversion == 1.4 11:08:51 INFO - psutil == 3.1.1 11:08:51 INFO - requests == 1.2.3 11:08:51 INFO - wsgiref == 0.1.2 11:08:51 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:08: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')]} 11:08:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:08: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')]} 11:08:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:08:51 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 0xe341f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf38a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10dbef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d90b0>, '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 0x10d9fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10da440>, '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': 'af724c981e2a0f424dbabf99000001e7-1502906880.52806-1546123981', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:08:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 11:08:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 11:08:51 INFO - Using env: {'DISPLAY': ':0', 11:08:51 INFO - 'HOME': '/home/cltbld', 11:08:51 INFO - 'LANG': 'en_US.UTF-8', 11:08:51 INFO - 'LANGUAGE': 'en_US:en', 11:08:51 INFO - 'LOGNAME': 'cltbld', 11:08:51 INFO - 'MAIL': '/var/mail/cltbld', 11:08:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:08:51 INFO - 'MOZ_NO_REMOTE': '1', 11:08:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:08:51 INFO - 'NO_EM_RESTART': '1', 11:08:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:08:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:08:51 INFO - 'PWD': '/builds/slave/test', 11:08:51 INFO - 'SHELL': '/bin/bash', 11:08:51 INFO - 'SHLVL': '1', 11:08:51 INFO - 'TERM': 'linux', 11:08:51 INFO - 'TMOUT': '86400', 11:08:51 INFO - 'USER': 'cltbld', 11:08:51 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1502906880.52806-1546123981', 11:08:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:08:51 INFO - '_': '/tools/buildbot/bin/python'} 11:08:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:08:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 11:08:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 11:08:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 11:08:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 11:08:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 11:08:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 11:08:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 11:08:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 11:08:51 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 11:08:51 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 11:08:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:08:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:08:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:08:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:08:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 11:08:52 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 11:08:52 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 11:08:52 INFO - Installing collected packages: simplejson 11:08:52 INFO - Running setup.py install for simplejson 11:08:52 INFO - building 'simplejson._speedups' extension 11:08:52 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c simplejson/_speedups.c -o build/temp.linux-x86_64-2.7/simplejson/_speedups.o 11:08:53 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/simplejson/_speedups.o -o build/lib.linux-x86_64-2.7/simplejson/_speedups.so 11:08:53 INFO - Successfully installed simplejson 11:08:53 INFO - Cleaning up... 11:08:53 INFO - Return code: 0 11:08:53 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 11:08:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:08:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:08:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:08:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:08:53 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe341f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf38a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10dbef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d90b0>, '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 0x10d9fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10da440>, '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': 'af724c981e2a0f424dbabf99000001e7-1502906880.52806-1546123981', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:08:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 11:08:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 11:08:53 INFO - Using env: {'DISPLAY': ':0', 11:08:53 INFO - 'HOME': '/home/cltbld', 11:08:53 INFO - 'LANG': 'en_US.UTF-8', 11:08:53 INFO - 'LANGUAGE': 'en_US:en', 11:08:53 INFO - 'LOGNAME': 'cltbld', 11:08:53 INFO - 'MAIL': '/var/mail/cltbld', 11:08:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:08:53 INFO - 'MOZ_NO_REMOTE': '1', 11:08:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:08:53 INFO - 'NO_EM_RESTART': '1', 11:08:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:08:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:08:53 INFO - 'PWD': '/builds/slave/test', 11:08:53 INFO - 'SHELL': '/bin/bash', 11:08:53 INFO - 'SHLVL': '1', 11:08:53 INFO - 'TERM': 'linux', 11:08:53 INFO - 'TMOUT': '86400', 11:08:53 INFO - 'USER': 'cltbld', 11:08:53 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1502906880.52806-1546123981', 11:08:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:08:53 INFO - '_': '/tools/buildbot/bin/python'} 11:08:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:08:53 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 11:08:53 INFO - Cleaning up... 11:08:53 INFO - Return code: 0 11:08:53 INFO - Running post-action listener: _resource_record_post_action 11:08:53 INFO - Running post-action listener: _start_resource_monitoring 11:08:53 INFO - Starting resource monitoring. 11:08:53 INFO - [mozharness: 2017-08-16 18:08:53.828885Z] Finished create-virtualenv step (success) 11:08:53 INFO - [mozharness: 2017-08-16 18:08:53.829473Z] Running install step. 11:08:53 INFO - Running pre-action listener: _resource_record_pre_action 11:08:53 INFO - Running main action method: install 11:08:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:08:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:08:54 INFO - Reading from file tmpfile_stdout 11:08:54 INFO - Detecting whether we're running mozinstall >=1.0... 11:08:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 11:08:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 11:08:54 INFO - Reading from file tmpfile_stdout 11:08:54 INFO - Output received: 11:08:54 INFO - Usage: mozinstall [options] installer 11:08:54 INFO - Options: 11:08:54 INFO - -h, --help show this help message and exit 11:08:54 INFO - -d DEST, --destination=DEST 11:08:54 INFO - Directory to install application into. [default: 11:08:54 INFO - "/builds/slave/test"] 11:08:54 INFO - --app=APP Application being installed. [default: firefox] 11:08:54 INFO - mkdir: /builds/slave/test/build/application 11:08:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/target.tar.bz2', '--destination', '/builds/slave/test/build/application'] 11:08:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 11:09:12 INFO - Reading from file tmpfile_stdout 11:09:12 INFO - Output received: 11:09:12 INFO - /builds/slave/test/build/application/firefox/firefox 11:09:12 INFO - Running post-action listener: _resource_record_post_action 11:09:12 INFO - [mozharness: 2017-08-16 18:09:12.158830Z] Finished install step (success) 11:09:12 INFO - [mozharness: 2017-08-16 18:09:12.159112Z] Running setup-mitmproxy step. 11:09:12 INFO - Running pre-action listener: _resource_record_pre_action 11:09:12 INFO - Running main action method: setup_mitmproxy 11:09:12 INFO - Skipping: mitmproxy is not required 11:09:12 INFO - Running post-action listener: _resource_record_post_action 11:09:12 INFO - [mozharness: 2017-08-16 18:09:12.160263Z] Finished setup-mitmproxy step (success) 11:09:12 INFO - [mozharness: 2017-08-16 18:09:12.160487Z] Running run-tests step. 11:09:12 INFO - Running pre-action listener: _resource_record_pre_action 11:09:12 INFO - Running pre-action listener: _set_gcov_prefix 11:09:12 INFO - Running main action method: run_tests 11:09:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 11:09:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 11:09:12 INFO - Python 2.7.3 11:09:12 INFO - Return code: 0 11:09:12 INFO - grabbing minidump binary from tooltool 11:09:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:09:12 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 0x10d90b0>, '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 0x10d9fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10da440>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 11:09:12 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 11:09:12 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 11:09:12 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 11:09:12 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 11:09:12 INFO - Return code: 0 11:09:12 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 11:09:12 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 11:09:12 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 11:09:12 INFO - ENV: RUST_BACKTRACE is now full 11:09:12 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 11:09:12 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 11:09:12 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/YbqntiLNQ_uKrat-Wa379w/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-020', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 11:09:12 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/YbqntiLNQ_uKrat-Wa379w/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-020 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 11:09:12 INFO - Using env: {'DISPLAY': ':0', 11:09:12 INFO - 'HOME': '/home/cltbld', 11:09:12 INFO - 'LANG': 'en_US.UTF-8', 11:09:12 INFO - 'LANGUAGE': 'en_US:en', 11:09:12 INFO - 'LOGNAME': 'cltbld', 11:09:12 INFO - 'MAIL': '/var/mail/cltbld', 11:09:12 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:09:12 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 11:09:12 INFO - 'MOZ_ACCELERATED': '1', 11:09:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:09:12 INFO - 'MOZ_NO_REMOTE': '1', 11:09:12 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:09:12 INFO - 'MOZ_WEBRENDER': '1', 11:09:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:09:12 INFO - 'NO_EM_RESTART': '1', 11:09:12 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:09:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:09:12 INFO - 'PWD': '/builds/slave/test', 11:09:12 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:09:12 INFO - 'RUST_BACKTRACE': 'full', 11:09:12 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 11:09:12 INFO - 'SHELL': '/bin/bash', 11:09:12 INFO - 'SHLVL': '1', 11:09:12 INFO - 'TERM': 'linux', 11:09:12 INFO - 'TMOUT': '86400', 11:09:12 INFO - 'USER': 'cltbld', 11:09:12 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1502906880.52806-1546123981', 11:09:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:09:12 INFO - '_': '/tools/buildbot/bin/python'} 11:09:12 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/YbqntiLNQ_uKrat-Wa379w/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-020', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 11:09:12 INFO - mozversion application_buildid: 20170816171050 11:09:12 INFO - mozversion application_changeset: 07ce8c96222d533fc89c02802143d35d7c351f9c 11:09:12 INFO - mozversion application_display_name: Nightly 11:09:12 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 11:09:12 INFO - mozversion application_name: Firefox 11:09:12 INFO - mozversion application_remotingname: firefox 11:09:12 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 11:09:12 INFO - mozversion application_vendor: Mozilla 11:09:12 INFO - mozversion application_version: 57.0a1 11:09:12 INFO - mozversion platform_buildid: 20170816171050 11:09:12 INFO - mozversion platform_changeset: 07ce8c96222d533fc89c02802143d35d7c351f9c 11:09:12 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 11:09:12 INFO - mozversion platform_version: 57.0a1 11:09:12 INFO - using testdate: 1502906952 11:09:12 INFO - actual date: 1502906952 11:09:12 INFO - starting webserver on 'localhost:46512' 11:09:12 INFO - SUITE-START | Running 2 tests 11:09:12 INFO - TEST-START | dromaeo_css 11:09:12 INFO - Initialising browser for dromaeo_css test... 11:09:12 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:46512/getInfo.html -profile /tmp/tmp2XVTZL/profile 11:09:12 INFO - TEST-INFO | started process 24928 (/builds/slave/test/build/application/firefox/firefox http://localhost:46512/getInfo.html) 11:09:19 INFO - TEST-INFO | 24928: exit 0 11:09:19 INFO - Browser initialized. 11:09:19 INFO - Running cycle 1/1 for dromaeo_css test... 11:09:19 INFO - TEST-INFO | started process 25150 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp2XVTZL/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 11:09:20 INFO - PID 25150 | WebRender - OpenGL version new 3.2.0 NVIDIA 361.42 11:09:20 INFO - PID 25150 | WebRender - OpenGL version new 3.2.0 NVIDIA 361.42 11:09:20 INFO - PID 25150 | 11:09:20 INFO - PID 25150 | (/builds/slave/test/build/application/firefox/firefox:25208): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 11:09:20 INFO - PID 25150 | 11:09:31 INFO - PID 25150 | RSS: Main: 195870720 11:09:31 INFO - PID 25150 | 11:09:35 INFO - PID 25150 | WebRender - OpenGL version new 3.2.0 NVIDIA 361.42 11:12:30 INFO - PID 25150 | Cycle 1(1): loaded http://localhost:46512/tests/dromaeo/cssquery-dojo.html (next: http://localhost:46512/tests/dromaeo/cssquery-ext.html) 11:12:31 INFO - PID 25150 | RSS: Main: 224493568 11:12:31 INFO - PID 25150 | 11:15:34 INFO - PID 25150 | Cycle 1(1): loaded http://localhost:46512/tests/dromaeo/cssquery-ext.html (next: http://localhost:46512/tests/dromaeo/cssquery-jquery.html) 11:15:34 INFO - PID 25150 | RSS: Main: 268816384 11:15:34 INFO - PID 25150 | 11:18:36 INFO - PID 25150 | Cycle 1(1): loaded http://localhost:46512/tests/dromaeo/cssquery-jquery.html (next: http://localhost:46512/tests/dromaeo/cssquery-mootools.html) 11:18:37 INFO - PID 25150 | RSS: Main: 273723392 11:18:37 INFO - PID 25150 | 11:21:39 INFO - PID 25150 | Cycle 1(1): loaded http://localhost:46512/tests/dromaeo/cssquery-mootools.html (next: http://localhost:46512/tests/dromaeo/cssquery-prototype.html) 11:21:40 INFO - PID 25150 | RSS: Main: 276520960 11:21:40 INFO - PID 25150 | 11:24:44 INFO - PID 25150 | Cycle 1(1): loaded http://localhost:46512/tests/dromaeo/cssquery-prototype.html (next: http://localhost:46512/tests/dromaeo/cssquery-yui.html) 11:24:45 INFO - PID 25150 | RSS: Main: 279453696 11:24:45 INFO - PID 25150 | 11:27:47 INFO - PID 25150 | Cycle 1(1): loaded http://localhost:46512/tests/dromaeo/cssquery-yui.html (next: http://localhost:46512/tests/dromaeo/cssquery-dojo.html) 11:27:47 INFO - PID 25150 | RSS: Main: 280420352 11:27:47 INFO - PID 25150 | 11:27:47 INFO - PID 25150 | __start_tp_report 11:27:47 INFO - PID 25150 | _x_x_mozilla_page_load 11:27:47 INFO - PID 25150 | _x_x_mozilla_page_load_details 11:27:47 INFO - PID 25150 | |i|pagename|runs| 11:27:47 INFO - PID 25150 | |0;dojo.html;3119.750419966403;3122.6721194274587;3159.652438231794;3161.0990867602736;3224.435723748345;6021.578489505737;6096.6951652417365;6156.384361563847;6165.198524191849;6259.499240060795;6174.567780255384;6204.96897515513;6280.811575652726;6296.527760417964;6314.210723659543;5649.745761440725;5664.8867022659415;5692.0608099663505;5729.341125770548;5780.5664575156825;5511.448855114497;5576;5580.051391263474;5666.206731057655;5711.742971566289;5604.047311956957;5643.661380317174;5690.772369105231;5697.544196464293;5711.514521265697;5578;5632.802851900164;5684.658920464785;5691.886162276773;5706.600537962303;5442.6462279952075;5541.9168712469345;5558;5580.1629755537;5627.43725627434;6079.574429789916;6086.513078953673;6101.572889897709;6109.5723299369065;6120.96939515304;6556.508261880378;6609.471242300652;6614.272430032693;6706.195256569243;6711.094002309675;6505.186851643544;6535.0850880876715;6560.278369379364;6715.2613212546585;6759.628220447873;6074.8785024299705;6076.149339092531;6095.146679464879;6098.939010609882;6156.569040167235;6880.552764070319;6882.311768823178;6895.310468953065;6905.689243984033;6922;6447.903281450782;6460.644664543402;6545.37818907203;6550.213974323112;6551.672416379162;6565.212174539086;6580.5722628029025;6660.034295027291;6695.46436285096;6707.463402927754;6413.839654008687;6482.157319548429;6508.707108180143;6542.705578248991;6582.111414959015;6699.9665001674675;6713;6721.025451309532;6721.462283017347;6739.730410783612;5383.192521121863;5412.864678383072;5452.291202143696;5490.890182196334;5515.503604675599;4512.2329204035395;4595.862124136282;4652.418447694038;4682.906341873211;4693.718376897329;5638.633488823295;5674.4892959633835;5719.7140142992685;5767.250257466587;5803.5357171426185;6501;6513.54405191632;6556.770513032021;6556.967215163893;6558.524332025351;5497.8075767347955;5582.525485333792;5659.122835960433;5685.459881311269;5711.457411545896;5628.380878103405;5684.8294551163535;5707.971460142673;5777.364489906107;5789.478946894799;6302.716377763011;6360.681965901686;6392.968035159794;6463.5798673085155;6544.705488252945;6684.264730879502;6688;6711.060451536887;6711.731530738716;6730.495212859153;6426.518011149089;6432.614043157426;6452.935470645421;6529.347065293623;6531.706073226621;6453.193350831146;6462.192225971754;6544;6558.344165583403;6606.471482281502;6500.382463665944;6569.638669873203;6596.406323430914;6597.472202223907;6619.50353723463;6408.58344207625;6446.645434501147;6447.4197322241225;6472.834889719896;6488.578242414228;6361.300256971637;6432.549721519449;6451.580647257913;6463.15978922737;6524.217093948757;6332.525060620564;6426.228852537725;6438.549301549034;6448.032795080775;6450.129232553545;6422.550421470639;6458.580192287674;6523.24982626985;6539.901901471577;6588.110605068255;6046.697665116814;6157.907631385622;6201.441870231701;6218.440340369389;6339.334369891095 11:27:47 INFO - PID 25150 | |1;ext.html;799.7760627024435;809.5911564659846;836.7071524966261;853.0871966995318;866.4714524140273;41160;41964.790176049115;42069.789651051775;42109.78945105274;42149;38208.235835283274;38573.42139867904;38575.614243857555;38620.420693689615;38664.03339916503;6732.394084532391;6835.897461538081;6836;6837.829054273658;6850.109485766869;6746.392824645781;6761.8309542261595;6829.965850170742;6837.076994605714;6843.760468383608;6779.084823548807;6832.760853370133;7421.851562968737;7630.351420129296;7649.235076492334;7569.924300756977;7625.199354067799;7628.923710762904;7637.083549974039;7637.809054773619;7590.620468976585;7626.084869815602;7679.6160191990175;7698.268664476922;7713.190115037953;39188.21623567513;40127.79936100301;40162.39756403656;40175.79912100421;40330.79834600838;3547.3614749345106;3640.9635903640888;3641.453781932731;3643.344198044351;3646;32075.6792432075;32199.51700724491;32221.194470138198;32257.51613725796;32296.19259518507;5123.769430375642;5133.101707201225;5156.690598564061;5169.81905633301;5207.531322180984;184342;186741;187285;188206.99999999863;188994.2201155983;48055;48088.27867581989;48320.51679483231;48358.5164148354;48615.756921215165;50522;50525;50969.23546146811;50996;51024.74487627538;15424.228788560527;15605.297761600756;15663.373465061497;15665.37338506447;15792.763108553381;12768.425420856083;12773;12778;12782.744345113046;12806.551770687982;14666.193359365125;14748.18884961316;14763;14837.777433338508;14995.850041499445;5786.623869448473;5927.347991720907;5985.850353741192;6025.216721826135;6112.449879510866;1004.2417974429259;1008.5562352564848;1017.8167929772712;1019.9949000254951;1021.545412291538;22544.21095261658;22621.773782261967;22813;23170.957306921227;29002.85498572536;1084.9186311026704;1093.6336327330275;1105.7711482471204;1106.1593189176283;1110.3448965110463;12333.876661233453;12465.065120116027;12561.811572826415;12617.873821261854;12707.428165732565;245081;248199;249250;249273;249650;45016.3247551287;45582.54417455783;54821;55182.72408638011;55223.44776552264;1455.82530096387;1492.6268432891777;1492.6716122453042;1498.9700205995819;1501.3544176004204;26648.467030659667;27016.45967080608;27039.188824335302;27621;27655.446891061663;37207.627923720414;37737.245255095295;37781.81109094437;37911.81044094762;38010.42984355292;195087;195258;197799;198321;198570;33091.33817323688;33886.81396151123;34087.93208611237;34165.658343416246;34279.28603569861;43226;43291.35062974121;43556.34665480084;44007;44037.779811100736;32089.197770055;32204.19489512781;32473.837630811693;32577.185570359983;32864.50703239405;31522.527162092127;31553.842230789618;31684.5247321295;31993.520097198096;32046.19884502906;34670.82664586661;34761.82619086889;34910.12724681903;35081;35461.645383546864;30805;31321.216969575944;32066.679333206368;34049;34785;24611.63082553727;24711.38221544476;25370.746292537577;25464.490710186063;25584.488310234065 11:27:47 INFO - PID 25150 | |2;jquery.html;566.6996491859315;574.3050908400835;579.3540202674017;580.2630659062987;594.5719082260772;22436;23168;23290;23309.300720978375;23343.416414589603;25668.22995310139;28247.858760706167;28378.43243135136;28458.43083138341;28556.714432855664;7081.114860642419;7188.245234250407;7260.636968151598;7271.200167981518;7291.08861392326;6432.77485288015;7089.432845372384;7199.244079371669;7275.4179665626625;7303.671334789948;7020.613866237355;7026.1217347831525;7080.575165490087;7081.716731330766;7098.467614928875;7054.6472676365975;7057.223705392403;7079.327463890948;7082.185548661892;7083.7520686775715;6881.965590172067;6928.61892595907;6951.860962780716;6980.16238051432;7002;31618.525722114187;31680.841595791873;32060.519092213635;32243.83878080618;32292.192695182574;1869.1869036968826;1927.0364817591205;1929.1415320182525;1935.1098494692458;1938.6995015772577;20319;21024.5795084099;21118.3664490064;21192.788072119234;21216.36350909475;2530.835495692774;2546.1088618983395;2548.5922252439523;2616.947661046768;2629.737026297374;144870;146700;147345.26327368402;147889;148183;20676.966151692355;21874.89062554709;22414.887925560593;22713.545729085326;22756.20353287627;42184;42420;42465;42734.786326068795;42888.356674649905;11812.704682382837;11862.703432414259;12027.879721202851;12169.33068681231;12290.815637765441;9863.852042219372;9924.801503970024;9958.402495850272;10032.749181270381;10069.949650251701;9061.864072038925;9603.127390158992;9771.12059914611;11428.428578571038;12218.572349967708;2772.1683494951435;2810.9297267568472;2812.381276119291;2813.592029155802;2893.1899068260923;934.9158575728217;970.5455340983717;981.9754506137403;983.2085171437062;983.852422136671;19618.50953726168;23794.663521120423;24628.384290392885;25094.874525627256;25179.874100629746;1013.9315795776533;1014.1734486393566;1032.9535170917327;1044.6589203534625;1051.2746205118444;11412.714682133013;11414.315141091562;11544.307341559364;11577.536898523964;11602.825957610643;462390;474823;480433;490353;496417;117507;119375;119385.40307298582;119497;120193;1218.3968935377045;1247.1457051919283;1286.9034822388357;1290.2323117744738;1297.1244410023196;21311.680324795452;21450.463738406666;21527.138914443247;21629.567408652052;22183.223587174372;58295.70852145712;59221.70389148027;60593;61193.69403152956;61703;71666;74566.62716686382;75891;77010.6149469249;77285.61357193178;12474;14319.35562899693;14613.707725845636;14829.925850370679;14992.850071499146;24131.155409560582;24139.879300603385;24176.879115604308;24391.878040609685;24618.876905615358;18456.446306610822;18662.53343666419;18746.625067498848;18848.58635602363;18983.24067037303;16610.50168494947;17267.740983885502;17350.219240134476;17380;17558.473245802645;18646.34737784171;19491.902540487208;19531.21875124979;19618.50953726111;19744.703829442857;14946.626334341294;14977.127859017623;15026.948113631941;15059.6988060236;15116.54650360491;18196.90901545484;18303.176357063698;18589.44231673052;18628.441146765617;18712.15795289188 11:27:47 INFO - PID 25150 | |3;mootools.html;1337.7057047449562;1388.4585011845381;1409.5418988828633;1412.1527083749759;1412.2515067014485;14000.089994150374;14007.719845603082;14839.777403338945;14846.1834599097;14867.851321486782;14518;14968.476103336385;15001.174935378549;15023.399064037425;15136.848631513682;2735.9042433514833;2776.8889244430197;2777.597248398981;2780.527310357234;2785.8885644574193;2513.170653684289;2641.102025311394;2651.297406187362;2692.67687877455;2701.8243814152115;2701.986490067547;2746.533089374801;2749.5325794614964;2758.4483103379303;2765.35014271646;2619.5546757051156;2653.9469210615775;2657.7873770098345;2663.1211700139006;2717.0490328385104;2564.2948189248104;2568.460623269116;2568.7816535594498;2594.8313359631566;2595.9870200649066;14255.928720356436;14536.345864436125;14563.49027784033;14590.489332873405;14630.41478340865;7448.627568621548;7736.961315193388;7744.303012728881;7749.728759493447;7764.805879852993;4844.2975768513725;5010.123228435045;5104.795808167669;5154.896902061975;5159.535641792219;1832.9541761455937;1840.8619353548538;1917.04147926037;2287.49675071484;2397.3167647220457;24119.155829546056;24819.25542233736;24858;24973.125940592174;24993;6575.375339342755;6668.099806526154;6773.762918297836;6806.319368063253;6914.1702995639835;18910.716339254923;18922.3377181798;18943.621127577648;18956.33652822172;19022.904885475484;7698.538087714755;7714.035745531809;7743.5353878767455;7754.18581048993;7756.612169391507;6790.762323318759;6843.349881761224;6945.548539344926;7041.894371584431;7092;5500.339959204921;5581.134924086773;5591.133374326986;5656.123300888369;5691.089425691952;1507.2539093148962;1543.8996465229725;1580.5653445302403;1681.3598559119614;1755.833195846418;874.4927941793871;881.3081730841259;896.2292428511475;898.1781669772216;900.0414558495313;7960.164182760726;8389.07720150783;8426.41015128935;8463.53450560225;8504.914950850536;943.9386439881386;958.3770549143113;961.7547525380983;965.652365148546;985.8077674853334;4123.4021066945725;4176.916461670749;4281.957180428218;4339.370791235253;5340.49265319794;19109;19312.8068719311;19525.51186220356;20066.19735210575;20223.29218477346;19642.312519061765;19789.406317810488;19952.60094798125;20078.19687212495;20214;9341.579628916716;9737.805243895224;9831.803363932539;10205.948970255102;10280.948595257125;8301.418900677136;8435;8446.155384461505;8592.484450932963;8634.654613815377;17335.56661083483;17519.737203941695;17611.471655849833;17844.821551784837;17870.374536891148;17604.55988600244;17712.91143544274;17838.821611783715;17932.193051312985;18034.36879709204;11876.881231187577;11899.226550274205;11948.103892207946;11991.580294689644;12188.634340969786;12930.418131183931;13260.204387736767;13272.668183295495;13273.933630331787;13287.80068298957;10588.894111059099;11006.669799906016;11024.118070554176;11227.27022743519;11461.541538338706;10601.575936962436;10831.945840270748;10901.890981090088;10995.670129896116;11321.830172547254;9095.681651142178;9161.129692679186;9198.080191980749;9205.401648892801;9207.033261507713;6782.050512928293;6833.829154271183;6844.691988860413;6916.515843890879;7022.613756243456;6870.931290687029;6970.23327433992;7088.645567721696;7091.326323999212;7125.35871771543 11:27:47 INFO - PID 25150 | |4;prototype.html;501.9384002834007;506.16262965435476;515.8736109653134;523.9790408383665;530.6020484636523;6050.2739671239515;6199.256089269288;6207.09997050428;6219.782307619234;6244;6045.758169673208;6055.757769689207;6113.572049956505;6151.969240153804;6215.968920155404;4916.655834091615;4953.306537084793;5011.2483127530795;5021.422536408305;5027.2710456983805;4961.727105009223;4970.254461830737;5008.865912439742;5009.44896061433;5026.2209357549455;4732.893862231308;4834.734089625069;4889.755512224392;4945.159322915113;4976.203807390818;4786.64100192487;4834.709917404967;4938.580220681247;4940.1107800596055;4953.455119936804;4361.476622805252;4405.977970110129;4444.933216028162;4455.933161002587;4479.932801007987;5851.444112809277;5906.793262235801;5935.49548288396;5948.702564871739;5994.610350327215;5623.184638227475;5687.516561092312;5747.683877386742;5786.524436268766;5800.24596802413;6400.231972163324;6443.48452123829;6448.93551064488;6499.415052645285;6532.949571265798;4809.663323567317;4854.757262136879;4861.513848615145;4871.707697538123;4913.164761990471;6781.966090169567;6850.862982740367;6982.511224214307;7000.9649951750935;7002;4977.054359671651;4999.900001999939;5037.420696619935;5042.218456139304;5066.265391518209;5051.4695956924725;5070.771815268322;5079.1365467870555;5094.923576146361;5101.591872650179;5677.432256774372;5686.857828554236;5717.3996730342715;5763.366029736726;5776.335721392094;6609.372109649672;6657.833554161088;6681.899771503431;6684.565503242274;6738.157730283715;1671.6656668666315;1698.507432844486;1783.4114742135064;1793.64127174563;1795.8922464652162;1373.4300265389752;1420.1975883625719;1431.7279716853764;1452.5061479096946;1455.3669153918079;5571.693556854412;5634.915081419901;5669.40471250521;5718.971405142947;5737.569682273846;6494.480441564663;6512.837179070561;6571.178602674666;6639.070530125786;6646.2356828965285;5646.802361917313;5649.604527683105;5694.345150307685;5705.636701500576;5715.142728590661;3464.9258729793846;3516.7538272321203;3520.4895290183294;3532.788032718045;3543.2027793746715;6423.164988551458;6432.198984284408;6432.549721519449;6470.38531339522;6490.545661803723;6686.699098540577;6762.898556521656;6776.593404395752;6780.627065511444;6787.694553745093;6418.1656384669695;6485.4487368573255;6498.935010649928;6550.967245163934;6567.014947757683;6570;6585.5719378240265;6597.670116494252;6630.9336906630315;6667.799966001027;6375.330590287953;6417.96791016042;6522.869542609026;6534.509911756732;6581.572197807127;6351.777687780906;6366.9044964326495;6437.871242575028;6477.546571740121;6514.706838192198;5492.5444757140185;5524.458748975356;5532.2254884317035;5563.443655634404;5575.163725441216;6552.901706474502;6601.9009714853355;6644.269130395749;6705.497087718343;6741.52809303344;6329.778457753957;6418.422341989243;6427.967860160857;6434.967825160844;6474.125992990886;6338.397852204033;6354.17395738551;6358.364163583605;6466.482681385572;6483.870322593616;6017.428344307284;6382.6170429774365;6454.419102280817;6483.870322593616;6507.28419873823;6413;6489.805305840832;6524.608523488606;6622.145799176238;6647.368499992686;6261.5616906816085;6322.747090116528;6377.808665740035;6457.612543247233;6496.7726129585235 11:27:47 INFO - PID 25150 | |5;yui.html;890.3989806880355;901.6078006067357;921.2169655792572;926.3561824531953;932.8600709893517;18788;19364.612707745837;19379.806201937976;19403.805961940376;21620.675689864664;21226.469338266514;21701.45746356342;21728.13087476503;21778.89110554449;21793.455163620878;1014.523174108168;1055.0399136785488;1056.3556230699305;1057.1278695076553;1057.9418132002736;1059.041567381517;1065.7229120428667;1066.648006157966;1067.5356220044266;1068.7648717282225;788.7949133225374;819.6885183630212;828.5567221536479;1092.6558134187705;1127.689885281546;1119.6641007697658;1124.1849658997244;1127.3517727306833;1127.7011591928147;1128.0975219824109;819.6147810529042;821.4578378270372;822.3544517553752;823.1398188892562;823.3618945317367;19838.80161198384;19860.80139198604;20193.091310890897;20288.898555507127;20516.38450846477;20698.275560355316;21652;21788.782112178833;22110.33668989933;22156.667649985262;16533.090680012596;17090.82909170905;17211.397601083903;17275.481735547954;17291.221895014627;3623.8188090595363;3633.418653015531;3668.5414323209598;3682.852685892588;3691.833867475943;122909;126265.73734262632;127993.36003319923;130372;132681;17127.657446850993;17571.472855814347;17796.3771268005;17859.553511162067;17863.285468581373;29953.400931981676;30961.380772384877;30970.380592388025;31442.21394465157;31577.368452630817;7426.368758655467;7777.922220777833;7802.765917022499;8501.957490212633;8782.956085219534;3987.501562304712;4069.7558146511305;4078.7756673382655;4149.066460046526;4170.72890262132;5235.712035837989;5237.816676416307;5314.096603577401;5315.973420132875;5372.221027950925;974.0697633759743;987.1263931420744;999.7350702063959;1003.4731765823001;1005.6982905128432;648.7015972652538;669.0833558025536;669.327326037339;671.3152584363921;681.6693903456819;11200.831987520194;12093.939530302292;12346.197497162655;13149.145305555108;13290.3354832258;696.1437431958719;698.5599072584341;706.5689929143218;713.3365969648173;725.6408078001317;5370.409254981949;5670.837478316935;5758.165066065397;5840.036393995028;6013.45878870895;102390;107506;108585.45707271413;109277;112275.438622808;90307.54846225858;96277.5186124065;96932.51533742427;97299.51350243203;101046;85734.57132714297;86186.13813861906;86291.56854215689;87201;89239.55380223187;12526.624201273977;12974.675633109247;13007.219566826021;13031.152975056591;13117.475300987853;38087;38976.610233898435;39348.606513935636;39818;41007.79496102501;51623.741881290356;52650.94698106093;54318.728406359296;54340.72829635826;55288.72355638357;18528.536786579905;18889.149988250836;18940.621187575896;19036.33372831944;19100;20790.1683932641;20908.581828363043;21056;21071.894640526698;21177.470563236042;18397.448076557725;18641.254349825856;18673.346432874783;18742.437726868215;18891.43325700231;17964.55088622795;18339.449816505527;18679.1594378256;18772.906135469235;18831.90584047071;17308.22113004943;17648.823511764716;18463.723044154616;18999.24003039863;19108.33120840764;14051.36768845425;14068.507602233873;14137.787933181216;14195.432182712575;14221.715565688835;13211;13377;13492.257925814174;14406.461964481574;14777.261136943325 11:27:47 INFO - PID 25150 | __end_tp_report 11:27:47 INFO - PID 25150 | __start_cc_report 11:27:47 INFO - PID 25150 | _x_x_mozilla_cycle_collect,360 11:27:47 INFO - PID 25150 | __end_cc_report 11:27:47 INFO - PID 25150 | __startTimestamp1502908067750__endTimestamp 11:27:47 INFO - PID 25150 | 11:27:47 INFO - PID 25150 | ------- Summary: start ------- 11:27:47 INFO - PID 25150 | Number of tests: 6 11:27:47 INFO - PID 25150 | 11:27:47 INFO - PID 25150 | [#0] dojo.html Cycles:165 Average:6086.82 Median:6360.68 stddev:717.61 (11.3%) stddev-sans-first:681.02 11:27:47 INFO - PID 25150 | Values: 3119.8 3122.7 3159.7 3161.1 3224.4 6021.6 6096.7 6156.4 6165.2 6259.5 6174.6 6205.0 6280.8 6296.5 6314.2 5649.7 5664.9 5692.1 5729.3 5780.6 5511.4 5576.0 5580.1 5666.2 5711.7 5604.0 5643.7 5690.8 5697.5 5711.5 5578.0 5632.8 5684.7 5691.9 5706.6 5442.6 5541.9 5558.0 5580.2 5627.4 6079.6 6086.5 6101.6 6109.6 6121.0 6556.5 6609.5 6614.3 6706.2 6711.1 6505.2 6535.1 6560.3 6715.3 6759.6 6074.9 6076.1 6095.1 6098.9 6156.6 6880.6 6882.3 6895.3 6905.7 6922.0 6447.9 6460.6 6545.4 6550.2 6551.7 6565.2 6580.6 6660.0 6695.5 6707.5 6413.8 6482.2 6508.7 6542.7 6582.1 6700.0 6713.0 6721.0 6721.5 6739.7 5383.2 5412.9 5452.3 5490.9 5515.5 4512.2 4595.9 4652.4 4682.9 4693.7 5638.6 5674.5 5719.7 5767.3 5803.5 6501.0 6513.5 6556.8 6557.0 6558.5 5497.8 5582.5 5659.1 5685.5 5711.5 5628.4 5684.8 5708.0 5777.4 5789.5 6302.7 6360.7 6393.0 6463.6 6544.7 6684.3 6688.0 6711.1 6711.7 6730.5 6426.5 6432.6 6452.9 6529.3 6531.7 6453.2 6462.2 6544.0 6558.3 6606.5 6500.4 6569.6 6596.4 6597.5 6619.5 6408.6 6446.6 6447.4 6472.8 6488.6 6361.3 6432.5 6451.6 6463.2 6524.2 6332.5 6426.2 6438.5 6448.0 6450.1 6422.6 6458.6 6523.2 6539.9 6588.1 6046.7 6157.9 6201.4 6218.4 6339.3 11:27:47 INFO - PID 25150 | 11:27:47 INFO - PID 25150 | [#1] ext.html Cycles:180 Average:38050.45 Median:34773.41 stddev:55102.14 (158.5%) stddev-sans-first:55185.73 11:27:47 INFO - PID 25150 | Values: 799.8 809.6 836.7 853.1 866.5 41160.0 41964.8 42069.8 42109.8 42149.0 38208.2 38573.4 38575.6 38620.4 38664.0 6732.4 6835.9 6836.0 6837.8 6850.1 6746.4 6761.8 6830.0 6837.1 6843.8 6779.1 6832.8 7421.9 7630.4 7649.2 7569.9 7625.2 7628.9 7637.1 7637.8 7590.6 7626.1 7679.6 7698.3 7713.2 39188.2 40127.8 40162.4 40175.8 40330.8 3547.4 3641.0 3641.5 3643.3 3646.0 32075.7 32199.5 32221.2 32257.5 32296.2 5123.8 5133.1 5156.7 5169.8 5207.5 184342.0 186741.0 187285.0 188207.0 188994.2 48055.0 48088.3 48320.5 48358.5 48615.8 50522.0 50525.0 50969.2 50996.0 51024.7 15424.2 15605.3 15663.4 15665.4 15792.8 12768.4 12773.0 12778.0 12782.7 12806.6 14666.2 14748.2 14763.0 14837.8 14995.9 5786.6 5927.3 5985.9 6025.2 6112.4 1004.2 1008.6 1017.8 1020.0 1021.5 22544.2 22621.8 22813.0 23171.0 29002.9 1084.9 1093.6 1105.8 1106.2 1110.3 12333.9 12465.1 12561.8 12617.9 12707.4 245081.0 248199.0 249250.0 249273.0 249650.0 45016.3 45582.5 54821.0 55182.7 55223.4 1455.8 1492.6 1492.7 1499.0 1501.4 26648.5 27016.5 27039.2 27621.0 27655.4 37207.6 37737.2 37781.8 37911.8 38010.4 195087.0 195258.0 197799.0 198321.0 198570.0 33091.3 33886.8 34087.9 34165.7 34279.3 43226.0 43291.4 43556.3 44007.0 44037.8 32089.2 32204.2 32473.8 32577.2 32864.5 31522.5 31553.8 31684.5 31993.5 32046.2 34670.8 34761.8 34910.1 35081.0 35461.6 30805.0 31321.2 32066.7 34049.0 34785.0 24611.6 24711.4 25370.7 25464.5 25584.5 11:27:47 INFO - PID 25150 | 11:27:47 INFO - PID 25150 | [#2] jquery.html Cycles:180 Average:36507.62 Median:23962.91 stddev:81496.86 (340.1%) stddev-sans-first:81680.80 11:27:47 INFO - PID 25150 | Values: 566.7 574.3 579.4 580.3 594.6 22436.0 23168.0 23290.0 23309.3 23343.4 25668.2 28247.9 28378.4 28458.4 28556.7 7081.1 7188.2 7260.6 7271.2 7291.1 6432.8 7089.4 7199.2 7275.4 7303.7 7020.6 7026.1 7080.6 7081.7 7098.5 7054.6 7057.2 7079.3 7082.2 7083.8 6882.0 6928.6 6951.9 6980.2 7002.0 31618.5 31680.8 32060.5 32243.8 32292.2 1869.2 1927.0 1929.1 1935.1 1938.7 20319.0 21024.6 21118.4 21192.8 21216.4 2530.8 2546.1 2548.6 2616.9 2629.7 144870.0 146700.0 147345.3 147889.0 148183.0 20677.0 21874.9 22414.9 22713.5 22756.2 42184.0 42420.0 42465.0 42734.8 42888.4 11812.7 11862.7 12027.9 12169.3 12290.8 9863.9 9924.8 9958.4 10032.7 10069.9 9061.9 9603.1 9771.1 11428.4 12218.6 2772.2 2810.9 2812.4 2813.6 2893.2 934.9 970.5 982.0 983.2 983.9 19618.5 23794.7 24628.4 25094.9 25179.9 1013.9 1014.2 1033.0 1044.7 1051.3 11412.7 11414.3 11544.3 11577.5 11602.8 462390.0 474823.0 480433.0 490353.0 496417.0 117507.0 119375.0 119385.4 119497.0 120193.0 1218.4 1247.1 1286.9 1290.2 1297.1 21311.7 21450.5 21527.1 21629.6 22183.2 58295.7 59221.7 60593.0 61193.7 61703.0 71666.0 74566.6 75891.0 77010.6 77285.6 12474.0 14319.4 14613.7 14829.9 14992.9 24131.2 24139.9 24176.9 24391.9 24618.9 18456.4 18662.5 18746.6 18848.6 18983.2 16610.5 17267.7 17350.2 17380.0 17558.5 18646.3 19491.9 19531.2 19618.5 19744.7 14946.6 14977.1 15026.9 15059.7 15116.5 18196.9 18303.2 18589.4 18628.4 18712.2 11:27:47 INFO - PID 25150 | 11:27:47 INFO - PID 25150 | [#3] mootools.html Cycles:180 Average:9005.84 Median:2652.62 stddev:6310.19 (237.9%) stddev-sans-first:6301.59 11:27:47 INFO - PID 25150 | Values: 1337.7 1388.5 1409.5 1412.2 1412.3 14000.1 14007.7 14839.8 14846.2 14867.9 14518.0 14968.5 15001.2 15023.4 15136.8 2735.9 2776.9 2777.6 2780.5 2785.9 2513.2 2641.1 2651.3 2692.7 2701.8 2702.0 2746.5 2749.5 2758.4 2765.4 2619.6 2653.9 2657.8 2663.1 2717.0 2564.3 2568.5 2568.8 2594.8 2596.0 14255.9 14536.3 14563.5 14590.5 14630.4 7448.6 7737.0 7744.3 7749.7 7764.8 4844.3 5010.1 5104.8 5154.9 5159.5 1833.0 1840.9 1917.0 2287.5 2397.3 24119.2 24819.3 24858.0 24973.1 24993.0 6575.4 6668.1 6773.8 6806.3 6914.2 18910.7 18922.3 18943.6 18956.3 19022.9 7698.5 7714.0 7743.5 7754.2 7756.6 6790.8 6843.3 6945.5 7041.9 7092.0 5500.3 5581.1 5591.1 5656.1 5691.1 1507.3 1543.9 1580.6 1681.4 1755.8 874.5 881.3 896.2 898.2 900.0 7960.2 8389.1 8426.4 8463.5 8504.9 943.9 958.4 961.8 965.7 985.8 4123.4 4176.9 4282.0 4339.4 5340.5 19109.0 19312.8 19525.5 20066.2 20223.3 19642.3 19789.4 19952.6 20078.2 20214.0 9341.6 9737.8 9831.8 10205.9 10280.9 8301.4 8435.0 8446.2 8592.5 8634.7 17335.6 17519.7 17611.5 17844.8 17870.4 17604.6 17712.9 17838.8 17932.2 18034.4 11876.9 11899.2 11948.1 11991.6 12188.6 12930.4 13260.2 13272.7 13273.9 13287.8 10588.9 11006.7 11024.1 11227.3 11461.5 10601.6 10831.9 10901.9 10995.7 11321.8 9095.7 9161.1 9198.1 9205.4 9207.0 6782.1 6833.8 6844.7 6916.5 7022.6 6870.9 6970.2 7088.6 7091.3 7125.4 11:27:47 INFO - PID 25150 | 11:27:47 INFO - PID 25150 | [#4] prototype.html Cycles:180 Average:5487.54 Median:6031.59 stddev:1510.19 (25.0%) stddev-sans-first:1467.34 11:27:47 INFO - PID 25150 | Values: 501.9 506.2 515.9 524.0 530.6 6050.3 6199.3 6207.1 6219.8 6244.0 6045.8 6055.8 6113.6 6152.0 6216.0 4916.7 4953.3 5011.2 5021.4 5027.3 4961.7 4970.3 5008.9 5009.4 5026.2 4732.9 4834.7 4889.8 4945.2 4976.2 4786.6 4834.7 4938.6 4940.1 4953.5 4361.5 4406.0 4444.9 4455.9 4479.9 5851.4 5906.8 5935.5 5948.7 5994.6 5623.2 5687.5 5747.7 5786.5 5800.2 6400.2 6443.5 6448.9 6499.4 6532.9 4809.7 4854.8 4861.5 4871.7 4913.2 6782.0 6850.9 6982.5 7001.0 7002.0 4977.1 4999.9 5037.4 5042.2 5066.3 5051.5 5070.8 5079.1 5094.9 5101.6 5677.4 5686.9 5717.4 5763.4 5776.3 6609.4 6657.8 6681.9 6684.6 6738.2 1671.7 1698.5 1783.4 1793.6 1795.9 1373.4 1420.2 1431.7 1452.5 1455.4 5571.7 5634.9 5669.4 5719.0 5737.6 6494.5 6512.8 6571.2 6639.1 6646.2 5646.8 5649.6 5694.3 5705.6 5715.1 3464.9 3516.8 3520.5 3532.8 3543.2 6423.2 6432.2 6432.5 6470.4 6490.5 6686.7 6762.9 6776.6 6780.6 6787.7 6418.2 6485.4 6498.9 6551.0 6567.0 6570.0 6585.6 6597.7 6630.9 6667.8 6375.3 6418.0 6522.9 6534.5 6581.6 6351.8 6366.9 6437.9 6477.5 6514.7 5492.5 5524.5 5532.2 5563.4 5575.2 6552.9 6601.9 6644.3 6705.5 6741.5 6329.8 6418.4 6428.0 6435.0 6474.1 6338.4 6354.2 6358.4 6466.5 6483.9 6017.4 6382.6 6454.4 6483.9 6507.3 6413.0 6489.8 6524.6 6622.1 6647.4 6261.6 6322.7 6377.8 6457.6 6496.8 11:27:47 INFO - PID 25150 | 11:27:47 INFO - PID 25150 | [#5] yui.html Cycles:180 Average:23476.93 Median:20849.38 stddev:31506.06 (151.1%) stddev-sans-first:31548.80 11:27:47 INFO - PID 25150 | Values: 890.4 901.6 921.2 926.4 932.9 18788.0 19364.6 19379.8 19403.8 21620.7 21226.5 21701.5 21728.1 21778.9 21793.5 1014.5 1055.0 1056.4 1057.1 1057.9 1059.0 1065.7 1066.6 1067.5 1068.8 788.8 819.7 828.6 1092.7 1127.7 1119.7 1124.2 1127.4 1127.7 1128.1 819.6 821.5 822.4 823.1 823.4 19838.8 19860.8 20193.1 20288.9 20516.4 20698.3 21652.0 21788.8 22110.3 22156.7 16533.1 17090.8 17211.4 17275.5 17291.2 3623.8 3633.4 3668.5 3682.9 3691.8 122909.0 126265.7 127993.4 130372.0 132681.0 17127.7 17571.5 17796.4 17859.6 17863.3 29953.4 30961.4 30970.4 31442.2 31577.4 7426.4 7777.9 7802.8 8502.0 8783.0 3987.5 4069.8 4078.8 4149.1 4170.7 5235.7 5237.8 5314.1 5316.0 5372.2 974.1 987.1 999.7 1003.5 1005.7 648.7 669.1 669.3 671.3 681.7 11200.8 12093.9 12346.2 13149.1 13290.3 696.1 698.6 706.6 713.3 725.6 5370.4 5670.8 5758.2 5840.0 6013.5 102390.0 107506.0 108585.5 109277.0 112275.4 90307.5 96277.5 96932.5 97299.5 101046.0 85734.6 86186.1 86291.6 87201.0 89239.6 12526.6 12974.7 13007.2 13031.2 13117.5 38087.0 38976.6 39348.6 39818.0 41007.8 51623.7 52650.9 54318.7 54340.7 55288.7 18528.5 18889.1 18940.6 19036.3 19100.0 20790.2 20908.6 21056.0 21071.9 21177.5 18397.4 18641.3 18673.3 18742.4 18891.4 17964.6 18339.4 18679.2 18772.9 18831.9 17308.2 17648.8 18463.7 18999.2 19108.3 14051.4 14068.5 14137.8 14195.4 14221.7 13211.0 13377.0 13492.3 14406.5 14777.3 11:27:47 INFO - PID 25150 | -------- Summary: end -------- 11:27:47 INFO - PID 25150 | 11:27:48 INFO - TEST-INFO | 25150: exit 0 11:27:48 INFO - TEST-OK | dromaeo_css | took 1116273ms 11:27:48 INFO - TEST-START | kraken 11:27:48 INFO - Initialising browser for kraken test... 11:27:48 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:46512/getInfo.html -profile /tmp/tmpQmCOhM/profile 11:27:48 INFO - TEST-INFO | started process 25534 (/builds/slave/test/build/application/firefox/firefox http://localhost:46512/getInfo.html) 11:27:55 INFO - TEST-INFO | 25534: exit 0 11:27:55 INFO - Browser initialized. 11:27:55 INFO - Running cycle 1/1 for kraken test... 11:27:55 INFO - TEST-INFO | started process 25755 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpQmCOhM/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 11:27:56 INFO - PID 25755 | WebRender - OpenGL version new 3.2.0 NVIDIA 361.42 11:27:56 INFO - PID 25755 | WebRender - OpenGL version new 3.2.0 NVIDIA 361.42 11:27:56 INFO - PID 25755 | 11:27:56 INFO - PID 25755 | (/builds/slave/test/build/application/firefox/firefox:25813): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 11:27:56 INFO - PID 25755 | 11:28:07 INFO - PID 25755 | RSS: Main: 195227648 11:28:07 INFO - PID 25755 | 11:28:09 INFO - PID 25755 | Cycle 1(1): loaded http://localhost:46512/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:46512/tests/kraken/driver.html?testName=audio-beat-detection) 11:28:10 INFO - PID 25755 | RSS: Main: 204914688 11:28:10 INFO - PID 25755 | 11:28:11 INFO - PID 25755 | WebRender - OpenGL version new 3.2.0 NVIDIA 361.42 11:28:13 INFO - PID 25755 | Cycle 1(1): loaded http://localhost:46512/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:46512/tests/kraken/driver.html?testName=audio-dft) 11:28:14 INFO - PID 25755 | RSS: Main: 211378176 11:28:14 INFO - PID 25755 | 11:28:17 INFO - PID 25755 | Cycle 1(1): loaded http://localhost:46512/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:46512/tests/kraken/driver.html?testName=audio-fft) 11:28:17 INFO - PID 25755 | RSS: Main: 204197888 11:28:17 INFO - PID 25755 | 11:28:20 INFO - PID 25755 | Cycle 1(1): loaded http://localhost:46512/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:46512/tests/kraken/driver.html?testName=audio-oscillator) 11:28:20 INFO - PID 25755 | RSS: Main: 205844480 11:28:20 INFO - PID 25755 | 11:28:22 INFO - PID 25755 | Cycle 1(1): loaded http://localhost:46512/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:46512/tests/kraken/driver.html?testName=imaging-gaussian-blur) 11:28:23 INFO - PID 25755 | RSS: Main: 218497024 11:28:23 INFO - PID 25755 | 11:28:26 INFO - PID 25755 | Cycle 1(1): loaded http://localhost:46512/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:46512/tests/kraken/driver.html?testName=imaging-darkroom) 11:28:27 INFO - PID 25755 | RSS: Main: 220524544 11:28:27 INFO - PID 25755 | 11:28:30 INFO - PID 25755 | Cycle 1(1): loaded http://localhost:46512/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:46512/tests/kraken/driver.html?testName=imaging-desaturate) 11:28:31 INFO - PID 25755 | RSS: Main: 219500544 11:28:31 INFO - PID 25755 | 11:28:34 INFO - PID 25755 | Cycle 1(1): loaded http://localhost:46512/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:46512/tests/kraken/driver.html?testName=json-parse-financial) 11:28:35 INFO - PID 25755 | RSS: Main: 220143616 11:28:35 INFO - PID 25755 | 11:28:36 INFO - PID 25755 | Cycle 1(1): loaded http://localhost:46512/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:46512/tests/kraken/driver.html?testName=json-stringify-tinderbox) 11:28:37 INFO - PID 25755 | RSS: Main: 219811840 11:28:37 INFO - PID 25755 | 11:28:39 INFO - PID 25755 | Cycle 1(1): loaded http://localhost:46512/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:46512/tests/kraken/driver.html?testName=stanford-crypto-aes) 11:28:39 INFO - PID 25755 | RSS: Main: 219398144 11:28:39 INFO - PID 25755 | 11:28:42 INFO - PID 25755 | Cycle 1(1): loaded http://localhost:46512/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:46512/tests/kraken/driver.html?testName=stanford-crypto-ccm) 11:28:42 INFO - PID 25755 | RSS: Main: 220651520 11:28:42 INFO - PID 25755 | 11:28:45 INFO - PID 25755 | Cycle 1(1): loaded http://localhost:46512/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:46512/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 11:28:46 INFO - PID 25755 | RSS: Main: 221233152 11:28:46 INFO - PID 25755 | 11:28:49 INFO - PID 25755 | Cycle 1(1): loaded http://localhost:46512/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:46512/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 11:28:49 INFO - PID 25755 | RSS: Main: 219668480 11:28:49 INFO - PID 25755 | 11:28:51 INFO - PID 25755 | Cycle 1(1): loaded http://localhost:46512/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:46512/tests/kraken/driver.html?testName=ai-astar) 11:28:52 INFO - PID 25755 | RSS: Main: 220839936 11:28:52 INFO - PID 25755 | 11:28:52 INFO - PID 25755 | __start_tp_report 11:28:52 INFO - PID 25755 | _x_x_mozilla_page_load 11:28:52 INFO - PID 25755 | _x_x_mozilla_page_load_details 11:28:52 INFO - PID 25755 | |i|pagename|runs| 11:28:52 INFO - PID 25755 | |0;ai-astar;104;113;101;118;114;114;110;101;117;109 11:28:52 INFO - PID 25755 | |1;audio-beat-detection;147;125;159;189;126;144;148;119;170;120 11:28:52 INFO - PID 25755 | |2;audio-dft;173;162;175;167;163;165;169;164;163;170 11:28:52 INFO - PID 25755 | |3;audio-fft;79;74;76;172;83;79;84;94;98;80 11:28:52 INFO - PID 25755 | |4;audio-oscillator;84;83;130;80;81;81;132;79;81;132 11:28:52 INFO - PID 25755 | |5;imaging-gaussian-blur;121;114;125;123;117;121;124;114;116;125 11:28:52 INFO - PID 25755 | |6;imaging-darkroom;150;156;158;151;158;151;152;159;157;159 11:28:52 INFO - PID 25755 | |7;imaging-desaturate;95;100;95;100;94;94;99;107;95;97 11:28:52 INFO - PID 25755 | |8;json-parse-financial;58;54;66;53;54;54;58;55;54;54 11:28:52 INFO - PID 25755 | |9;json-stringify-tinderbox;60;60;59;56;54;55;65;59;54;54 11:28:52 INFO - PID 25755 | |10;stanford-crypto-aes;75;77;82;79;75;77;83;80;83;80 11:28:52 INFO - PID 25755 | |11;stanford-crypto-ccm;143;125;134;127;122;134;125;131;137;162 11:28:52 INFO - PID 25755 | |12;stanford-crypto-pbkdf2;193;190;179;178;174;178;179;198;190;178 11:28:52 INFO - PID 25755 | |13;stanford-crypto-sha256-iterative;69;69;70;69;68;68;67;71;69;69 11:28:52 INFO - PID 25755 | __end_tp_report 11:28:52 INFO - PID 25755 | __start_cc_report 11:28:52 INFO - PID 25755 | _x_x_mozilla_cycle_collect,969 11:28:52 INFO - PID 25755 | __end_cc_report 11:28:52 INFO - PID 25755 | __startTimestamp1502908132057__endTimestamp 11:28:52 INFO - PID 25755 | 11:28:52 INFO - PID 25755 | ------- Summary: start ------- 11:28:52 INFO - PID 25755 | Number of tests: 14 11:28:52 INFO - PID 25755 | 11:28:52 INFO - PID 25755 | [#0] ai-astar Cycles:10 Average:110.10 Median:113.50 stddev:6.26 (5.5%) stddev-sans-first:6.24 11:28:52 INFO - PID 25755 | Values: 104.0 113.0 101.0 118.0 114.0 114.0 110.0 101.0 117.0 109.0 11:28:52 INFO - PID 25755 | 11:28:52 INFO - PID 25755 | [#1] audio-beat-detection Cycles:10 Average:144.70 Median:147.50 stddev:23.17 (15.7%) stddev-sans-first:24.56 11:28:52 INFO - PID 25755 | Values: 147.0 125.0 159.0 189.0 126.0 144.0 148.0 119.0 170.0 120.0 11:28:52 INFO - PID 25755 | 11:28:52 INFO - PID 25755 | [#2] audio-dft Cycles:10 Average:167.10 Median:168.00 stddev:4.51 (2.7%) stddev-sans-first:4.25 11:28:52 INFO - PID 25755 | Values: 173.0 162.0 175.0 167.0 163.0 165.0 169.0 164.0 163.0 170.0 11:28:52 INFO - PID 25755 | 11:28:52 INFO - PID 25755 | [#3] audio-fft Cycles:10 Average:91.90 Median:81.50 stddev:29.15 (35.8%) stddev-sans-first:30.54 11:28:52 INFO - PID 25755 | Values: 79.0 74.0 76.0 172.0 83.0 79.0 84.0 94.0 98.0 80.0 11:28:52 INFO - PID 25755 | 11:28:52 INFO - PID 25755 | [#4] audio-oscillator Cycles:10 Average:96.30 Median:81.00 stddev:24.22 (29.9%) stddev-sans-first:25.28 11:28:52 INFO - PID 25755 | Values: 84.0 83.0 130.0 80.0 81.0 81.0 132.0 79.0 81.0 132.0 11:28:52 INFO - PID 25755 | 11:28:52 INFO - PID 25755 | [#5] imaging-gaussian-blur Cycles:10 Average:120.00 Median:122.00 stddev:4.40 (3.6%) stddev-sans-first:4.65 11:28:52 INFO - PID 25755 | Values: 121.0 114.0 125.0 123.0 117.0 121.0 124.0 114.0 116.0 125.0 11:28:52 INFO - PID 25755 | 11:28:52 INFO - PID 25755 | [#6] imaging-darkroom Cycles:10 Average:155.10 Median:157.50 stddev:3.67 (2.3%) stddev-sans-first:3.39 11:28:52 INFO - PID 25755 | Values: 150.0 156.0 158.0 151.0 158.0 151.0 152.0 159.0 157.0 159.0 11:28:52 INFO - PID 25755 | 11:28:52 INFO - PID 25755 | [#7] imaging-desaturate Cycles:10 Average:97.60 Median:95.00 stddev:4.06 (4.3%) stddev-sans-first:4.20 11:28:52 INFO - PID 25755 | Values: 95.0 100.0 95.0 100.0 94.0 94.0 99.0 107.0 95.0 97.0 11:28:52 INFO - PID 25755 | 11:28:52 INFO - PID 25755 | [#8] json-parse-financial Cycles:10 Average:56.00 Median:54.50 stddev:3.92 (7.2%) stddev-sans-first:4.09 11:28:52 INFO - PID 25755 | Values: 58.0 54.0 66.0 53.0 54.0 54.0 58.0 55.0 54.0 54.0 11:28:52 INFO - PID 25755 | 11:28:52 INFO - PID 25755 | [#9] json-stringify-tinderbox Cycles:10 Average:57.60 Median:59.00 stddev:3.63 (6.1%) stddev-sans-first:3.74 11:28:52 INFO - PID 25755 | Values: 60.0 60.0 59.0 56.0 54.0 55.0 65.0 59.0 54.0 54.0 11:28:52 INFO - PID 25755 | 11:28:52 INFO - PID 25755 | [#10] stanford-crypto-aes Cycles:10 Average:79.10 Median:80.00 stddev:3.03 (3.8%) stddev-sans-first:2.83 11:28:52 INFO - PID 25755 | Values: 75.0 77.0 82.0 79.0 75.0 77.0 83.0 80.0 83.0 80.0 11:28:52 INFO - PID 25755 | 11:28:52 INFO - PID 25755 | [#11] stanford-crypto-ccm Cycles:10 Average:134.00 Median:134.00 stddev:11.73 (8.8%) stddev-sans-first:11.98 11:28:52 INFO - PID 25755 | Values: 143.0 125.0 134.0 127.0 122.0 134.0 125.0 131.0 137.0 162.0 11:28:52 INFO - PID 25755 | 11:28:52 INFO - PID 25755 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:183.70 Median:184.50 stddev:8.21 (4.4%) stddev-sans-first:7.98 11:28:52 INFO - PID 25755 | Values: 193.0 190.0 179.0 178.0 174.0 178.0 179.0 198.0 190.0 178.0 11:28:52 INFO - PID 25755 | 11:28:52 INFO - PID 25755 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.90 Median:69.00 stddev:1.10 (1.6%) stddev-sans-first:1.17 11:28:52 INFO - PID 25755 | Values: 69.0 69.0 70.0 69.0 68.0 68.0 67.0 71.0 69.0 69.0 11:28:52 INFO - PID 25755 | -------- Summary: end -------- 11:28:52 INFO - PID 25755 | 11:28:52 INFO - PID 25755 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 11:28:53 INFO - TEST-INFO | 25755: exit 0 11:28:53 INFO - TEST-OK | kraken | took 64307ms 11:28:53 INFO - SUITE-END | took 1180s 11:28:53 INFO - Completed test suite (00:19:40) 11:28:53 INFO - javascript benchmark 11:28:53 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8615.947101971195, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3119.750419966403, 3122.6721194274587, 3159.652438231794, 3161.0990867602736, 3224.435723748345, 6021.578489505737, 6096.6951652417365, 6156.384361563847, 6165.198524191849, 6259.499240060795, 6174.567780255384, 6204.96897515513, 6280.811575652726, 6296.527760417964, 6314.210723659543, 5649.745761440725, 5664.8867022659415, 5692.0608099663505, 5729.341125770548, 5780.5664575156825, 5511.448855114497, 5576.0, 5580.051391263474, 5666.206731057655, 5711.742971566289, 5604.047311956957, 5643.661380317174, 5690.772369105231, 5697.544196464293, 5711.514521265697, 5578.0, 5632.802851900164, 5684.658920464785, 5691.886162276773, 5706.600537962303, 5442.6462279952075, 5541.9168712469345, 5558.0, 5580.1629755537, 5627.43725627434, 6079.574429789916, 6086.513078953673, 6101.572889897709, 6109.5723299369065, 6120.96939515304, 6556.508261880378, 6609.471242300652, 6614.272430032693, 6706.195256569243, 6711.094002309675, 6505.186851643544, 6535.0850880876715, 6560.278369379364, 6715.2613212546585, 6759.628220447873, 6074.8785024299705, 6076.149339092531, 6095.146679464879, 6098.939010609882, 6156.569040167235, 6880.552764070319, 6882.311768823178, 6895.310468953065, 6905.689243984033, 6922.0, 6447.903281450782, 6460.644664543402, 6545.37818907203, 6550.213974323112, 6551.672416379162, 6565.212174539086, 6580.5722628029025, 6660.034295027291, 6695.46436285096, 6707.463402927754, 6413.839654008687, 6482.157319548429, 6508.707108180143, 6542.705578248991, 6582.111414959015, 6699.9665001674675, 6713.0, 6721.025451309532, 6721.462283017347, 6739.730410783612, 5383.192521121863, 5412.864678383072, 5452.291202143696, 5490.890182196334, 5515.503604675599, 4512.2329204035395, 4595.862124136282, 4652.418447694038, 4682.906341873211, 4693.718376897329, 5638.633488823295, 5674.4892959633835, 5719.7140142992685, 5767.250257466587, 5803.5357171426185, 6501.0, 6513.54405191632, 6556.770513032021, 6556.967215163893, 6558.524332025351, 5497.8075767347955, 5582.525485333792, 5659.122835960433, 5685.459881311269, 5711.457411545896, 5628.380878103405, 5684.8294551163535, 5707.971460142673, 5777.364489906107, 5789.478946894799, 6302.716377763011, 6360.681965901686, 6392.968035159794, 6463.5798673085155, 6544.705488252945, 6684.264730879502, 6688.0, 6711.060451536887, 6711.731530738716, 6730.495212859153, 6426.518011149089, 6432.614043157426, 6452.935470645421, 6529.347065293623, 6531.706073226621, 6453.193350831146, 6462.192225971754, 6544.0, 6558.344165583403, 6606.471482281502, 6500.382463665944, 6569.638669873203, 6596.406323430914, 6597.472202223907, 6619.50353723463, 6408.58344207625, 6446.645434501147, 6447.4197322241225, 6472.834889719896, 6488.578242414228, 6361.300256971637, 6432.549721519449, 6451.580647257913, 6463.15978922737, 6524.217093948757, 6332.525060620564, 6426.228852537725, 6438.549301549034, 6448.032795080775, 6450.129232553545, 6422.550421470639, 6458.580192287674, 6523.24982626985, 6539.901901471577, 6588.110605068255, 6046.697665116814, 6157.907631385622, 6201.441870231701, 6218.440340369389, 6339.334369891095], "value": 6033.614737370335, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [799.7760627024435, 809.5911564659846, 836.7071524966261, 853.0871966995318, 866.4714524140273, 41160.0, 41964.790176049115, 42069.789651051775, 42109.78945105274, 42149.0, 38208.235835283274, 38573.42139867904, 38575.614243857555, 38620.420693689615, 38664.03339916503, 6732.394084532391, 6835.897461538081, 6836.0, 6837.829054273658, 6850.109485766869, 6746.392824645781, 6761.8309542261595, 6829.965850170742, 6837.076994605714, 6843.760468383608, 6779.084823548807, 6832.760853370133, 7421.851562968737, 7630.351420129296, 7649.235076492334, 7569.924300756977, 7625.199354067799, 7628.923710762904, 7637.083549974039, 7637.809054773619, 7590.620468976585, 7626.084869815602, 7679.6160191990175, 7698.268664476922, 7713.190115037953, 39188.21623567513, 40127.79936100301, 40162.39756403656, 40175.79912100421, 40330.79834600838, 3547.3614749345106, 3640.9635903640888, 3641.453781932731, 3643.344198044351, 3646.0, 32075.6792432075, 32199.51700724491, 32221.194470138198, 32257.51613725796, 32296.19259518507, 5123.769430375642, 5133.101707201225, 5156.690598564061, 5169.81905633301, 5207.531322180984, 184342.0, 186741.0, 187285.0, 188206.99999999863, 188994.2201155983, 48055.0, 48088.27867581989, 48320.51679483231, 48358.5164148354, 48615.756921215165, 50522.0, 50525.0, 50969.23546146811, 50996.0, 51024.74487627538, 15424.228788560527, 15605.297761600756, 15663.373465061497, 15665.37338506447, 15792.763108553381, 12768.425420856083, 12773.0, 12778.0, 12782.744345113046, 12806.551770687982, 14666.193359365125, 14748.18884961316, 14763.0, 14837.777433338508, 14995.850041499445, 5786.623869448473, 5927.347991720907, 5985.850353741192, 6025.216721826135, 6112.449879510866, 1004.2417974429259, 1008.5562352564848, 1017.8167929772712, 1019.9949000254951, 1021.545412291538, 22544.21095261658, 22621.773782261967, 22813.0, 23170.957306921227, 29002.85498572536, 1084.9186311026704, 1093.6336327330275, 1105.7711482471204, 1106.1593189176283, 1110.3448965110463, 12333.876661233453, 12465.065120116027, 12561.811572826415, 12617.873821261854, 12707.428165732565, 245081.0, 248199.0, 249250.0, 249273.0, 249650.0, 45016.3247551287, 45582.54417455783, 54821.0, 55182.72408638011, 55223.44776552264, 1455.82530096387, 1492.6268432891777, 1492.6716122453042, 1498.9700205995819, 1501.3544176004204, 26648.467030659667, 27016.45967080608, 27039.188824335302, 27621.0, 27655.446891061663, 37207.627923720414, 37737.245255095295, 37781.81109094437, 37911.81044094762, 38010.42984355292, 195087.0, 195258.0, 197799.0, 198321.0, 198570.0, 33091.33817323688, 33886.81396151123, 34087.93208611237, 34165.658343416246, 34279.28603569861, 43226.0, 43291.35062974121, 43556.34665480084, 44007.0, 44037.779811100736, 32089.197770055, 32204.19489512781, 32473.837630811693, 32577.185570359983, 32864.50703239405, 31522.527162092127, 31553.842230789618, 31684.5247321295, 31993.520097198096, 32046.19884502906, 34670.82664586661, 34761.82619086889, 34910.12724681903, 35081.0, 35461.645383546864, 30805.0, 31321.216969575944, 32066.679333206368, 34049.0, 34785.0, 24611.63082553727, 24711.38221544476, 25370.746292537577, 25464.490710186063, 25584.488310234065], "value": 17183.188316358395, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [566.6996491859315, 574.3050908400835, 579.3540202674017, 580.2630659062987, 594.5719082260772, 22436.0, 23168.0, 23290.0, 23309.300720978375, 23343.416414589603, 25668.22995310139, 28247.858760706167, 28378.43243135136, 28458.43083138341, 28556.714432855664, 7081.114860642419, 7188.245234250407, 7260.636968151598, 7271.200167981518, 7291.08861392326, 6432.77485288015, 7089.432845372384, 7199.244079371669, 7275.4179665626625, 7303.671334789948, 7020.613866237355, 7026.1217347831525, 7080.575165490087, 7081.716731330766, 7098.467614928875, 7054.6472676365975, 7057.223705392403, 7079.327463890948, 7082.185548661892, 7083.7520686775715, 6881.965590172067, 6928.61892595907, 6951.860962780716, 6980.16238051432, 7002.0, 31618.525722114187, 31680.841595791873, 32060.519092213635, 32243.83878080618, 32292.192695182574, 1869.1869036968826, 1927.0364817591205, 1929.1415320182525, 1935.1098494692458, 1938.6995015772577, 20319.0, 21024.5795084099, 21118.3664490064, 21192.788072119234, 21216.36350909475, 2530.835495692774, 2546.1088618983395, 2548.5922252439523, 2616.947661046768, 2629.737026297374, 144870.0, 146700.0, 147345.26327368402, 147889.0, 148183.0, 20676.966151692355, 21874.89062554709, 22414.887925560593, 22713.545729085326, 22756.20353287627, 42184.0, 42420.0, 42465.0, 42734.786326068795, 42888.356674649905, 11812.704682382837, 11862.703432414259, 12027.879721202851, 12169.33068681231, 12290.815637765441, 9863.852042219372, 9924.801503970024, 9958.402495850272, 10032.749181270381, 10069.949650251701, 9061.864072038925, 9603.127390158992, 9771.12059914611, 11428.428578571038, 12218.572349967708, 2772.1683494951435, 2810.9297267568472, 2812.381276119291, 2813.592029155802, 2893.1899068260923, 934.9158575728217, 970.5455340983717, 981.9754506137403, 983.2085171437062, 983.852422136671, 19618.50953726168, 23794.663521120423, 24628.384290392885, 25094.874525627256, 25179.874100629746, 1013.9315795776533, 1014.1734486393566, 1032.9535170917327, 1044.6589203534625, 1051.2746205118444, 11412.714682133013, 11414.315141091562, 11544.307341559364, 11577.536898523964, 11602.825957610643, 462390.0, 474823.0, 480433.0, 490353.0, 496417.0, 117507.0, 119375.0, 119385.40307298582, 119497.0, 120193.0, 1218.3968935377045, 1247.1457051919283, 1286.9034822388357, 1290.2323117744738, 1297.1244410023196, 21311.680324795452, 21450.463738406666, 21527.138914443247, 21629.567408652052, 22183.223587174372, 58295.70852145712, 59221.70389148027, 60593.0, 61193.69403152956, 61703.0, 71666.0, 74566.62716686382, 75891.0, 77010.6149469249, 77285.61357193178, 12474.0, 14319.35562899693, 14613.707725845636, 14829.925850370679, 14992.850071499146, 24131.155409560582, 24139.879300603385, 24176.879115604308, 24391.878040609685, 24618.876905615358, 18456.446306610822, 18662.53343666419, 18746.625067498848, 18848.58635602363, 18983.24067037303, 16610.50168494947, 17267.740983885502, 17350.219240134476, 17380.0, 17558.473245802645, 18646.34737784171, 19491.902540487208, 19531.21875124979, 19618.50953726111, 19744.703829442857, 14946.626334341294, 14977.127859017623, 15026.948113631941, 15059.6988060236, 15116.54650360491, 18196.90901545484, 18303.176357063698, 18589.44231673052, 18628.441146765617, 18712.15795289188], "value": 12996.078243649223, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1337.7057047449562, 1388.4585011845381, 1409.5418988828633, 1412.1527083749759, 1412.2515067014485, 14000.089994150374, 14007.719845603082, 14839.777403338945, 14846.1834599097, 14867.851321486782, 14518.0, 14968.476103336385, 15001.174935378549, 15023.399064037425, 15136.848631513682, 2735.9042433514833, 2776.8889244430197, 2777.597248398981, 2780.527310357234, 2785.8885644574193, 2513.170653684289, 2641.102025311394, 2651.297406187362, 2692.67687877455, 2701.8243814152115, 2701.986490067547, 2746.533089374801, 2749.5325794614964, 2758.4483103379303, 2765.35014271646, 2619.5546757051156, 2653.9469210615775, 2657.7873770098345, 2663.1211700139006, 2717.0490328385104, 2564.2948189248104, 2568.460623269116, 2568.7816535594498, 2594.8313359631566, 2595.9870200649066, 14255.928720356436, 14536.345864436125, 14563.49027784033, 14590.489332873405, 14630.41478340865, 7448.627568621548, 7736.961315193388, 7744.303012728881, 7749.728759493447, 7764.805879852993, 4844.2975768513725, 5010.123228435045, 5104.795808167669, 5154.896902061975, 5159.535641792219, 1832.9541761455937, 1840.8619353548538, 1917.04147926037, 2287.49675071484, 2397.3167647220457, 24119.155829546056, 24819.25542233736, 24858.0, 24973.125940592174, 24993.0, 6575.375339342755, 6668.099806526154, 6773.762918297836, 6806.319368063253, 6914.1702995639835, 18910.716339254923, 18922.3377181798, 18943.621127577648, 18956.33652822172, 19022.904885475484, 7698.538087714755, 7714.035745531809, 7743.5353878767455, 7754.18581048993, 7756.612169391507, 6790.762323318759, 6843.349881761224, 6945.548539344926, 7041.894371584431, 7092.0, 5500.339959204921, 5581.134924086773, 5591.133374326986, 5656.123300888369, 5691.089425691952, 1507.2539093148962, 1543.8996465229725, 1580.5653445302403, 1681.3598559119614, 1755.833195846418, 874.4927941793871, 881.3081730841259, 896.2292428511475, 898.1781669772216, 900.0414558495313, 7960.164182760726, 8389.07720150783, 8426.41015128935, 8463.53450560225, 8504.914950850536, 943.9386439881386, 958.3770549143113, 961.7547525380983, 965.652365148546, 985.8077674853334, 4123.4021066945725, 4176.916461670749, 4281.957180428218, 4339.370791235253, 5340.49265319794, 19109.0, 19312.8068719311, 19525.51186220356, 20066.19735210575, 20223.29218477346, 19642.312519061765, 19789.406317810488, 19952.60094798125, 20078.19687212495, 20214.0, 9341.579628916716, 9737.805243895224, 9831.803363932539, 10205.948970255102, 10280.948595257125, 8301.418900677136, 8435.0, 8446.155384461505, 8592.484450932963, 8634.654613815377, 17335.56661083483, 17519.737203941695, 17611.471655849833, 17844.821551784837, 17870.374536891148, 17604.55988600244, 17712.91143544274, 17838.821611783715, 17932.193051312985, 18034.36879709204, 11876.881231187577, 11899.226550274205, 11948.103892207946, 11991.580294689644, 12188.634340969786, 12930.418131183931, 13260.204387736767, 13272.668183295495, 13273.933630331787, 13287.80068298957, 10588.894111059099, 11006.669799906016, 11024.118070554176, 11227.27022743519, 11461.541538338706, 10601.575936962436, 10831.945840270748, 10901.890981090088, 10995.670129896116, 11321.830172547254, 9095.681651142178, 9161.129692679186, 9198.080191980749, 9205.401648892801, 9207.033261507713, 6782.050512928293, 6833.829154271183, 6844.691988860413, 6916.515843890879, 7022.613756243456, 6870.931290687029, 6970.23327433992, 7088.645567721696, 7091.326323999212, 7125.35871771543], "value": 6521.545332627657, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [501.9384002834007, 506.16262965435476, 515.8736109653134, 523.9790408383665, 530.6020484636523, 6050.2739671239515, 6199.256089269288, 6207.09997050428, 6219.782307619234, 6244.0, 6045.758169673208, 6055.757769689207, 6113.572049956505, 6151.969240153804, 6215.968920155404, 4916.655834091615, 4953.306537084793, 5011.2483127530795, 5021.422536408305, 5027.2710456983805, 4961.727105009223, 4970.254461830737, 5008.865912439742, 5009.44896061433, 5026.2209357549455, 4732.893862231308, 4834.734089625069, 4889.755512224392, 4945.159322915113, 4976.203807390818, 4786.64100192487, 4834.709917404967, 4938.580220681247, 4940.1107800596055, 4953.455119936804, 4361.476622805252, 4405.977970110129, 4444.933216028162, 4455.933161002587, 4479.932801007987, 5851.444112809277, 5906.793262235801, 5935.49548288396, 5948.702564871739, 5994.610350327215, 5623.184638227475, 5687.516561092312, 5747.683877386742, 5786.524436268766, 5800.24596802413, 6400.231972163324, 6443.48452123829, 6448.93551064488, 6499.415052645285, 6532.949571265798, 4809.663323567317, 4854.757262136879, 4861.513848615145, 4871.707697538123, 4913.164761990471, 6781.966090169567, 6850.862982740367, 6982.511224214307, 7000.9649951750935, 7002.0, 4977.054359671651, 4999.900001999939, 5037.420696619935, 5042.218456139304, 5066.265391518209, 5051.4695956924725, 5070.771815268322, 5079.1365467870555, 5094.923576146361, 5101.591872650179, 5677.432256774372, 5686.857828554236, 5717.3996730342715, 5763.366029736726, 5776.335721392094, 6609.372109649672, 6657.833554161088, 6681.899771503431, 6684.565503242274, 6738.157730283715, 1671.6656668666315, 1698.507432844486, 1783.4114742135064, 1793.64127174563, 1795.8922464652162, 1373.4300265389752, 1420.1975883625719, 1431.7279716853764, 1452.5061479096946, 1455.3669153918079, 5571.693556854412, 5634.915081419901, 5669.40471250521, 5718.971405142947, 5737.569682273846, 6494.480441564663, 6512.837179070561, 6571.178602674666, 6639.070530125786, 6646.2356828965285, 5646.802361917313, 5649.604527683105, 5694.345150307685, 5705.636701500576, 5715.142728590661, 3464.9258729793846, 3516.7538272321203, 3520.4895290183294, 3532.788032718045, 3543.2027793746715, 6423.164988551458, 6432.198984284408, 6432.549721519449, 6470.38531339522, 6490.545661803723, 6686.699098540577, 6762.898556521656, 6776.593404395752, 6780.627065511444, 6787.694553745093, 6418.1656384669695, 6485.4487368573255, 6498.935010649928, 6550.967245163934, 6567.014947757683, 6570.0, 6585.5719378240265, 6597.670116494252, 6630.9336906630315, 6667.799966001027, 6375.330590287953, 6417.96791016042, 6522.869542609026, 6534.509911756732, 6581.572197807127, 6351.777687780906, 6366.9044964326495, 6437.871242575028, 6477.546571740121, 6514.706838192198, 5492.5444757140185, 5524.458748975356, 5532.2254884317035, 5563.443655634404, 5575.163725441216, 6552.901706474502, 6601.9009714853355, 6644.269130395749, 6705.497087718343, 6741.52809303344, 6329.778457753957, 6418.422341989243, 6427.967860160857, 6434.967825160844, 6474.125992990886, 6338.397852204033, 6354.17395738551, 6358.364163583605, 6466.482681385572, 6483.870322593616, 6017.428344307284, 6382.6170429774365, 6454.419102280817, 6483.870322593616, 6507.28419873823, 6413.0, 6489.805305840832, 6524.608523488606, 6622.145799176238, 6647.368499992686, 6261.5616906816085, 6322.747090116528, 6377.808665740035, 6457.612543247233, 6496.7726129585235], "value": 5055.253847409449, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [890.3989806880355, 901.6078006067357, 921.2169655792572, 926.3561824531953, 932.8600709893517, 18788.0, 19364.612707745837, 19379.806201937976, 19403.805961940376, 21620.675689864664, 21226.469338266514, 21701.45746356342, 21728.13087476503, 21778.89110554449, 21793.455163620878, 1014.523174108168, 1055.0399136785488, 1056.3556230699305, 1057.1278695076553, 1057.9418132002736, 1059.041567381517, 1065.7229120428667, 1066.648006157966, 1067.5356220044266, 1068.7648717282225, 788.7949133225374, 819.6885183630212, 828.5567221536479, 1092.6558134187705, 1127.689885281546, 1119.6641007697658, 1124.1849658997244, 1127.3517727306833, 1127.7011591928147, 1128.0975219824109, 819.6147810529042, 821.4578378270372, 822.3544517553752, 823.1398188892562, 823.3618945317367, 19838.80161198384, 19860.80139198604, 20193.091310890897, 20288.898555507127, 20516.38450846477, 20698.275560355316, 21652.0, 21788.782112178833, 22110.33668989933, 22156.667649985262, 16533.090680012596, 17090.82909170905, 17211.397601083903, 17275.481735547954, 17291.221895014627, 3623.8188090595363, 3633.418653015531, 3668.5414323209598, 3682.852685892588, 3691.833867475943, 122909.0, 126265.73734262632, 127993.36003319923, 130372.0, 132681.0, 17127.657446850993, 17571.472855814347, 17796.3771268005, 17859.553511162067, 17863.285468581373, 29953.400931981676, 30961.380772384877, 30970.380592388025, 31442.21394465157, 31577.368452630817, 7426.368758655467, 7777.922220777833, 7802.765917022499, 8501.957490212633, 8782.956085219534, 3987.501562304712, 4069.7558146511305, 4078.7756673382655, 4149.066460046526, 4170.72890262132, 5235.712035837989, 5237.816676416307, 5314.096603577401, 5315.973420132875, 5372.221027950925, 974.0697633759743, 987.1263931420744, 999.7350702063959, 1003.4731765823001, 1005.6982905128432, 648.7015972652538, 669.0833558025536, 669.327326037339, 671.3152584363921, 681.6693903456819, 11200.831987520194, 12093.939530302292, 12346.197497162655, 13149.145305555108, 13290.3354832258, 696.1437431958719, 698.5599072584341, 706.5689929143218, 713.3365969648173, 725.6408078001317, 5370.409254981949, 5670.837478316935, 5758.165066065397, 5840.036393995028, 6013.45878870895, 102390.0, 107506.0, 108585.45707271413, 109277.0, 112275.438622808, 90307.54846225858, 96277.5186124065, 96932.51533742427, 97299.51350243203, 101046.0, 85734.57132714297, 86186.13813861906, 86291.56854215689, 87201.0, 89239.55380223187, 12526.624201273977, 12974.675633109247, 13007.219566826021, 13031.152975056591, 13117.475300987853, 38087.0, 38976.610233898435, 39348.606513935636, 39818.0, 41007.79496102501, 51623.741881290356, 52650.94698106093, 54318.728406359296, 54340.72829635826, 55288.72355638357, 18528.536786579905, 18889.149988250836, 18940.621187575896, 19036.33372831944, 19100.0, 20790.1683932641, 20908.581828363043, 21056.0, 21071.894640526698, 21177.470563236042, 18397.448076557725, 18641.254349825856, 18673.346432874783, 18742.437726868215, 18891.43325700231, 17964.55088622795, 18339.449816505527, 18679.1594378256, 18772.906135469235, 18831.90584047071, 17308.22113004943, 17648.823511764716, 18463.723044154616, 18999.24003039863, 19108.33120840764, 14051.36768845425, 14068.507602233873, 14137.787933181216, 14195.432182712575, 14221.715565688835, 13211.0, 13377.0, 13492.257925814174, 14406.461964481574, 14777.261136943325], "value": 9208.80171239469, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1562.1, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [104.0, 113.0, 101.0, 118.0, 114.0, 114.0, 110.0, 101.0, 117.0, 109.0], "value": 110.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 125.0, 159.0, 189.0, 126.0, 144.0, 148.0, 119.0, 170.0, 120.0], "value": 144.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [173.0, 162.0, 175.0, 167.0, 163.0, 165.0, 169.0, 164.0, 163.0, 170.0], "value": 167.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 74.0, 76.0, 172.0, 83.0, 79.0, 84.0, 94.0, 98.0, 80.0], "value": 91.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 83.0, 130.0, 80.0, 81.0, 81.0, 132.0, 79.0, 81.0, 132.0], "value": 96.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [121.0, 114.0, 125.0, 123.0, 117.0, 121.0, 124.0, 114.0, 116.0, 125.0], "value": 120.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 156.0, 158.0, 151.0, 158.0, 151.0, 152.0, 159.0, 157.0, 159.0], "value": 155.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 100.0, 95.0, 100.0, 94.0, 94.0, 99.0, 107.0, 95.0, 97.0], "value": 97.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 54.0, 66.0, 53.0, 54.0, 54.0, 58.0, 55.0, 54.0, 54.0], "value": 56.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 60.0, 59.0, 56.0, 54.0, 55.0, 65.0, 59.0, 54.0, 54.0], "value": 57.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 77.0, 82.0, 79.0, 75.0, 77.0, 83.0, 80.0, 83.0, 80.0], "value": 79.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [143.0, 125.0, 134.0, 127.0, 122.0, 134.0, 125.0, 131.0, 137.0, 162.0], "value": 134.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [193.0, 190.0, 179.0, 178.0, 174.0, 178.0, 179.0, 198.0, 190.0, 178.0], "value": 183.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 69.0, 70.0, 69.0, 68.0, 68.0, 67.0, 71.0, 69.0, 69.0], "value": 68.9, "unit": "score"}]}]} 11:28:53 INFO - Return code: 0 11:28:53 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 11:28:53 INFO - # TBPL SUCCESS # 11:28:53 INFO - Running post-action listener: _package_coverage_data 11:28:53 INFO - Running post-action listener: _resource_record_post_action 11:28:53 INFO - [mozharness: 2017-08-16 18:28:53.353903Z] Finished run-tests step (success) 11:28:53 INFO - Running post-run listener: _resource_record_post_run 11:28:53 INFO - Total resource usage - Wall time: 1199s; CPU: 13.0%; Read bytes: 4096; Write bytes: 434745344; Read time: 12; Write time: 413952 11:28:53 INFO - TinderboxPrint: CPU usage
13.3% 11:28:53 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 11:28:53 INFO - TinderboxPrint: I/O write bytes / time
434,745,344 / 413,952 11:28:53 INFO - TinderboxPrint: CPU idle
8,283.2 (86.7%) 11:28:53 INFO - TinderboxPrint: CPU user
1,208.9 (12.7%) 11:28:53 INFO - TinderboxPrint: Swap in / out
0 / 0 11:28:53 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 107163648; Read time: 0; Write time: 141332 11:28:53 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 11:28:53 INFO - run-tests - Wall time: 1181s; CPU: 13.0%; Read bytes: 0; Write bytes: 327581696; Read time: 0; Write time: 272620 11:28:54 INFO - Running post-run listener: _upload_blobber_files 11:28:54 INFO - Blob upload gear active. 11:28:54 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 11:28:54 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:28:54 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:28:54 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:28:54 INFO - (blobuploader) - INFO - Open directory for files ... 11:28:54 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 11:28:54 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:28:54 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:29:00 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 11:29:00 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:29:00 INFO - (blobuploader) - INFO - Done attempting. 11:29:00 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 11:29:00 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:29:00 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:29:01 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 11:29:01 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:29:01 INFO - (blobuploader) - INFO - Done attempting. 11:29:01 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 11:29:01 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:29:01 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:29:02 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 11:29:02 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:29:02 INFO - (blobuploader) - INFO - Done attempting. 11:29:02 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 11:29:02 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:29:02 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:29:03 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 11:29:03 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:29:03 INFO - (blobuploader) - INFO - Done attempting. 11:29:03 INFO - (blobuploader) - INFO - Iteration through files over. 11:29:03 INFO - Return code: 0 11:29:03 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 11:29:03 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 11:29:03 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c520ef2fbf98c0e5e2f924bfb49f5011d56d8e76da5b6157bb52a9a2f0830636e419ac222d481645b5646f1bd48250b0599fe3eab2c8ebd2cca094bb6903d728", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ac1bfb2a2bee7b72c461d8dd5bbb22436fce966b2edf28aa2ddda03bb11c8ca8152b9b411a18a8fe916402e2da8960477d8a69dfa1a0bc93186d8a4bed87dc7a", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4357d153682ce7a26dc363d2cb62b1e731d5b47001a9bfb6e98b135888043963d749a3a380d30148143c58bc7ba6ebc44c068d4b124df2bfdb5736744b768cdd", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a0eeb77e1894e83cd3f1fec35741ac41e2154ba3f29558c3c3ae7c079dba1f6fd1397e8340ff8245bdbefb012f73f2f7f67474c0dba426fbabc618e32f845691"} 11:29:03 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 11:29:03 INFO - Writing to file /builds/slave/test/properties/blobber_files 11:29:03 INFO - Contents: 11:29:03 INFO - blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c520ef2fbf98c0e5e2f924bfb49f5011d56d8e76da5b6157bb52a9a2f0830636e419ac222d481645b5646f1bd48250b0599fe3eab2c8ebd2cca094bb6903d728", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ac1bfb2a2bee7b72c461d8dd5bbb22436fce966b2edf28aa2ddda03bb11c8ca8152b9b411a18a8fe916402e2da8960477d8a69dfa1a0bc93186d8a4bed87dc7a", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4357d153682ce7a26dc363d2cb62b1e731d5b47001a9bfb6e98b135888043963d749a3a380d30148143c58bc7ba6ebc44c068d4b124df2bfdb5736744b768cdd", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a0eeb77e1894e83cd3f1fec35741ac41e2154ba3f29558c3c3ae7c079dba1f6fd1397e8340ff8245bdbefb012f73f2f7f67474c0dba426fbabc618e32f845691"} 11:29:03 INFO - Running post-run listener: copy_logs_to_upload_dir 11:29:03 INFO - Copying logs to upload dir... 11:29:03 INFO - mkdir: /builds/slave/test/build/upload/logs 11:29:03 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1260.287249 ========= master_lag: 0.05 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 0 secs) (at 2017-08-16 11:29:03.143289) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-08-16 11:29:03.150526) ========= 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=af724c981e2a0f424dbabf99000001e7-1502906880.52806-1546123981 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/c520ef2fbf98c0e5e2f924bfb49f5011d56d8e76da5b6157bb52a9a2f0830636e419ac222d481645b5646f1bd48250b0599fe3eab2c8ebd2cca094bb6903d728", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ac1bfb2a2bee7b72c461d8dd5bbb22436fce966b2edf28aa2ddda03bb11c8ca8152b9b411a18a8fe916402e2da8960477d8a69dfa1a0bc93186d8a4bed87dc7a", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4357d153682ce7a26dc363d2cb62b1e731d5b47001a9bfb6e98b135888043963d749a3a380d30148143c58bc7ba6ebc44c068d4b124df2bfdb5736744b768cdd", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a0eeb77e1894e83cd3f1fec35741ac41e2154ba3f29558c3c3ae7c079dba1f6fd1397e8340ff8245bdbefb012f73f2f7f67474c0dba426fbabc618e32f845691"} build_url:https://queue.taskcluster.net/v1/task/YbqntiLNQ_uKrat-Wa379w/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011207 build_url: 'https://queue.taskcluster.net/v1/task/YbqntiLNQ_uKrat-Wa379w/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c520ef2fbf98c0e5e2f924bfb49f5011d56d8e76da5b6157bb52a9a2f0830636e419ac222d481645b5646f1bd48250b0599fe3eab2c8ebd2cca094bb6903d728", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ac1bfb2a2bee7b72c461d8dd5bbb22436fce966b2edf28aa2ddda03bb11c8ca8152b9b411a18a8fe916402e2da8960477d8a69dfa1a0bc93186d8a4bed87dc7a", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4357d153682ce7a26dc363d2cb62b1e731d5b47001a9bfb6e98b135888043963d749a3a380d30148143c58bc7ba6ebc44c068d4b124df2bfdb5736744b768cdd", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a0eeb77e1894e83cd3f1fec35741ac41e2154ba3f29558c3c3ae7c079dba1f6fd1397e8340ff8245bdbefb012f73f2f7f67474c0dba426fbabc618e32f845691"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-08-16 11:29:03.179584) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-08-16 11:29:03.179904) ========= 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=af724c981e2a0f424dbabf99000001e7-1502906880.52806-1546123981 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004538 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-08-16 11:29:03.262921) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-08-16 11:29:03.266276) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-08-16 11:29:03.266615) ========= ========= Total master_lag: 0.21 =========