builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-035 starttime: 1502484705.7 results: success (0) revision: d0afe5d6350426e338c1acff28a4a0c38ba1965f ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-08-11 13:51:45.700454) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-08-11 13:51:45.700919) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-08-11 13:51:45.701192) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-08-11 13:51:45.717132) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-11 13:51:45.717424) ========= 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=ed14279e38b05397cf4aa391000001a4-1502484705.83030-799731030 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-08-11 13:51:45-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 46.1M=0s 2017-08-11 13:51:45 (46.1 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.091326 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-11 13:51:45.822095) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-08-11 13:51:45.822402) ========= 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=ed14279e38b05397cf4aa391000001a4-1502484705.83030-799731030 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014328 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-08-11 13:51:45.874333) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-08-11 13:51:45.878193) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev d0afe5d6350426e338c1acff28a4a0c38ba1965f --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 d0afe5d6350426e338c1acff28a4a0c38ba1965f --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=ed14279e38b05397cf4aa391000001a4-1502484705.83030-799731030 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-08-11 13:51:45,944 truncating revision to first 12 chars 2017-08-11 13:51:45,944 Setting DEBUG logging. 2017-08-11 13:51:45,944 attempt 1/10 2017-08-11 13:51:45,944 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/d0afe5d63504?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-08-11 13:51:46,829 unpacking tar archive at: mozilla-central-d0afe5d63504/testing/mozharness/ program finished with exit code 0 elapsedTime=1.175904 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-08-11 13:51:47.066723) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-08-11 13:51:47.067041) ========= script_repo_revision: d0afe5d6350426e338c1acff28a4a0c38ba1965f ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-08-11 13:51:47.067431) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-08-11 13:51:47.067732) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-08-11 13:51:47.078540) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 44 secs) (at 2017-08-11 13:51:47.078888) ========= /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=ed14279e38b05397cf4aa391000001a4-1502484705.83030-799731030 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 13:51:47 INFO - MultiFileLogger online at 20170811 13:51:47 in /builds/slave/test 13:51:47 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 13:51:47 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 13:51:47 INFO - {'append_to_log': False, 13:51:47 INFO - 'base_work_dir': '/builds/slave/test', 13:51:47 INFO - 'blob_upload_branch': 'Firefox', 13:51:47 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 13:51:47 INFO - 'branch': 'Firefox', 13:51:47 INFO - 'buildbot_json_path': 'buildprops.json', 13:51:47 INFO - 'code_coverage': False, 13:51:47 INFO - 'config_files': ('talos/linux_config.py',), 13:51:47 INFO - 'default_actions': ('clobber', 13:51:47 INFO - 'read-buildbot-config', 13:51:47 INFO - 'download-and-extract', 13:51:47 INFO - 'populate-webroot', 13:51:47 INFO - 'create-virtualenv', 13:51:47 INFO - 'install', 13:51:47 INFO - 'setup-mitmproxy', 13:51:47 INFO - 'run-tests'), 13:51:47 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 13:51:47 INFO - 'disable_ccov_upload': False, 13:51:47 INFO - 'download_minidump_stackwalk': True, 13:51:47 INFO - 'download_symbols': 'ondemand', 13:51:47 INFO - 'enable_stylo': False, 13:51:47 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 13:51:47 INFO - 'tooltool.py': '/tools/tooltool.py', 13:51:47 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 13:51:47 INFO - '/tools/misc-python/virtualenv.py')}, 13:51:47 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 13:51:47 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 13:51:47 INFO - 'gecko_profile': False, 13:51:47 INFO - 'gecko_profile_interval': 0, 13:51:47 INFO - 'installer_path': 'installer.exe', 13:51:47 INFO - 'log_level': 'info', 13:51:47 INFO - 'log_name': 'talos', 13:51:47 INFO - 'log_to_console': True, 13:51:47 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 13:51:47 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 13:51:47 INFO - 'opt_config_files': (), 13:51:47 INFO - 'pip_index': False, 13:51:47 INFO - 'suite': 'dromaeojs-e10s', 13:51:47 INFO - 'system_bits': '32', 13:51:47 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 13:51:47 INFO - 'title': 'talos-linux64-ix-035', 13:51:47 INFO - 'tooltool_cache': '/builds/tooltool_cache', 13:51:47 INFO - 'use_talos_json': True, 13:51:47 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 13:51:47 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 13:51:47 INFO - 'work_dir': 'build'} 13:51:47 INFO - [mozharness: 2017-08-11 20:51:47.254279Z] Running clobber step. 13:51:47 INFO - Running pre-action listener: _resource_record_pre_action 13:51:47 INFO - Running main action method: clobber 13:51:47 INFO - rmtree: /builds/slave/test/build 13:51:47 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 13:51:48 INFO - Running post-action listener: _resource_record_post_action 13:51:48 INFO - [mozharness: 2017-08-11 20:51:48.374166Z] Finished clobber step (success) 13:51:48 INFO - [mozharness: 2017-08-11 20:51:48.374268Z] Running read-buildbot-config step. 13:51:48 INFO - Running pre-action listener: _resource_record_pre_action 13:51:48 INFO - Running main action method: read_buildbot_config 13:51:48 INFO - Using buildbot properties: 13:51:48 INFO - { 13:51:48 INFO - "project": "", 13:51:48 INFO - "product": "firefox", 13:51:48 INFO - "who": "kwierso@gmail.com", 13:51:48 INFO - "installer_path": "public/build/target.tar.bz2", 13:51:48 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 13:51:48 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 13:51:48 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs-e10s", 13:51:48 INFO - "stage_platform": "linux64-pgo", 13:51:48 INFO - "basedir": "/builds/slave/test", 13:51:48 INFO - "buildnumber": 107, 13:51:48 INFO - "platform": "ubuntu64_hw", 13:51:48 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 13:51:48 INFO - "slavebuilddir": "test", 13:51:48 INFO - "taskId": "ehfGq17SSgeMZqFcbAGmHw", 13:51:48 INFO - "branch": "mozilla-central", 13:51:48 INFO - "script_repo_revision": "production", 13:51:48 INFO - "revision": "d0afe5d6350426e338c1acff28a4a0c38ba1965f", 13:51:48 INFO - "slavename": "talos-linux64-ix-035", 13:51:48 INFO - "repo_path": "mozilla-central" 13:51:48 INFO - } 13:51:48 INFO - Finding installer, test and symbols from parent task. 13:51:48 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ehfGq17SSgeMZqFcbAGmHw'}, attempt #1 13:51:48 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ehfGq17SSgeMZqFcbAGmHw'}, attempt #1 13:51:49 INFO - Task dependencies: fX1fdLQiTay6BlwwYboQrw 13:51:49 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/fX1fdLQiTay6BlwwYboQrw'}, attempt #1 13:51:49 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/fX1fdLQiTay6BlwwYboQrw/artifacts/public/build/target.tar.bz2 13:51:49 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/fX1fdLQiTay6BlwwYboQrw/artifacts/public/build/target.test_packages.json 13:51:49 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/fX1fdLQiTay6BlwwYboQrw/artifacts/public/build/target.crashreporter-symbols.zip 13:51:49 INFO - Running post-action listener: _resource_record_post_action 13:51:49 INFO - [mozharness: 2017-08-11 20:51:49.710878Z] Finished read-buildbot-config step (success) 13:51:49 INFO - [mozharness: 2017-08-11 20:51:49.711098Z] Running download-and-extract step. 13:51:49 INFO - Running pre-action listener: _resource_record_pre_action 13:51:49 INFO - Running main action method: download_and_extract 13:51:49 INFO - mkdir: /builds/slave/test/build/tests 13:51:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:51:49 INFO - trying https://queue.taskcluster.net/v1/task/fX1fdLQiTay6BlwwYboQrw/artifacts/public/build/target.test_packages.json 13:51:49 INFO - Downloading https://queue.taskcluster.net/v1/task/fX1fdLQiTay6BlwwYboQrw/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 13:51:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/fX1fdLQiTay6BlwwYboQrw/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 13:51:50 INFO - Downloaded 989 bytes. 13:51:50 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 13:51:50 INFO - Using the following test package requirements: 13:51:50 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 13:51:50 INFO - u'common': [u'target.common.tests.zip'], 13:51:50 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 13:51:50 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 13:51:50 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 13:51:50 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 13:51:50 INFO - u'mozbase': [u'target.common.tests.zip'], 13:51:50 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 13:51:50 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 13:51:50 INFO - u'web-platform': [u'target.common.tests.zip', 13:51:50 INFO - u'target.web-platform.tests.tar.gz'], 13:51:50 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 13:51:50 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 13:51:50 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/fX1fdLQiTay6BlwwYboQrw/artifacts/public/build/target.common.tests.zip 13:51:50 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/fX1fdLQiTay6BlwwYboQrw/artifacts/public/build/target.common.tests.zip'}, attempt #1 13:51:50 INFO - Fetch https://queue.taskcluster.net/v1/task/fX1fdLQiTay6BlwwYboQrw/artifacts/public/build/target.common.tests.zip into memory 13:51:51 INFO - Content-Length response header: 54648931 13:51:51 INFO - Bytes received: 54648931 13:52:02 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 13:52:02 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/fX1fdLQiTay6BlwwYboQrw/artifacts/public/build/target.common.tests.zip 13:52:02 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/fX1fdLQiTay6BlwwYboQrw/artifacts/public/build/target.common.tests.zip'}, attempt #1 13:52:02 INFO - Fetch https://queue.taskcluster.net/v1/task/fX1fdLQiTay6BlwwYboQrw/artifacts/public/build/target.common.tests.zip into memory 13:52:03 INFO - Content-Length response header: 54648931 13:52:03 INFO - Bytes received: 54648931 13:52:15 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/fX1fdLQiTay6BlwwYboQrw/artifacts/public/build/target.talos.tests.zip 13:52:15 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/fX1fdLQiTay6BlwwYboQrw/artifacts/public/build/target.talos.tests.zip'}, attempt #1 13:52:15 INFO - Fetch https://queue.taskcluster.net/v1/task/fX1fdLQiTay6BlwwYboQrw/artifacts/public/build/target.talos.tests.zip into memory 13:52:15 INFO - Content-Length response header: 14496050 13:52:15 INFO - Bytes received: 14496050 13:52:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:52:16 INFO - trying https://queue.taskcluster.net/v1/task/fX1fdLQiTay6BlwwYboQrw/artifacts/public/build/target.tar.bz2 13:52:16 INFO - Downloading https://queue.taskcluster.net/v1/task/fX1fdLQiTay6BlwwYboQrw/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 13:52:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/fX1fdLQiTay6BlwwYboQrw/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 13:52:17 INFO - Downloaded 62675641 bytes. 13:52:17 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/fX1fdLQiTay6BlwwYboQrw/artifacts/public/build/target.tar.bz2 13:52:17 INFO - mkdir: /builds/slave/test/properties 13:52:17 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 13:52:17 INFO - Writing to file /builds/slave/test/properties/build_url 13:52:17 INFO - Contents: 13:52:17 INFO - build_url:https://queue.taskcluster.net/v1/task/fX1fdLQiTay6BlwwYboQrw/artifacts/public/build/target.tar.bz2 13:52:17 INFO - Running post-action listener: _resource_record_post_action 13:52:17 INFO - Running post-action listener: set_extra_try_arguments 13:52:17 INFO - [mozharness: 2017-08-11 20:52:17.226522Z] Finished download-and-extract step (success) 13:52:17 INFO - [mozharness: 2017-08-11 20:52:17.226619Z] Running populate-webroot step. 13:52:17 INFO - Running pre-action listener: _resource_record_pre_action 13:52:17 INFO - Running main action method: populate_webroot 13:52:17 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 13:52:17 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 13:52:17 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 13:52:17 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:52:17 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 13:52:17 INFO - 'tests': ['damp', 'tps']}, 13:52:17 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 13:52:17 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 13:52:17 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 13:52:17 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 13:52:17 INFO - 'other-e10s': {'tests': ['a11yr', 13:52:17 INFO - 'ts_paint', 13:52:17 INFO - 'tpaint', 13:52:17 INFO - 'sessionrestore', 13:52:17 INFO - 'sessionrestore_many_windows', 13:52:17 INFO - 'sessionrestore_no_auto_restore', 13:52:17 INFO - 'tabpaint']}, 13:52:17 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 13:52:17 INFO - 'perf-reftest-singletons-e10s': {'tests': ['bloom_basic_singleton']}, 13:52:17 INFO - 'svgr-e10s': {'tests': ['tsvgx', 13:52:17 INFO - 'tsvgr_opacity', 13:52:17 INFO - 'tart', 13:52:17 INFO - 'tscrollx', 13:52:17 INFO - 'tsvg_static']}, 13:52:17 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 13:52:17 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 13:52:17 INFO - 'talos_options': ['--mitmproxy', 13:52:17 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 13:52:17 INFO - '--firstNonBlankPaint'], 13:52:17 INFO - 'tests': ['tp6_google', 13:52:17 INFO - 'tp6_youtube', 13:52:17 INFO - 'tp6_amazon', 13:52:17 INFO - 'tp6_facebook']}, 13:52:17 INFO - 'tp6-stylo-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 13:52:17 INFO - 'talos_options': ['--stylo', 13:52:17 INFO - '--mitmproxy', 13:52:17 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 13:52:17 INFO - '--firstNonBlankPaint'], 13:52:17 INFO - 'tests': ['tp6_google', 13:52:17 INFO - 'tp6_youtube', 13:52:17 INFO - 'tp6_amazon', 13:52:17 INFO - 'tp6_facebook']}, 13:52:17 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 13:52:17 INFO - 'talos_options': ['--stylo', 13:52:17 INFO - '--stylo-threads=1', 13:52:17 INFO - '--mitmproxy', 13:52:17 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 13:52:17 INFO - '--firstNonBlankPaint'], 13:52:17 INFO - 'tests': ['tp6_google', 13:52:17 INFO - 'tp6_youtube', 13:52:17 INFO - 'tp6_amazon', 13:52:17 INFO - 'tp6_facebook']}, 13:52:17 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 13:52:17 INFO - 'talos_options': ['--xperf_path', 13:52:17 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:52:17 INFO - 'tests': ['tp5n']}}} 13:52:17 INFO - Running post-action listener: _resource_record_post_action 13:52:17 INFO - [mozharness: 2017-08-11 20:52:17.235031Z] Finished populate-webroot step (success) 13:52:17 INFO - [mozharness: 2017-08-11 20:52:17.235121Z] Running create-virtualenv step. 13:52:17 INFO - Running pre-action listener: _resource_record_pre_action 13:52:17 INFO - Running main action method: create_virtualenv 13:52:17 INFO - Creating virtualenv /builds/slave/test/build/venv 13:52:17 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 13:52:17 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 13:52:17 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 13:52:17 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 13:52:17 INFO - Using real prefix '/usr' 13:52:17 INFO - New python executable in /builds/slave/test/build/venv/bin/python 13:52:17 INFO - Installing distribute.............................................................................................................................................................................................done. 13:52:19 INFO - Installing pip.................done. 13:52:19 INFO - Return code: 0 13:52:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 13:52:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 13:52:20 INFO - Reading from file tmpfile_stdout 13:52:20 INFO - Output received: 13:52:20 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) 13:52:20 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 13:52:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:52:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:52:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:52:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:52:20 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 0xf141f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e0a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1283700>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12808a0>, '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 0x12817a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1281c30>, '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': 'ed14279e38b05397cf4aa391000001a4-1502484705.83030-799731030', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 13:52:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 13:52:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 13:52:20 INFO - Using env: {'DISPLAY': ':0', 13:52:20 INFO - 'HOME': '/home/cltbld', 13:52:20 INFO - 'LANG': 'en_US.UTF-8', 13:52:20 INFO - 'LANGUAGE': 'en_US:en', 13:52:20 INFO - 'LOGNAME': 'cltbld', 13:52:20 INFO - 'MAIL': '/var/mail/cltbld', 13:52:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:52:20 INFO - 'MOZ_NO_REMOTE': '1', 13:52:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:52:20 INFO - 'NO_EM_RESTART': '1', 13:52:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:52:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:52:20 INFO - 'PWD': '/builds/slave/test', 13:52:20 INFO - 'SHELL': '/bin/bash', 13:52:20 INFO - 'SHLVL': '1', 13:52:20 INFO - 'TERM': 'linux', 13:52:20 INFO - 'TMOUT': '86400', 13:52:20 INFO - 'USER': 'cltbld', 13:52:20 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1502484705.83030-799731030', 13:52:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:52:20 INFO - '_': '/tools/buildbot/bin/python'} 13:52:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:52:20 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 13:52:20 INFO - Cleaning up... 13:52:20 INFO - Return code: 0 13:52:20 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 13:52:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:52:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:52:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:52:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:52:20 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 0xf141f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e0a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1283700>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12808a0>, '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 0x12817a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1281c30>, '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': 'ed14279e38b05397cf4aa391000001a4-1502484705.83030-799731030', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 13:52:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 13:52:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 13:52:20 INFO - Using env: {'DISPLAY': ':0', 13:52:20 INFO - 'HOME': '/home/cltbld', 13:52:20 INFO - 'LANG': 'en_US.UTF-8', 13:52:20 INFO - 'LANGUAGE': 'en_US:en', 13:52:20 INFO - 'LOGNAME': 'cltbld', 13:52:20 INFO - 'MAIL': '/var/mail/cltbld', 13:52:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:52:20 INFO - 'MOZ_NO_REMOTE': '1', 13:52:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:52:20 INFO - 'NO_EM_RESTART': '1', 13:52:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:52:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:52:20 INFO - 'PWD': '/builds/slave/test', 13:52:20 INFO - 'SHELL': '/bin/bash', 13:52:20 INFO - 'SHLVL': '1', 13:52:20 INFO - 'TERM': 'linux', 13:52:20 INFO - 'TMOUT': '86400', 13:52:20 INFO - 'USER': 'cltbld', 13:52:20 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1502484705.83030-799731030', 13:52:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:52:20 INFO - '_': '/tools/buildbot/bin/python'} 13:52:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:52:20 INFO - Downloading/unpacking psutil>=3.1.1 13:52:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:52:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:52:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:52:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:52:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 13:52:21 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:52:21 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:52:21 INFO - Installing collected packages: psutil 13:52:21 INFO - Running setup.py install for psutil 13:52:21 INFO - building 'psutil._psutil_linux' extension 13:52:21 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 13:52:21 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 13:52:22 INFO - building 'psutil._psutil_posix' extension 13:52:22 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 13:52:22 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 13:52:22 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:52:22 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:52:22 INFO - Successfully installed psutil 13:52:22 INFO - Cleaning up... 13:52:22 INFO - Return code: 0 13:52:22 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 13:52:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:52:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:52:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:52:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:52:22 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 0xf141f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e0a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1283700>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12808a0>, '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 0x12817a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1281c30>, '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': 'ed14279e38b05397cf4aa391000001a4-1502484705.83030-799731030', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 13:52:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 13:52:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 13:52:22 INFO - Using env: {'DISPLAY': ':0', 13:52:22 INFO - 'HOME': '/home/cltbld', 13:52:22 INFO - 'LANG': 'en_US.UTF-8', 13:52:22 INFO - 'LANGUAGE': 'en_US:en', 13:52:22 INFO - 'LOGNAME': 'cltbld', 13:52:22 INFO - 'MAIL': '/var/mail/cltbld', 13:52:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:52:22 INFO - 'MOZ_NO_REMOTE': '1', 13:52:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:52:22 INFO - 'NO_EM_RESTART': '1', 13:52:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:52:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:52:22 INFO - 'PWD': '/builds/slave/test', 13:52:22 INFO - 'SHELL': '/bin/bash', 13:52:22 INFO - 'SHLVL': '1', 13:52:22 INFO - 'TERM': 'linux', 13:52:22 INFO - 'TMOUT': '86400', 13:52:22 INFO - 'USER': 'cltbld', 13:52:22 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1502484705.83030-799731030', 13:52:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:52:22 INFO - '_': '/tools/buildbot/bin/python'} 13:52:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:52:22 INFO - Downloading/unpacking mozsystemmonitor==0.3 13:52:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:52:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:52:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:52:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:52:23 INFO - Downloading mozsystemmonitor-0.3.tar.gz 13:52:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 13:52:23 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 13:52:23 INFO - Installing collected packages: mozsystemmonitor 13:52:23 INFO - Running setup.py install for mozsystemmonitor 13:52:23 INFO - Successfully installed mozsystemmonitor 13:52:23 INFO - Cleaning up... 13:52:23 INFO - Return code: 0 13:52:23 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 13:52:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:52:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:52:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:52:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:52:23 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 0xf141f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e0a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1283700>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12808a0>, '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 0x12817a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1281c30>, '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': 'ed14279e38b05397cf4aa391000001a4-1502484705.83030-799731030', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 13:52:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 13:52:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 13:52:23 INFO - Using env: {'DISPLAY': ':0', 13:52:23 INFO - 'HOME': '/home/cltbld', 13:52:23 INFO - 'LANG': 'en_US.UTF-8', 13:52:23 INFO - 'LANGUAGE': 'en_US:en', 13:52:23 INFO - 'LOGNAME': 'cltbld', 13:52:23 INFO - 'MAIL': '/var/mail/cltbld', 13:52:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:52:23 INFO - 'MOZ_NO_REMOTE': '1', 13:52:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:52:23 INFO - 'NO_EM_RESTART': '1', 13:52:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:52:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:52:23 INFO - 'PWD': '/builds/slave/test', 13:52:23 INFO - 'SHELL': '/bin/bash', 13:52:23 INFO - 'SHLVL': '1', 13:52:23 INFO - 'TERM': 'linux', 13:52:23 INFO - 'TMOUT': '86400', 13:52:23 INFO - 'USER': 'cltbld', 13:52:23 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1502484705.83030-799731030', 13:52:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:52:23 INFO - '_': '/tools/buildbot/bin/python'} 13:52:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:52:23 INFO - Downloading/unpacking jsonschema==2.5.1 13:52:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:52:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:52:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:52:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:52:25 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 13:52:25 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 13:52:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:52:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:52:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:52:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:52:25 INFO - Downloading functools32-3.2.3-2.tar.gz 13:52:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 13:52:25 INFO - warning: no files found matching '*.txt' 13:52:25 INFO - no previously-included directories found matching 'build' 13:52:25 INFO - no previously-included directories found matching 'dist' 13:52:25 INFO - no previously-included directories found matching '.git*' 13:52:25 INFO - Installing collected packages: jsonschema, functools32 13:52:25 INFO - Running setup.py install for functools32 13:52:25 INFO - warning: no files found matching '*.txt' 13:52:25 INFO - no previously-included directories found matching 'build' 13:52:25 INFO - no previously-included directories found matching 'dist' 13:52:25 INFO - no previously-included directories found matching '.git*' 13:52:25 INFO - Successfully installed jsonschema functools32 13:52:25 INFO - Cleaning up... 13:52:25 INFO - Return code: 0 13:52:25 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 13:52:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:52:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:52:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:52:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:52:25 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 0xf141f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e0a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1283700>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12808a0>, '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 0x12817a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1281c30>, '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': 'ed14279e38b05397cf4aa391000001a4-1502484705.83030-799731030', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 13:52:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 13:52:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 13:52:25 INFO - Using env: {'DISPLAY': ':0', 13:52:25 INFO - 'HOME': '/home/cltbld', 13:52:25 INFO - 'LANG': 'en_US.UTF-8', 13:52:25 INFO - 'LANGUAGE': 'en_US:en', 13:52:25 INFO - 'LOGNAME': 'cltbld', 13:52:25 INFO - 'MAIL': '/var/mail/cltbld', 13:52:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:52:25 INFO - 'MOZ_NO_REMOTE': '1', 13:52:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:52:25 INFO - 'NO_EM_RESTART': '1', 13:52:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:52:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:52:25 INFO - 'PWD': '/builds/slave/test', 13:52:25 INFO - 'SHELL': '/bin/bash', 13:52:25 INFO - 'SHLVL': '1', 13:52:25 INFO - 'TERM': 'linux', 13:52:25 INFO - 'TMOUT': '86400', 13:52:25 INFO - 'USER': 'cltbld', 13:52:25 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1502484705.83030-799731030', 13:52:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:52:25 INFO - '_': '/tools/buildbot/bin/python'} 13:52:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:52:25 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 13:52:25 INFO - Cleaning up... 13:52:25 INFO - Return code: 0 13:52:25 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 13:52:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:52:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:52:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:52:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:52:25 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 0xf141f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e0a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1283700>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12808a0>, '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 0x12817a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1281c30>, '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': 'ed14279e38b05397cf4aa391000001a4-1502484705.83030-799731030', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 13:52:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 13:52:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 13:52:25 INFO - Using env: {'DISPLAY': ':0', 13:52:25 INFO - 'HOME': '/home/cltbld', 13:52:25 INFO - 'LANG': 'en_US.UTF-8', 13:52:25 INFO - 'LANGUAGE': 'en_US:en', 13:52:25 INFO - 'LOGNAME': 'cltbld', 13:52:25 INFO - 'MAIL': '/var/mail/cltbld', 13:52:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:52:25 INFO - 'MOZ_NO_REMOTE': '1', 13:52:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:52:25 INFO - 'NO_EM_RESTART': '1', 13:52:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:52:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:52:25 INFO - 'PWD': '/builds/slave/test', 13:52:25 INFO - 'SHELL': '/bin/bash', 13:52:25 INFO - 'SHLVL': '1', 13:52:25 INFO - 'TERM': 'linux', 13:52:25 INFO - 'TMOUT': '86400', 13:52:25 INFO - 'USER': 'cltbld', 13:52:25 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1502484705.83030-799731030', 13:52:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:52:25 INFO - '_': '/tools/buildbot/bin/python'} 13:52:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:52:25 INFO - Downloading/unpacking blobuploader==1.2.4 13:52:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:52:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:52:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:52:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:52:26 INFO - Downloading blobuploader-1.2.4.tar.gz 13:52:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 13:52:27 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 13:52:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:52:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:52:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:52:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:52:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 13:52:27 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 13:52:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:52:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:52:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:52:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:52:27 INFO - Downloading docopt-0.6.1.tar.gz 13:52:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 13:52:27 INFO - Installing collected packages: blobuploader, requests, docopt 13:52:27 INFO - Running setup.py install for blobuploader 13:52:27 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 13:52:27 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 13:52:27 INFO - Running setup.py install for requests 13:52:28 INFO - Running setup.py install for docopt 13:52:28 INFO - Successfully installed blobuploader requests docopt 13:52:28 INFO - Cleaning up... 13:52:28 INFO - Return code: 0 13:52:28 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:52:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:52:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:52:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:52:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:52:28 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 0xf141f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e0a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1283700>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12808a0>, '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 0x12817a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1281c30>, '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': 'ed14279e38b05397cf4aa391000001a4-1502484705.83030-799731030', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 13:52:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 13:52:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 13:52:28 INFO - Using env: {'DISPLAY': ':0', 13:52:28 INFO - 'HOME': '/home/cltbld', 13:52:28 INFO - 'LANG': 'en_US.UTF-8', 13:52:28 INFO - 'LANGUAGE': 'en_US:en', 13:52:28 INFO - 'LOGNAME': 'cltbld', 13:52:28 INFO - 'MAIL': '/var/mail/cltbld', 13:52:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:52:28 INFO - 'MOZ_NO_REMOTE': '1', 13:52:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:52:28 INFO - 'NO_EM_RESTART': '1', 13:52:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:52:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:52:28 INFO - 'PWD': '/builds/slave/test', 13:52:28 INFO - 'SHELL': '/bin/bash', 13:52:28 INFO - 'SHLVL': '1', 13:52:28 INFO - 'TERM': 'linux', 13:52:28 INFO - 'TMOUT': '86400', 13:52:28 INFO - 'USER': 'cltbld', 13:52:28 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1502484705.83030-799731030', 13:52:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:52:28 INFO - '_': '/tools/buildbot/bin/python'} 13:52:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:52:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:52:28 INFO - Running setup.py (path:/tmp/pip-hj2u2E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:52:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:52:28 INFO - Running setup.py (path:/tmp/pip-HeWp6R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:52:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:52:28 INFO - Running setup.py (path:/tmp/pip-t5GNOC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:52:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:52:28 INFO - Running setup.py (path:/tmp/pip-C6fG3q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:52:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:52:28 INFO - Running setup.py (path:/tmp/pip-nqsx7V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:52:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:52:28 INFO - Running setup.py (path:/tmp/pip-5Va_VL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:52:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:52:28 INFO - Running setup.py (path:/tmp/pip-9MiUwU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:52:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:52:29 INFO - Running setup.py (path:/tmp/pip-iMm5mm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:52:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:52:29 INFO - Running setup.py (path:/tmp/pip-RB6HlW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:52:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:52:29 INFO - Running setup.py (path:/tmp/pip-pllHT9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:52:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:52:29 INFO - Running setup.py (path:/tmp/pip-0hinI7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:52:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:52:29 INFO - Running setup.py (path:/tmp/pip-Ltr6zG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:52:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:52:29 INFO - Running setup.py (path:/tmp/pip-BseUj9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:52:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:52:29 INFO - Running setup.py (path:/tmp/pip-ASj3BY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:52:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:52:29 INFO - Running setup.py (path:/tmp/pip-TApuBe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:52:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:52:29 INFO - Running setup.py (path:/tmp/pip-3UOoHI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:52:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:52:29 INFO - Running setup.py (path:/tmp/pip-cGeXl9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:52:29 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 13:52:29 INFO - Running setup.py install for manifestparser 13:52:29 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 13:52:29 INFO - Running setup.py install for mozcrash 13:52:29 INFO - Running setup.py install for mozdebug 13:52:30 INFO - Running setup.py install for mozdevice 13:52:30 INFO - Installing dm script to /builds/slave/test/build/venv/bin 13:52:30 INFO - Running setup.py install for mozfile 13:52:30 INFO - Running setup.py install for mozhttpd 13:52:30 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 13:52:30 INFO - Running setup.py install for mozinfo 13:52:30 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 13:52:30 INFO - Running setup.py install for mozInstall 13:52:30 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 13:52:30 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 13:52:30 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 13:52:30 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 13:52:30 INFO - Running setup.py install for mozleak 13:52:30 INFO - Running setup.py install for mozlog 13:52:30 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 13:52:30 INFO - Running setup.py install for moznetwork 13:52:30 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 13:52:30 INFO - Running setup.py install for mozprocess 13:52:30 INFO - Running setup.py install for mozprofile 13:52:31 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 13:52:31 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 13:52:31 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 13:52:31 INFO - Running setup.py install for mozrunner 13:52:31 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 13:52:31 INFO - Running setup.py install for mozscreenshot 13:52:31 INFO - Running setup.py install for moztest 13:52:31 INFO - Running setup.py install for mozversion 13:52:31 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 13:52:31 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 13:52:31 INFO - Cleaning up... 13:52:31 INFO - Return code: 0 13:52:31 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:52:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:52:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:52:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:52:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:52:31 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 0xf141f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e0a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1283700>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12808a0>, '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 0x12817a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1281c30>, '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': 'ed14279e38b05397cf4aa391000001a4-1502484705.83030-799731030', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 13:52:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 13:52:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 13:52:31 INFO - Using env: {'DISPLAY': ':0', 13:52:31 INFO - 'HOME': '/home/cltbld', 13:52:31 INFO - 'LANG': 'en_US.UTF-8', 13:52:31 INFO - 'LANGUAGE': 'en_US:en', 13:52:31 INFO - 'LOGNAME': 'cltbld', 13:52:31 INFO - 'MAIL': '/var/mail/cltbld', 13:52:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:52:31 INFO - 'MOZ_NO_REMOTE': '1', 13:52:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:52:31 INFO - 'NO_EM_RESTART': '1', 13:52:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:52:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:52:31 INFO - 'PWD': '/builds/slave/test', 13:52:31 INFO - 'SHELL': '/bin/bash', 13:52:31 INFO - 'SHLVL': '1', 13:52:31 INFO - 'TERM': 'linux', 13:52:31 INFO - 'TMOUT': '86400', 13:52:31 INFO - 'USER': 'cltbld', 13:52:31 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1502484705.83030-799731030', 13:52:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:52:31 INFO - '_': '/tools/buildbot/bin/python'} 13:52:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:52:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:52:31 INFO - Running setup.py (path:/tmp/pip-y2WHmb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:52:31 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 13:52:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:52:31 INFO - Running setup.py (path:/tmp/pip-LSTp7m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:52:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 13:52:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:52:31 INFO - Running setup.py (path:/tmp/pip-H5sXoe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:52:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 13:52:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:52:31 INFO - Running setup.py (path:/tmp/pip-7is8h7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:52:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.51 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 13:52:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:52:32 INFO - Running setup.py (path:/tmp/pip-8X__PQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:52:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 13:52:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:52:32 INFO - Running setup.py (path:/tmp/pip-PVd4EO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:52:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 13:52:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:52:32 INFO - Running setup.py (path:/tmp/pip-Zids3U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:52:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.10 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 13:52:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:52:32 INFO - Running setup.py (path:/tmp/pip-WNxHes-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:52:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.13 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 13:52:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:52:32 INFO - Running setup.py (path:/tmp/pip-exIK2i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:52:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 13:52:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:52:32 INFO - Running setup.py (path:/tmp/pip-Y_MW9K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:52:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.5 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 13:52:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:52:32 INFO - Running setup.py (path:/tmp/pip-KBLw79-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:52:32 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 13:52:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:52:32 INFO - Running setup.py (path:/tmp/pip-HCV6P8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:52:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 13:52:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:52:32 INFO - Running setup.py (path:/tmp/pip-yuz6Ym-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:52:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 13:52:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:52:32 INFO - Running setup.py (path:/tmp/pip-PAbIbO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:52:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 13:52:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:52:32 INFO - Running setup.py (path:/tmp/pip-HC7Gaj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:52:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 13:52:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:52:32 INFO - Running setup.py (path:/tmp/pip-lwfndi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:52:32 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 13:52:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:52:32 INFO - Running setup.py (path:/tmp/pip-_QUwg4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:52:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 13:52:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 13:52:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 13:52:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 13:52:32 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.51->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 13:52:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.51->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 13:52:32 INFO - Requirement already satisfied (use --upgrade to upgrade): requests in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozInstall==1.13->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 13:52:32 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 13:52:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:52:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:52:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:52:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:52:34 INFO - Downloading blessings-1.6.tar.gz 13:52:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 13:52:34 INFO - Installing collected packages: blessings 13:52:34 INFO - Running setup.py install for blessings 13:52:34 INFO - Successfully installed blessings 13:52:34 INFO - Cleaning up... 13:52:34 INFO - Return code: 0 13:52:34 INFO - Done creating virtualenv /builds/slave/test/build/venv. 13:52:34 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:52:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:52:34 INFO - Reading from file tmpfile_stdout 13:52:34 INFO - Current package versions: 13:52:34 INFO - argparse == 1.2.1 13:52:34 INFO - blessings == 1.6 13:52:34 INFO - blobuploader == 1.2.4 13:52:34 INFO - docopt == 0.6.1 13:52:34 INFO - functools32 == 3.2.3-2 13:52:34 INFO - jsonschema == 2.5.1 13:52:34 INFO - manifestparser == 1.1 13:52:34 INFO - mozInstall == 1.13 13:52:34 INFO - mozcrash == 1.0 13:52:34 INFO - mozdebug == 0.1 13:52:34 INFO - mozdevice == 0.51 13:52:34 INFO - mozfile == 1.2 13:52:34 INFO - mozhttpd == 0.7 13:52:34 INFO - mozinfo == 0.10 13:52:34 INFO - mozleak == 0.1 13:52:34 INFO - mozlog == 3.5 13:52:34 INFO - moznetwork == 0.27 13:52:34 INFO - mozprocess == 0.25 13:52:34 INFO - mozprofile == 0.28 13:52:34 INFO - mozrunner == 6.13 13:52:34 INFO - mozscreenshot == 0.1 13:52:34 INFO - mozsystemmonitor == 0.3 13:52:34 INFO - moztest == 0.8 13:52:34 INFO - mozversion == 1.4 13:52:34 INFO - psutil == 3.1.1 13:52:34 INFO - requests == 1.2.3 13:52:34 INFO - wsgiref == 0.1.2 13:52:34 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:52:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:52:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:52:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:52:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:52:34 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 0xf141f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e0a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1283700>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12808a0>, '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 0x12817a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1281c30>, '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': 'ed14279e38b05397cf4aa391000001a4-1502484705.83030-799731030', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 13:52:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 13:52:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 13:52:34 INFO - Using env: {'DISPLAY': ':0', 13:52:34 INFO - 'HOME': '/home/cltbld', 13:52:34 INFO - 'LANG': 'en_US.UTF-8', 13:52:34 INFO - 'LANGUAGE': 'en_US:en', 13:52:34 INFO - 'LOGNAME': 'cltbld', 13:52:34 INFO - 'MAIL': '/var/mail/cltbld', 13:52:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:52:34 INFO - 'MOZ_NO_REMOTE': '1', 13:52:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:52:34 INFO - 'NO_EM_RESTART': '1', 13:52:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:52:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:52:34 INFO - 'PWD': '/builds/slave/test', 13:52:34 INFO - 'SHELL': '/bin/bash', 13:52:34 INFO - 'SHLVL': '1', 13:52:34 INFO - 'TERM': 'linux', 13:52:34 INFO - 'TMOUT': '86400', 13:52:34 INFO - 'USER': 'cltbld', 13:52:34 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1502484705.83030-799731030', 13:52:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:52:34 INFO - '_': '/tools/buildbot/bin/python'} 13:52:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:52:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 13:52:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 13:52:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 13:52:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 13:52:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 13:52:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 13:52:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 13:52:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 13:52:34 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 13:52:34 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 13:52:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:52:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:52:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:52:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:52:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 13:52:35 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 13:52:35 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 13:52:35 INFO - Installing collected packages: simplejson 13:52:35 INFO - Running setup.py install for simplejson 13:52:36 INFO - building 'simplejson._speedups' extension 13:52:36 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c simplejson/_speedups.c -o build/temp.linux-x86_64-2.7/simplejson/_speedups.o 13:52:36 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/simplejson/_speedups.o -o build/lib.linux-x86_64-2.7/simplejson/_speedups.so 13:52:36 INFO - Successfully installed simplejson 13:52:36 INFO - Cleaning up... 13:52:36 INFO - Return code: 0 13:52:36 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 13:52: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')]} 13:52:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:52: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')]} 13:52:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:52: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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf141f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e0a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1283700>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12808a0>, '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 0x12817a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1281c30>, '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': 'ed14279e38b05397cf4aa391000001a4-1502484705.83030-799731030', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 13:52: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', 'jsonschema'] in /builds/slave/test/build 13:52: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 jsonschema 13:52:36 INFO - Using env: {'DISPLAY': ':0', 13:52:36 INFO - 'HOME': '/home/cltbld', 13:52:36 INFO - 'LANG': 'en_US.UTF-8', 13:52:36 INFO - 'LANGUAGE': 'en_US:en', 13:52:36 INFO - 'LOGNAME': 'cltbld', 13:52:36 INFO - 'MAIL': '/var/mail/cltbld', 13:52:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:52:36 INFO - 'MOZ_NO_REMOTE': '1', 13:52:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:52:36 INFO - 'NO_EM_RESTART': '1', 13:52:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:52:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:52:36 INFO - 'PWD': '/builds/slave/test', 13:52:36 INFO - 'SHELL': '/bin/bash', 13:52:36 INFO - 'SHLVL': '1', 13:52:36 INFO - 'TERM': 'linux', 13:52:36 INFO - 'TMOUT': '86400', 13:52:37 INFO - 'USER': 'cltbld', 13:52:37 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1502484705.83030-799731030', 13:52:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:52:37 INFO - '_': '/tools/buildbot/bin/python'} 13:52:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:52:37 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 13:52:37 INFO - Cleaning up... 13:52:37 INFO - Return code: 0 13:52:37 INFO - Running post-action listener: _resource_record_post_action 13:52:37 INFO - Running post-action listener: _start_resource_monitoring 13:52:37 INFO - Starting resource monitoring. 13:52:37 INFO - [mozharness: 2017-08-11 20:52:37.256639Z] Finished create-virtualenv step (success) 13:52:37 INFO - [mozharness: 2017-08-11 20:52:37.257179Z] Running install step. 13:52:37 INFO - Running pre-action listener: _resource_record_pre_action 13:52:37 INFO - Running main action method: install 13:52:37 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:52:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:52:37 INFO - Reading from file tmpfile_stdout 13:52:37 INFO - Detecting whether we're running mozinstall >=1.0... 13:52:37 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 13:52:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 13:52:37 INFO - Reading from file tmpfile_stdout 13:52:37 INFO - Output received: 13:52:37 INFO - Usage: mozinstall [options] installer 13:52:37 INFO - Options: 13:52:37 INFO - -h, --help show this help message and exit 13:52:37 INFO - -d DEST, --destination=DEST 13:52:37 INFO - Directory to install application into. [default: 13:52:37 INFO - "/builds/slave/test"] 13:52:37 INFO - --app=APP Application being installed. [default: firefox] 13:52:37 INFO - mkdir: /builds/slave/test/build/application 13:52:37 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/target.tar.bz2', '--destination', '/builds/slave/test/build/application'] 13:52:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 13:52:55 INFO - Reading from file tmpfile_stdout 13:52:55 INFO - Output received: 13:52:55 INFO - /builds/slave/test/build/application/firefox/firefox 13:52:55 INFO - Running post-action listener: _resource_record_post_action 13:52:55 INFO - [mozharness: 2017-08-11 20:52:55.395885Z] Finished install step (success) 13:52:55 INFO - [mozharness: 2017-08-11 20:52:55.396169Z] Running setup-mitmproxy step. 13:52:55 INFO - Running pre-action listener: _resource_record_pre_action 13:52:55 INFO - Running main action method: setup_mitmproxy 13:52:55 INFO - Skipping: mitmproxy is not required 13:52:55 INFO - Running post-action listener: _resource_record_post_action 13:52:55 INFO - [mozharness: 2017-08-11 20:52:55.397349Z] Finished setup-mitmproxy step (success) 13:52:55 INFO - [mozharness: 2017-08-11 20:52:55.397582Z] Running run-tests step. 13:52:55 INFO - Running pre-action listener: _resource_record_pre_action 13:52:55 INFO - Running pre-action listener: _set_gcov_prefix 13:52:55 INFO - Running main action method: run_tests 13:52:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 13:52:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 13:52:55 INFO - Python 2.7.3 13:52:55 INFO - Return code: 0 13:52:55 INFO - grabbing minidump binary from tooltool 13:52:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:52:55 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 0x12808a0>, '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 0x12817a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1281c30>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 13:52:55 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 13:52:55 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 13:52:55 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 13:52:55 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 13:52:55 INFO - Return code: 0 13:52:55 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 13:52:55 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 13:52:55 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 13:52:55 INFO - ENV: RUST_BACKTRACE is now full 13:52:55 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 13:52:55 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 13:52:55 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/fX1fdLQiTay6BlwwYboQrw/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-035', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 13:52:55 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/fX1fdLQiTay6BlwwYboQrw/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-035 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 13:52:55 INFO - Using env: {'DISPLAY': ':0', 13:52:55 INFO - 'HOME': '/home/cltbld', 13:52:55 INFO - 'LANG': 'en_US.UTF-8', 13:52:55 INFO - 'LANGUAGE': 'en_US:en', 13:52:55 INFO - 'LOGNAME': 'cltbld', 13:52:55 INFO - 'MAIL': '/var/mail/cltbld', 13:52:55 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 13:52:55 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 13:52:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:52:55 INFO - 'MOZ_NO_REMOTE': '1', 13:52:55 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 13:52:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:52:55 INFO - 'NO_EM_RESTART': '1', 13:52:55 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:52:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:52:55 INFO - 'PWD': '/builds/slave/test', 13:52:55 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 13:52:55 INFO - 'RUST_BACKTRACE': 'full', 13:52:55 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 13:52:55 INFO - 'SHELL': '/bin/bash', 13:52:55 INFO - 'SHLVL': '1', 13:52:55 INFO - 'TERM': 'linux', 13:52:55 INFO - 'TMOUT': '86400', 13:52:55 INFO - 'USER': 'cltbld', 13:52:55 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1502484705.83030-799731030', 13:52:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:52:55 INFO - '_': '/tools/buildbot/bin/python'} 13:52:55 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/fX1fdLQiTay6BlwwYboQrw/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-035', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 13:52:55 INFO - mozversion application_buildid: 20170811193030 13:52:55 INFO - mozversion application_changeset: d0afe5d6350426e338c1acff28a4a0c38ba1965f 13:52:55 INFO - mozversion application_display_name: Nightly 13:52:55 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 13:52:55 INFO - mozversion application_name: Firefox 13:52:55 INFO - mozversion application_remotingname: firefox 13:52:55 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 13:52:55 INFO - mozversion application_vendor: Mozilla 13:52:55 INFO - mozversion application_version: 57.0a1 13:52:55 INFO - mozversion platform_buildid: 20170811193030 13:52:55 INFO - mozversion platform_changeset: d0afe5d6350426e338c1acff28a4a0c38ba1965f 13:52:55 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 13:52:55 INFO - mozversion platform_version: 57.0a1 13:52:55 INFO - using testdate: 1502484775 13:52:55 INFO - actual date: 1502484775 13:52:55 INFO - starting webserver on 'localhost:54015' 13:52:55 INFO - SUITE-START | Running 2 tests 13:52:55 INFO - TEST-START | dromaeo_css 13:52:55 INFO - Initialising browser for dromaeo_css test... 13:52:55 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:54015/getInfo.html -profile /tmp/tmpRUWa3d/profile 13:52:55 INFO - TEST-INFO | started process 11526 (/builds/slave/test/build/application/firefox/firefox http://localhost:54015/getInfo.html) 13:53:00 INFO - TEST-INFO | 11526: exit 0 13:53:01 INFO - Browser initialized. 13:53:01 INFO - Running cycle 1/1 for dromaeo_css test... 13:53:01 INFO - TEST-INFO | started process 11738 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpRUWa3d/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 13:53:01 INFO - PID 11738 | 13:53:01 INFO - PID 11738 | (/builds/slave/test/build/application/firefox/firefox:11787): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 13:53:01 INFO - PID 11738 | 13:53:12 INFO - PID 11738 | RSS: Main: 162406400 13:53:12 INFO - PID 11738 | 13:56:10 INFO - PID 11738 | Cycle 1(1): loaded http://localhost:54015/tests/dromaeo/cssquery-dojo.html (next: http://localhost:54015/tests/dromaeo/cssquery-ext.html) 13:56:11 INFO - PID 11738 | RSS: Main: 167456768 13:56:11 INFO - PID 11738 | 13:59:13 INFO - PID 11738 | Cycle 1(1): loaded http://localhost:54015/tests/dromaeo/cssquery-ext.html (next: http://localhost:54015/tests/dromaeo/cssquery-jquery.html) 13:59:13 INFO - PID 11738 | RSS: Main: 164409344 13:59:13 INFO - PID 11738 | 14:02:15 INFO - PID 11738 | Cycle 1(1): loaded http://localhost:54015/tests/dromaeo/cssquery-jquery.html (next: http://localhost:54015/tests/dromaeo/cssquery-mootools.html) 14:02:16 INFO - PID 11738 | RSS: Main: 166195200 14:02:16 INFO - PID 11738 | 14:05:17 INFO - PID 11738 | Cycle 1(1): loaded http://localhost:54015/tests/dromaeo/cssquery-mootools.html (next: http://localhost:54015/tests/dromaeo/cssquery-prototype.html) 14:05:18 INFO - PID 11738 | RSS: Main: 164876288 14:05:18 INFO - PID 11738 | 14:08:21 INFO - PID 11738 | Cycle 1(1): loaded http://localhost:54015/tests/dromaeo/cssquery-prototype.html (next: http://localhost:54015/tests/dromaeo/cssquery-yui.html) 14:08:22 INFO - PID 11738 | RSS: Main: 167567360 14:08:22 INFO - PID 11738 | 14:11:23 INFO - PID 11738 | Cycle 1(1): loaded http://localhost:54015/tests/dromaeo/cssquery-yui.html (next: http://localhost:54015/tests/dromaeo/cssquery-dojo.html) 14:11:23 INFO - PID 11738 | RSS: Main: 168919040 14:11:23 INFO - PID 11738 | 14:11:23 INFO - PID 11738 | __start_tp_report 14:11:23 INFO - PID 11738 | _x_x_mozilla_page_load 14:11:23 INFO - PID 11738 | _x_x_mozilla_page_load_details 14:11:23 INFO - PID 11738 | |i|pagename|runs| 14:11:23 INFO - PID 11738 | |0;dojo.html;3483.790972541646;3501.8774342898005;3502.737294702898;3517.6130625631185;3526.982365088176;6105.908411373827;6211.875762484748;6231.096491008807;6245.46913512352;6246.781362652308;6071.210742603455;6156.507479401648;6165.1677023601915;6176.629402235869;6185.690715464231;5422.593305502093;5431.4840090191365;5438.755256013469;5439.102548079562;5447.782088716446;5453.890922181554;5454.481824226692;5454.972725136368;5457.781688732446;5504.119340905456;5467.480589344006;5477.260569823083;5516.393196748354;5529.198266251391;5544.029794785896;5460.754266058037;5470.425605311465;5493.148561972901;5541.5289700375515;5545.805896793613;5033.219850923113;5281.973590132025;5373.194020896858;5416.8104116356135;5421.241026256327;6037.486813620803;6062.514998800129;6112.358202388774;6116.7553297868035;6124.938750612526;6658.766943156967;6688.29772873851;6744.7976560703255;6748.932510674879;6754.527183097185;6611.570247933917;6693.832654183684;6723.159605049369;6814.863702725967;6845.281245469254;6213.627182369072;6264.718087686065;6281.214848143936;6282.654454005028;6283.214598175228;6841;6853;6900.413464855544;6937.965310173417;6940.09778728762;6483.7082331295205;6578.210614726264;6600;6608.173978252718;6663;6652.268250492442;6660.800175994728;6676.599404035774;6742.83142921421;6767.086443330088;6592.901106483407;6632.701528431232;6693.933060669428;6699.062131301622;6723.932760672428;6697.531172817953;6706.96646516774;6784.016317633916;6786.083878676414;6794.76218332356;4762.976185119052;4814.9518504815205;4830;4861.586765125004;4869.878253043631;4280.571942805695;4316.287812510964;4351.08627188294;4353.542877997828;4384.320430333303;6209.2548894133;6278.6860656966965;6298.275698294663;6388.233411990498;6391.488680905516;6620.702068406933;6626.635535045619;6651.401373876374;6657.1012913257055;6658.966705166443;6279.968600157062;6284.24589049317;6294.181756371642;6295.433410993032;6304.684765761694;5384.434634363413;5387.326584176978;5388.56891448691;5393.649412788156;5400.594955378284;6929.1684997800585;6981.650917454107;6986.266442023616;6989.161300643854;7101.964490177516;6731.562448440738;6794.966025169842;6801.625910574966;6819.829504262235;6825.590464572141;7051.435885129074;7070.893936590853;7137.036500072424;7137.678804453916;7146.928530714834;6659.134312539339;6694;6737.59574425536;6766.830829229309;6769.559978601375;6665.200175978914;6702.564333318319;6741.359570840762;6787.5588086774205;6798.7280508779095;6525.934740652533;6540.771073012422;6542.803715888531;6553.344665533408;6585.736570537317;6478.70845811949;6486.027095935648;6562.114114594468;6577.868442631025;6595.604263744191;6401.263854656588;6435.227772667123;6461;6509.707063182073;6531.11829902957;6516.380943810331;6543.051257567531;6555.573887697285;6640.203175618956;6641.269460359454;6227.439530442282;6297.874042519033;6299.338569450142;6324.936750632619;6375.968120159369 14:11:23 INFO - PID 11738 | |1;ext.html;902.7562558109313;913.616281161912;934.5233930695346;962.6341990043786;970.4177493503903;36422.45366319504;37175.44236836449;45036.74816259186;45832.08335833281;45852.770736146354;45665.54334456655;45686.314705279365;45870.54129458704;46050.30924536135;46127.07745845081;7556.584387858652;7688.5771282579435;7719.112302085276;7721.03487064117;7746.728864489744;7628.160902300742;7722.304992550669;7724.304812566867;7730.0723913130505;7731.729389471369;7718.266764657376;7775.455718099735;7779.910812486257;7835.960820195891;7840.176781437953;7783.571903545303;7810.570418626973;7811.687532498693;7814.492058016211;7819.8436031279625;7501.28737769911;7523.510971786816;7549.094108706935;7562.735304264324;7604.467687261894;40547.18905621871;40730.185396291905;40788.38817417741;40798.38802417966;40847;3530.947035794465;3566.7503274770775;3577.177249232665;3597.7301702372165;3601.279744051174;32200.194995125075;32237.677623223703;32530.674693253;32561.209133497647;32785.36073196331;5071.290019397287;5184.818531351385;5217.165253559412;5228.633995620308;5254.97372513135;207798;207912;208730.95634521882;208963;209186;52473.47526524686;52514;52520;52525;52738;55248;55444.445555544735;55461.44538554644;55483.72258138764;55570;15101.244937753068;15498.84501154974;16159.353625855068;16602.83397166037;17083.316667333416;13048.021398395158;13079.215247085205;13082.803757943639;13098.148620339647;13104.410301536454;15368.615784605474;15455.072695638297;15491.922540387452;15508.069515829086;15680.510351516588;6045.244344456943;6047.334793172748;6066.787662431882;6091.2081429414775;6136.969315153396;1074.8280275155937;1102.8235482322789;1110.2062025651699;1113.259682311254;1117.8379135025375;24545.754542454702;25056.24831255065;25077.62383564248;25126.623100653505;25314;1220.7436438347868;1221.43813845632;1221.9511219551296;1222.9299363057326;1233.1984210263402;17279.74080388795;17394.65210695779;17640.38258660941;17845.52217610346;17894.194761235776;274204;275070;276690;277792;281204;61534.69232653808;61870.69064654648;61928.69035654793;61996;62005.68997154985;1491.5152575413035;1496.5959191018364;1555.5488908216491;1572.4653617770014;1576.519161655706;29586.260343491584;30156.24609384783;30267.394652106395;30328.84835575808;30509.69490305157;43273.78363108164;43519.34720979251;43613.56386436095;43653.34519982139;43666.34500482432;244049;244500;245008;245601;246714;35445;38781;40430.39354409745;40504.59495405008;40704.59295407127;50251.24623130729;50692.746536267085;50800.49199508106;50876.745616271684;51130;37371.439428408055;37583.81208093942;37943.430848536744;38015.239695206496;38229.23541529098;36452.45321320235;37075.62924370722;37283.25433491369;37370.813145934095;37389.439158412104;44195;44384.55615443804;44622.77688611536;44657;44778.3283250745;35619.82190089033;36369.454458183674;37186.87674511303;37239.813800930824;37311.44032839564;26751.86624066867;27005.864970675808;27242.72757272402;27442.313942151606;27526.724732752416 14:11:23 INFO - PID 11738 | |2;jquery.html;543.9755211015502;558.8574913397083;562.0978329780702;568.8037627018678;577.6389756402249;23131.768682313173;23722.05111795528;23886.5222695546;23918.40203994901;24752.13367532137;26950.59574106385;27398.452030959368;27424.17727468174;27444.039458618954;27451.588226176624;6472.870542589158;6574.3754343337305;6586.440152587036;6608.471322294205;6626.536142470029;6183.752649893999;6389.616623002611;6396.2324521057535;6435.356464353574;6444.709988050549;6400.103985442019;6405.135306733578;6408.1349017882685;6410;6411.775587854426;6408;6411.807645770635;6412.134361861135;6412.839679008039;6417.807465776034;5912;5927.792527261525;5937.524998000193;5939.4357536034;5946;31380;31607.52588711171;31969.360612787616;32140.196495087577;32150.678493215004;2258.6499092640665;2284.1434462076722;2292.4612716011725;2293.793558579719;2294.690216820741;20263.29078482261;20778;20802.89598552013;20814.27150049741;20831.479213019797;2406.759324067597;2454.938626534351;2468.469279104983;2500.8749562521984;2509.1594315904194;149467;151512;153088.2345588265;153519.2324038384;153776.23111884482;14921.179335136454;15623.531294061197;15780.842191578167;15908.44320448802;15994.440194593133;23238.53522929532;23945.640815387782;23954.40113997164;23989.160379386638;24025.399365015666;10734.624288149877;10738.463076846283;10830.945845270724;10887;10985.340879547253;10001.44992025431;10004.54979525923;10047.748806279755;10053.145482633912;10150.695479135638;9999.800003999879;10010.246157690866;10104.242181836391;10107.3430227035;10172.491375431347;2719.4511162932563;2735.6990731019573;2744.6294750208867;2746.4644394342913;2857.657081150275;1061.989380106189;1069.5668254356997;1071.35909981895;1075.6289080267295;1092.355510248957;22028.229011984502;22128.114875405125;22310.776892231195;22387.9925403354;22462.663060053786;1142.274655593704;1144.7481554058095;1153.4751687981948;1156.248438514972;1161.3670549550347;12155.453004614814;12487;12537.623871283877;12569.245845249314;12600.621981340575;561412;562789;569988;571547;572976;132967;138994;144361;145682;146034;1330.900182486298;1346.9259190744408;1389.6248013036422;1397.168684632642;1399.9440022399194;23036.429981455574;23140.652890207;23173.652395213747;23246.651300230173;23719.762802372446;66263.66868165821;67617;68430.65784671044;69922.65038674774;70310.64844675743;82042;82852.58573707093;83657.16342836738;85041.57479212564;85404.57297713471;15016.774748378564;15377.692446151239;15486.148261845707;15489;15514.612134696723;25143.87428062848;25369.87315063413;25758.484830303663;25854.87072564625;25927.48145037051;21008.789912100685;21170.682439763106;21250.14999400007;21301.46746331354;21329.253476128262;16281.837181628032;17505.737413938547;18234.72647910256;18403.72394414058;19467.415977520697;21751.238706645192;22174.88912555427;22196.334109976728;22238.888805555867;22352.88823555872;15141.167235802137;15266.465673701367;15273.541793746206;15290.388384464497;15353.6161595961;20684.58630827405;20896.37310880676;20946.895265523573;21041.158353665684;21045.368638940858 14:11:23 INFO - PID 11738 | |3;mootools.html;1426.8787153091987;1465.4651052365875;1465.985340146599;1488.0476495043174;1497.528278592244;15661.13863737494;16413.179341032945;16415.58961025975;16426.342946282133;16779;16389.180540972964;16668.58328541787;16669.41657042004;16670.58323541912;16681;2703.945921081582;2737.534619114755;2741.1091395296507;2753.6144939708356;2754.4628797384516;2596.5196438658813;2675.331167208198;2676.2907829425217;2676.7724743396834;2678.410749635077;2629.973700263002;2670.5727083666616;2677.4109695866878;2677.919662410121;2678.183154137987;2534.3157347516158;2543.910963116282;2548.1463709657196;2549.7195308516048;2558.5010922870047;2511.3972646564876;2512.8366656167473;2516.949661006788;2533.0247854575937;2541.263033720237;15714;15841;16063.518094457186;16063.518094457186;16078.678426431406;8288.088310285864;8547.74356769298;8581.570921453902;8589.312854971588;8600.827983440297;5449.618526703132;5608.588307027976;5633.183188437694;5714.371419143891;5754.74103665336;1896.6111947050822;1917.539790450282;1919.529715219766;1930.9324173653854;1951.1707524302115;28583.28541786451;28930.71069289301;28936.855315723285;28957.85521072402;29029;6875.621840798804;6889.758858440031;6949.93050069503;7035.92964070363;7090.680919358641;18755.812441875405;18760.437186884414;18770.81229187718;18771.24915003412;18828.623427531646;8373;8782.209601135928;8975.28197744179;8980.191782739585;8987.056359082333;6449.193850768654;6657.900131498031;6808.8978665320055;7927.048754149424;7968.163342849033;5244.554212891947;5399.055165346049;5423.972880135574;5427.701476418835;5491.423400542965;1440.9351579178963;1446.7540518111737;1450.2313773699957;1456.2063675296988;1459.839417664056;904.2765787370078;928.0765638190044;929.2380248196549;939.5537119868145;946.2477330522114;8031.638576264082;8052.396070294752;8069.919300807034;9676.225901927828;9867.75330616726;1033;1057.2282233969092;1062.2882668612049;1069.235496619905;1075.9623413180502;5432.130859062531;5585.357683866326;5765.4522820332;5799.449052340021;5819.767209311664;23570.646440303408;24011.63982540263;24271.878640607036;24279;24426.511469770507;23222.419439514146;24004.51990960206;24514.387140321636;24664.383390415383;24744.133955311838;12245.204061735958;12626.55807046749;12730.427130779137;12769.680757981125;12800.871991280153;9116.680916167903;9288.164065234161;9424.434533927986;9546.997565255548;9564.952175239358;20114.396568102395;20452.590948181252;20602.484937876674;21499.355019349445;21643.891780541;21113.366599002056;21115.472113197295;21277.46806329854;21316;21369.252076177258;13071.477140914258;13360.665983350105;13470.79793803074;13531.458741650618;13631.591052268448;15036.248187590796;15104.244787760348;15107;15221.619459513158;15223.619409514407;12365;12467.625971220878;12492.500299987898;12506.312152831682;12571.18287311322;12059.095567832623;12122.939385303018;12165.330906799856;12215.083868709704;12346.197497162655;10092.798144037224;10139.64511242103;10277.897221027693;10283.382997020202;10284.228682848965;7527.397808175442;7947.920520794718;7976.561289129154;8019.9198008019175;8098.190180981855;7942.44402891792;8049.798755031171;8054.959725201571;8073;8191.590420479071 14:11:23 INFO - PID 11738 | |4;prototype.html;512.5412755583752;519.75051975052;532.9971910948774;536.6029138437556;538.9703566303854;6142.631442113471;6150.846228844275;6213.440790328869;6243.250809902806;6257;6056.576039677225;6110.388961103888;6125.601835880665;6173.598716083451;6203.069539569067;4894.751838281251;4912.6315526335575;4927.556519913207;4945.876353091166;4973.502649735015;4640.605548528362;4794.664373493857;4898.828541001066;4935.53112454318;4982.252662100677;4735.431748190222;4760.476347601779;4761.166795810719;4775.331453596499;4789.7844596993045;4714.434267887841;4771.5467030632035;4780.16347139251;4841.56425921667;4860.951390486085;4302.548232435581;4313.741175529478;4338.652907767371;4344.478662560481;4355.542668019875;6022.608530445507;6050.848728781772;6069.817905462844;6117.388261173892;6122.846928826815;5661;5693.743781529841;5731.340895796995;5737.540996720252;5768.894353560962;6574.178227721535;6617.86764264712;6620.536562440631;6625.867482650368;6637.76767813129;4903.65674402792;4925.168028383658;4939.703617782909;4949.282354058677;4953.826616068456;6555.868882622321;6645.435138013275;6791.490638202204;6863.553868998499;6881.552699074544;5013.072581572421;5015.523525265094;5073.771680274396;5085.466026067284;5089;5092.898142037138;5115.437301896788;5153.922691159635;5159.277701121846;5184.870378240575;5720.342160651495;5744.597878148489;5750.166225897222;5784.1034639630925;5789.363170051291;6605.966970165215;6635.668216589152;6643.445756520238;6653.933460665428;6673.4661227101715;1745.8079611242754;1766.5760217547952;1789.2753434858903;1796.4520821149674;1808.5478630342413;1185.4191446191476;1220.261741646309;1235.8640549539543;1248.1325478792153;1262.7158889249845;6281.775053864544;6301.275353334425;6335.334789847;6357.936420635827;6382.32985536512;6642.335766423319;6744.224414192333;6754.594724316458;6784.559003664746;6805.421539169226;6179.6910154493;6252.155958945576;6319.210098737658;6328.177336946167;6329.240491141092;3524.7885126891956;3558;3601.603823579404;3616.5479315085613;3621.4748861414946;6956.130483689539;7052.435805135577;7086.291370862872;7096.290370962965;7190.568565886064;6913.239543650195;6914.827129321707;6922.273161317989;7006.264342244093;7015.158181018209;6594.604323740591;7002.7745144598475;7032.894506582507;7095.254998225112;7098.716051357887;6481.902771458526;6616.503762217757;6651.667416629052;6735.663216839041;6742.595444273359;6545.410913017851;6552.803415897531;6635.303293154149;6648.634325112165;6708.228553716385;7027.402670773042;7035.507514474142;7036.296370363128;7133.322334378226;7195.8920616191845;5016.172331565251;5018.5232402921665;5060.266261392151;5072.163093089746;5099.847004589868;6516.185476815398;6659.966700166662;6729.327067293231;6775.661216939232;6826.180858297036;6410.1987251593555;6459.903101453576;6481.837954051187;6567.9014814778775;6582.670866456754;6439.517036222208;6475.740970361133;6502.967485162544;6535.640539770168;6568.474522038321;6447.484201263794;6478.287388387368;6503.707333169924;6522.934770652422;6525.673716314261;6554.80335589933;6594.10979517759;6596.736130554724;6717.966410167918;6718.193816742022;6342.682865856596;6371.331010244043;6409.903851442139;6437.324080971431;6469.191351081115 14:11:23 INFO - PID 11738 | |5;yui.html;927.1053433436737;944.9463847809692;958.5399008475936;962.9311464274654;967.1972263021693;19055.618887622255;19912.5021874453;19915.103820328084;19938.70091948622;23373;21693.45766355842;22199.778002219973;22212.222572209976;22317.77682223177;22408.215712450066;1051.2483574244413;1071.8820929697727;1073.5866691323818;1074.9032587067163;1077.5420446310327;1056.96300629478;1086.6468397770716;1089.199438412766;1089.3681664634494;1097.6926460591046;1154.0017884529905;1154.8440960470355;1155.0240047160137;1158.866730326015;1159.843421138144;1146.1919346860484;1146.3752255020993;1148.7817314710178;1152.6772503698978;1155.9364234967074;845.8350621628784;846.5047946951041;849.5667209723024;849.7748096754365;851.2381418630291;20485.8975705122;20908.68636970447;21047.158113675436;21187.894060529597;21232.36302910915;23121.768782312298;23309.41726456852;23439.531209375888;23455.882720586287;23959.880200598884;16705.331786728515;17487;17767.733483997752;18675.97282149481;18831;3816.065064059323;3831.731778775487;3839.0594304395604;3839.731218814684;3841.673457756094;145086;146330.99999999892;147844;147859;149805.25097374443;17308.480745577654;17466.650666986843;17543.473695789147;17584.56038599045;17618.73571896397;33851.15372115717;34272.82863585666;34317.82841085779;34323;34701.47947780785;8510.36172287081;8867;9052.728418147466;9205.309601779893;9464.716058518256;4452.131834292347;4522.88692782683;4532.0709254602725;4558.840440584564;4570.360149579062;5505.807296744675;5656.943430565724;5980.312264089685;6094.603850749687;6163.445289923929;1152.8616566012133;1174.8237764335247;1198.6763573835017;1205.258765859008;1205.8311836342918;709.5848928376854;716.8243780273762;722.5447967780265;726.9963650181716;745.0537816972522;12894.935525322313;13041.739165216643;13325.400356983959;13789.448422063206;13884.444622214998;701.8315604254942;717.1573401253611;726.0162479839846;731.2614259597844;735.3161559749484;6283.96858015707;6448;6527.477801775846;6552.246491653425;6582.76960306387;134438;134582.32708836393;135302.32348838192;138505;140302;119066.40466797611;119340;119375;120988;121906;105229.42155867668;105876;107038;109609;110378;11865.940670296939;12150.635480935585;12230.205036672944;12248.326342051272;12334.259944403006;51528.22707659463;52027.47972520226;52085.7395713019;53481.7325913368;54431.72784136054;84469;86031.5698421529;86612.56693716491;88047;88903.55548222217;20934.58130837405;21317.147314107882;21585.460363491038;21626.026828792426;21874;23510.882445587664;24122.87938560296;24443.51112977766;24552.263432097065;24732.752672473045;21816.890915545322;22170.113195472;22316.442088947908;22349.10603575839;22531.436714081625;19198.232070717575;19229;19450;20863.37409877706;21274.255401060887;21071.683924740835;21586.136554537643;21666.89166554157;21685.457863553536;21722.456938576663;13664.31678416095;13802.930985345009;13978.23119728384;15363;15916.204189790233;15573.377064917277;16572.17139143062;16789;16922;17345.47963561095 14:11:23 INFO - PID 11738 | __end_tp_report 14:11:23 INFO - PID 11738 | __start_cc_report 14:11:23 INFO - PID 11738 | _x_x_mozilla_cycle_collect,332 14:11:23 INFO - PID 11738 | __end_cc_report 14:11:23 INFO - PID 11738 | __startTimestamp1502485883856__endTimestamp 14:11:23 INFO - PID 11738 | 14:11:23 INFO - PID 11738 | ------- Summary: start ------- 14:11:23 INFO - PID 11738 | Number of tests: 6 14:11:23 INFO - PID 11738 | 14:11:23 INFO - PID 11738 | [#0] dojo.html Cycles:165 Average:6154.81 Median:6461.00 stddev:804.22 (12.4%) stddev-sans-first:778.91 14:11:23 INFO - PID 11738 | Values: 3483.8 3501.9 3502.7 3517.6 3527.0 6105.9 6211.9 6231.1 6245.5 6246.8 6071.2 6156.5 6165.2 6176.6 6185.7 5422.6 5431.5 5438.8 5439.1 5447.8 5453.9 5454.5 5455.0 5457.8 5504.1 5467.5 5477.3 5516.4 5529.2 5544.0 5460.8 5470.4 5493.1 5541.5 5545.8 5033.2 5282.0 5373.2 5416.8 5421.2 6037.5 6062.5 6112.4 6116.8 6124.9 6658.8 6688.3 6744.8 6748.9 6754.5 6611.6 6693.8 6723.2 6814.9 6845.3 6213.6 6264.7 6281.2 6282.7 6283.2 6841.0 6853.0 6900.4 6938.0 6940.1 6483.7 6578.2 6600.0 6608.2 6663.0 6652.3 6660.8 6676.6 6742.8 6767.1 6592.9 6632.7 6693.9 6699.1 6723.9 6697.5 6707.0 6784.0 6786.1 6794.8 4763.0 4815.0 4830.0 4861.6 4869.9 4280.6 4316.3 4351.1 4353.5 4384.3 6209.3 6278.7 6298.3 6388.2 6391.5 6620.7 6626.6 6651.4 6657.1 6659.0 6280.0 6284.2 6294.2 6295.4 6304.7 5384.4 5387.3 5388.6 5393.6 5400.6 6929.2 6981.7 6986.3 6989.2 7102.0 6731.6 6795.0 6801.6 6819.8 6825.6 7051.4 7070.9 7137.0 7137.7 7146.9 6659.1 6694.0 6737.6 6766.8 6769.6 6665.2 6702.6 6741.4 6787.6 6798.7 6525.9 6540.8 6542.8 6553.3 6585.7 6478.7 6486.0 6562.1 6577.9 6595.6 6401.3 6435.2 6461.0 6509.7 6531.1 6516.4 6543.1 6555.6 6640.2 6641.3 6227.4 6297.9 6299.3 6324.9 6376.0 14:11:23 INFO - PID 11738 | 14:11:23 INFO - PID 11738 | [#1] ext.html Cycles:180 Average:43173.30 Median:37979.34 stddev:63703.20 (167.7%) stddev-sans-first:63802.83 14:11:23 INFO - PID 11738 | Values: 902.8 913.6 934.5 962.6 970.4 36422.5 37175.4 45036.7 45832.1 45852.8 45665.5 45686.3 45870.5 46050.3 46127.1 7556.6 7688.6 7719.1 7721.0 7746.7 7628.2 7722.3 7724.3 7730.1 7731.7 7718.3 7775.5 7779.9 7836.0 7840.2 7783.6 7810.6 7811.7 7814.5 7819.8 7501.3 7523.5 7549.1 7562.7 7604.5 40547.2 40730.2 40788.4 40798.4 40847.0 3530.9 3566.8 3577.2 3597.7 3601.3 32200.2 32237.7 32530.7 32561.2 32785.4 5071.3 5184.8 5217.2 5228.6 5255.0 207798.0 207912.0 208731.0 208963.0 209186.0 52473.5 52514.0 52520.0 52525.0 52738.0 55248.0 55444.4 55461.4 55483.7 55570.0 15101.2 15498.8 16159.4 16602.8 17083.3 13048.0 13079.2 13082.8 13098.1 13104.4 15368.6 15455.1 15491.9 15508.1 15680.5 6045.2 6047.3 6066.8 6091.2 6137.0 1074.8 1102.8 1110.2 1113.3 1117.8 24545.8 25056.2 25077.6 25126.6 25314.0 1220.7 1221.4 1222.0 1222.9 1233.2 17279.7 17394.7 17640.4 17845.5 17894.2 274204.0 275070.0 276690.0 277792.0 281204.0 61534.7 61870.7 61928.7 61996.0 62005.7 1491.5 1496.6 1555.5 1572.5 1576.5 29586.3 30156.2 30267.4 30328.8 30509.7 43273.8 43519.3 43613.6 43653.3 43666.3 244049.0 244500.0 245008.0 245601.0 246714.0 35445.0 38781.0 40430.4 40504.6 40704.6 50251.2 50692.7 50800.5 50876.7 51130.0 37371.4 37583.8 37943.4 38015.2 38229.2 36452.5 37075.6 37283.3 37370.8 37389.4 44195.0 44384.6 44622.8 44657.0 44778.3 35619.8 36369.5 37186.9 37239.8 37311.4 26751.9 27005.9 27242.7 27442.3 27526.7 14:11:23 INFO - PID 11738 | 14:11:23 INFO - PID 11738 | [#2] jquery.html Cycles:180 Average:39667.03 Median:2288.30 stddev:95840.09 (4188.3%) stddev-sans-first:96063.93 14:11:23 INFO - PID 11738 | Values: 544.0 558.9 562.1 568.8 577.6 23131.8 23722.1 23886.5 23918.4 24752.1 26950.6 27398.5 27424.2 27444.0 27451.6 6472.9 6574.4 6586.4 6608.5 6626.5 6183.8 6389.6 6396.2 6435.4 6444.7 6400.1 6405.1 6408.1 6410.0 6411.8 6408.0 6411.8 6412.1 6412.8 6417.8 5912.0 5927.8 5937.5 5939.4 5946.0 31380.0 31607.5 31969.4 32140.2 32150.7 2258.6 2284.1 2292.5 2293.8 2294.7 20263.3 20778.0 20802.9 20814.3 20831.5 2406.8 2454.9 2468.5 2500.9 2509.2 149467.0 151512.0 153088.2 153519.2 153776.2 14921.2 15623.5 15780.8 15908.4 15994.4 23238.5 23945.6 23954.4 23989.2 24025.4 10734.6 10738.5 10830.9 10887.0 10985.3 10001.4 10004.5 10047.7 10053.1 10150.7 9999.8 10010.2 10104.2 10107.3 10172.5 2719.5 2735.7 2744.6 2746.5 2857.7 1062.0 1069.6 1071.4 1075.6 1092.4 22028.2 22128.1 22310.8 22388.0 22462.7 1142.3 1144.7 1153.5 1156.2 1161.4 12155.5 12487.0 12537.6 12569.2 12600.6 561412.0 562789.0 569988.0 571547.0 572976.0 132967.0 138994.0 144361.0 145682.0 146034.0 1330.9 1346.9 1389.6 1397.2 1399.9 23036.4 23140.7 23173.7 23246.7 23719.8 66263.7 67617.0 68430.7 69922.7 70310.6 82042.0 82852.6 83657.2 85041.6 85404.6 15016.8 15377.7 15486.1 15489.0 15514.6 25143.9 25369.9 25758.5 25854.9 25927.5 21008.8 21170.7 21250.1 21301.5 21329.3 16281.8 17505.7 18234.7 18403.7 19467.4 21751.2 22174.9 22196.3 22238.9 22352.9 15141.2 15266.5 15273.5 15290.4 15353.6 20684.6 20896.4 20946.9 21041.2 21045.4 14:11:23 INFO - PID 11738 | 14:11:23 INFO - PID 11738 | [#3] mootools.html Cycles:180 Average:10148.11 Median:2512.12 stddev:7458.70 (296.9%) stddev-sans-first:7450.84 14:11:23 INFO - PID 11738 | Values: 1426.9 1465.5 1466.0 1488.0 1497.5 15661.1 16413.2 16415.6 16426.3 16779.0 16389.2 16668.6 16669.4 16670.6 16681.0 2703.9 2737.5 2741.1 2753.6 2754.5 2596.5 2675.3 2676.3 2676.8 2678.4 2630.0 2670.6 2677.4 2677.9 2678.2 2534.3 2543.9 2548.1 2549.7 2558.5 2511.4 2512.8 2516.9 2533.0 2541.3 15714.0 15841.0 16063.5 16063.5 16078.7 8288.1 8547.7 8581.6 8589.3 8600.8 5449.6 5608.6 5633.2 5714.4 5754.7 1896.6 1917.5 1919.5 1930.9 1951.2 28583.3 28930.7 28936.9 28957.9 29029.0 6875.6 6889.8 6949.9 7035.9 7090.7 18755.8 18760.4 18770.8 18771.2 18828.6 8373.0 8782.2 8975.3 8980.2 8987.1 6449.2 6657.9 6808.9 7927.0 7968.2 5244.6 5399.1 5424.0 5427.7 5491.4 1440.9 1446.8 1450.2 1456.2 1459.8 904.3 928.1 929.2 939.6 946.2 8031.6 8052.4 8069.9 9676.2 9867.8 1033.0 1057.2 1062.3 1069.2 1076.0 5432.1 5585.4 5765.5 5799.4 5819.8 23570.6 24011.6 24271.9 24279.0 24426.5 23222.4 24004.5 24514.4 24664.4 24744.1 12245.2 12626.6 12730.4 12769.7 12800.9 9116.7 9288.2 9424.4 9547.0 9565.0 20114.4 20452.6 20602.5 21499.4 21643.9 21113.4 21115.5 21277.5 21316.0 21369.3 13071.5 13360.7 13470.8 13531.5 13631.6 15036.2 15104.2 15107.0 15221.6 15223.6 12365.0 12467.6 12492.5 12506.3 12571.2 12059.1 12122.9 12165.3 12215.1 12346.2 10092.8 10139.6 10277.9 10283.4 10284.2 7527.4 7947.9 7976.6 8019.9 8098.2 7942.4 8049.8 8055.0 8073.0 8191.6 14:11:23 INFO - PID 11738 | 14:11:23 INFO - PID 11738 | [#4] prototype.html Cycles:180 Average:5578.39 Median:6254.58 stddev:1594.77 (25.5%) stddev-sans-first:1553.25 14:11:23 INFO - PID 11738 | Values: 512.5 519.8 533.0 536.6 539.0 6142.6 6150.8 6213.4 6243.3 6257.0 6056.6 6110.4 6125.6 6173.6 6203.1 4894.8 4912.6 4927.6 4945.9 4973.5 4640.6 4794.7 4898.8 4935.5 4982.3 4735.4 4760.5 4761.2 4775.3 4789.8 4714.4 4771.5 4780.2 4841.6 4861.0 4302.5 4313.7 4338.7 4344.5 4355.5 6022.6 6050.8 6069.8 6117.4 6122.8 5661.0 5693.7 5731.3 5737.5 5768.9 6574.2 6617.9 6620.5 6625.9 6637.8 4903.7 4925.2 4939.7 4949.3 4953.8 6555.9 6645.4 6791.5 6863.6 6881.6 5013.1 5015.5 5073.8 5085.5 5089.0 5092.9 5115.4 5153.9 5159.3 5184.9 5720.3 5744.6 5750.2 5784.1 5789.4 6606.0 6635.7 6643.4 6653.9 6673.5 1745.8 1766.6 1789.3 1796.5 1808.5 1185.4 1220.3 1235.9 1248.1 1262.7 6281.8 6301.3 6335.3 6357.9 6382.3 6642.3 6744.2 6754.6 6784.6 6805.4 6179.7 6252.2 6319.2 6328.2 6329.2 3524.8 3558.0 3601.6 3616.5 3621.5 6956.1 7052.4 7086.3 7096.3 7190.6 6913.2 6914.8 6922.3 7006.3 7015.2 6594.6 7002.8 7032.9 7095.3 7098.7 6481.9 6616.5 6651.7 6735.7 6742.6 6545.4 6552.8 6635.3 6648.6 6708.2 7027.4 7035.5 7036.3 7133.3 7195.9 5016.2 5018.5 5060.3 5072.2 5099.8 6516.2 6660.0 6729.3 6775.7 6826.2 6410.2 6459.9 6481.8 6567.9 6582.7 6439.5 6475.7 6503.0 6535.6 6568.5 6447.5 6478.3 6503.7 6522.9 6525.7 6554.8 6594.1 6596.7 6718.0 6718.2 6342.7 6371.3 6409.9 6437.3 6469.2 14:11:23 INFO - PID 11738 | 14:11:23 INFO - PID 11738 | [#5] yui.html Cycles:180 Average:28136.71 Median:21295.70 stddev:39327.75 (184.7%) stddev-sans-first:39385.01 14:11:23 INFO - PID 11738 | Values: 927.1 944.9 958.5 962.9 967.2 19055.6 19912.5 19915.1 19938.7 23373.0 21693.5 22199.8 22212.2 22317.8 22408.2 1051.2 1071.9 1073.6 1074.9 1077.5 1057.0 1086.6 1089.2 1089.4 1097.7 1154.0 1154.8 1155.0 1158.9 1159.8 1146.2 1146.4 1148.8 1152.7 1155.9 845.8 846.5 849.6 849.8 851.2 20485.9 20908.7 21047.2 21187.9 21232.4 23121.8 23309.4 23439.5 23455.9 23959.9 16705.3 17487.0 17767.7 18676.0 18831.0 3816.1 3831.7 3839.1 3839.7 3841.7 145086.0 146331.0 147844.0 147859.0 149805.3 17308.5 17466.7 17543.5 17584.6 17618.7 33851.2 34272.8 34317.8 34323.0 34701.5 8510.4 8867.0 9052.7 9205.3 9464.7 4452.1 4522.9 4532.1 4558.8 4570.4 5505.8 5656.9 5980.3 6094.6 6163.4 1152.9 1174.8 1198.7 1205.3 1205.8 709.6 716.8 722.5 727.0 745.1 12894.9 13041.7 13325.4 13789.4 13884.4 701.8 717.2 726.0 731.3 735.3 6284.0 6448.0 6527.5 6552.2 6582.8 134438.0 134582.3 135302.3 138505.0 140302.0 119066.4 119340.0 119375.0 120988.0 121906.0 105229.4 105876.0 107038.0 109609.0 110378.0 11865.9 12150.6 12230.2 12248.3 12334.3 51528.2 52027.5 52085.7 53481.7 54431.7 84469.0 86031.6 86612.6 88047.0 88903.6 20934.6 21317.1 21585.5 21626.0 21874.0 23510.9 24122.9 24443.5 24552.3 24732.8 21816.9 22170.1 22316.4 22349.1 22531.4 19198.2 19229.0 19450.0 20863.4 21274.3 21071.7 21586.1 21666.9 21685.5 21722.5 13664.3 13802.9 13978.2 15363.0 15916.2 15573.4 16572.2 16789.0 16922.0 17345.5 14:11:23 INFO - PID 11738 | -------- Summary: end -------- 14:11:23 INFO - PID 11738 | 14:11:24 INFO - TEST-INFO | 11738: exit 0 14:11:24 INFO - TEST-OK | dromaeo_css | took 1108747ms 14:11:24 INFO - TEST-START | kraken 14:11:24 INFO - Initialising browser for kraken test... 14:11:24 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:54015/getInfo.html -profile /tmp/tmp68mu9P/profile 14:11:24 INFO - TEST-INFO | started process 12106 (/builds/slave/test/build/application/firefox/firefox http://localhost:54015/getInfo.html) 14:11:29 INFO - TEST-INFO | 12106: exit 0 14:11:29 INFO - Browser initialized. 14:11:29 INFO - Running cycle 1/1 for kraken test... 14:11:29 INFO - TEST-INFO | started process 12316 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp68mu9P/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 14:11:30 INFO - PID 12316 | 14:11:30 INFO - PID 12316 | (/builds/slave/test/build/application/firefox/firefox:12365): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 14:11:30 INFO - PID 12316 | 14:11:40 INFO - PID 12316 | RSS: Main: 158126080 14:11:40 INFO - PID 12316 | 14:11:43 INFO - PID 12316 | Cycle 1(1): loaded http://localhost:54015/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:54015/tests/kraken/driver.html?testName=audio-beat-detection) 14:11:44 INFO - PID 12316 | RSS: Main: 164360192 14:11:44 INFO - PID 12316 | 14:11:46 INFO - PID 12316 | Cycle 1(1): loaded http://localhost:54015/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:54015/tests/kraken/driver.html?testName=audio-dft) 14:11:47 INFO - PID 12316 | RSS: Main: 168816640 14:11:47 INFO - PID 12316 | 14:11:50 INFO - PID 12316 | Cycle 1(1): loaded http://localhost:54015/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:54015/tests/kraken/driver.html?testName=audio-fft) 14:11:50 INFO - PID 12316 | RSS: Main: 161984512 14:11:50 INFO - PID 12316 | 14:11:53 INFO - PID 12316 | Cycle 1(1): loaded http://localhost:54015/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:54015/tests/kraken/driver.html?testName=audio-oscillator) 14:11:53 INFO - PID 12316 | RSS: Main: 163090432 14:11:53 INFO - PID 12316 | 14:11:55 INFO - PID 12316 | Cycle 1(1): loaded http://localhost:54015/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:54015/tests/kraken/driver.html?testName=imaging-gaussian-blur) 14:11:56 INFO - PID 12316 | RSS: Main: 163385344 14:11:56 INFO - PID 12316 | 14:11:59 INFO - PID 12316 | Cycle 1(1): loaded http://localhost:54015/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:54015/tests/kraken/driver.html?testName=imaging-darkroom) 14:11:59 INFO - PID 12316 | RSS: Main: 162967552 14:11:59 INFO - PID 12316 | 14:12:03 INFO - PID 12316 | Cycle 1(1): loaded http://localhost:54015/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:54015/tests/kraken/driver.html?testName=imaging-desaturate) 14:12:04 INFO - PID 12316 | RSS: Main: 165122048 14:12:04 INFO - PID 12316 | 14:12:06 INFO - PID 12316 | Cycle 1(1): loaded http://localhost:54015/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:54015/tests/kraken/driver.html?testName=json-parse-financial) 14:12:07 INFO - PID 12316 | RSS: Main: 165298176 14:12:07 INFO - PID 12316 | 14:12:08 INFO - PID 12316 | Cycle 1(1): loaded http://localhost:54015/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:54015/tests/kraken/driver.html?testName=json-stringify-tinderbox) 14:12:09 INFO - PID 12316 | RSS: Main: 165056512 14:12:09 INFO - PID 12316 | 14:12:11 INFO - PID 12316 | Cycle 1(1): loaded http://localhost:54015/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:54015/tests/kraken/driver.html?testName=stanford-crypto-aes) 14:12:11 INFO - PID 12316 | RSS: Main: 165752832 14:12:11 INFO - PID 12316 | 14:12:13 INFO - PID 12316 | Cycle 1(1): loaded http://localhost:54015/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:54015/tests/kraken/driver.html?testName=stanford-crypto-ccm) 14:12:14 INFO - PID 12316 | RSS: Main: 165289984 14:12:14 INFO - PID 12316 | 14:12:17 INFO - PID 12316 | Cycle 1(1): loaded http://localhost:54015/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:54015/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 14:12:17 INFO - PID 12316 | RSS: Main: 164745216 14:12:17 INFO - PID 12316 | 14:12:20 INFO - PID 12316 | Cycle 1(1): loaded http://localhost:54015/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:54015/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 14:12:21 INFO - PID 12316 | RSS: Main: 165699584 14:12:21 INFO - PID 12316 | 14:12:22 INFO - PID 12316 | Cycle 1(1): loaded http://localhost:54015/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:54015/tests/kraken/driver.html?testName=ai-astar) 14:12:23 INFO - PID 12316 | RSS: Main: 167022592 14:12:23 INFO - PID 12316 | 14:12:23 INFO - PID 12316 | __start_tp_report 14:12:23 INFO - PID 12316 | _x_x_mozilla_page_load 14:12:23 INFO - PID 12316 | _x_x_mozilla_page_load_details 14:12:23 INFO - PID 12316 | |i|pagename|runs| 14:12:23 INFO - PID 12316 | |0;ai-astar;96;107;98;107;109;108;107;99;106;109 14:12:23 INFO - PID 12316 | |1;audio-beat-detection;144;115;142;162;115;141;139;115;171;113 14:12:23 INFO - PID 12316 | |2;audio-dft;163;163;162;163;161;162;163;162;168;165 14:12:23 INFO - PID 12316 | |3;audio-fft;75;74;74;185;76;74;74;85;97;75 14:12:23 INFO - PID 12316 | |4;audio-oscillator;78;77;125;78;77;81;123;78;78;120 14:12:23 INFO - PID 12316 | |5;imaging-gaussian-blur;113;114;114;114;114;114;113;113;114;114 14:12:23 INFO - PID 12316 | |6;imaging-darkroom;148;148;151;148;150;149;150;155;148;148 14:12:23 INFO - PID 12316 | |7;imaging-desaturate;94;95;94;94;93;94;99;94;94;93 14:12:23 INFO - PID 12316 | |8;json-parse-financial;49;47;48;47;48;48;47;47;50;49 14:12:23 INFO - PID 12316 | |9;json-stringify-tinderbox;57;55;55;56;56;55;56;56;56;56 14:12:23 INFO - PID 12316 | |10;stanford-crypto-aes;77;74;75;74;78;74;73;75;75;75 14:12:23 INFO - PID 12316 | |11;stanford-crypto-ccm;127;121;115;115;123;122;124;119;121;160 14:12:23 INFO - PID 12316 | |12;stanford-crypto-pbkdf2;169;165;163;162;166;161;161;166;159;160 14:12:23 INFO - PID 12316 | |13;stanford-crypto-sha256-iterative;80;60;61;61;60;61;61;61;61;60 14:12:23 INFO - PID 12316 | __end_tp_report 14:12:23 INFO - PID 12316 | __start_cc_report 14:12:23 INFO - PID 12316 | _x_x_mozilla_cycle_collect,857 14:12:23 INFO - PID 12316 | __end_cc_report 14:12:23 INFO - PID 12316 | __startTimestamp1502485943242__endTimestamp 14:12:23 INFO - PID 12316 | 14:12:23 INFO - PID 12316 | ------- Summary: start ------- 14:12:23 INFO - PID 12316 | Number of tests: 14 14:12:23 INFO - PID 12316 | 14:12:23 INFO - PID 12316 | [#0] ai-astar Cycles:10 Average:104.60 Median:109.00 stddev:4.93 (4.5%) stddev-sans-first:4.13 14:12:23 INFO - PID 12316 | Values: 96.0 107.0 98.0 107.0 109.0 108.0 107.0 99.0 106.0 109.0 14:12:23 INFO - PID 12316 | 14:12:23 INFO - PID 12316 | [#1] audio-beat-detection Cycles:10 Average:135.70 Median:141.50 stddev:20.78 (14.7%) stddev-sans-first:21.82 14:12:23 INFO - PID 12316 | Values: 144.0 115.0 142.0 162.0 115.0 141.0 139.0 115.0 171.0 113.0 14:12:23 INFO - PID 12316 | 14:12:23 INFO - PID 12316 | [#2] audio-dft Cycles:10 Average:163.20 Median:163.00 stddev:1.99 (1.2%) stddev-sans-first:2.11 14:12:23 INFO - PID 12316 | Values: 163.0 163.0 162.0 163.0 161.0 162.0 163.0 162.0 168.0 165.0 14:12:23 INFO - PID 12316 | 14:12:23 INFO - PID 12316 | [#3] audio-fft Cycles:10 Average:88.90 Median:75.00 stddev:34.57 (46.1%) stddev-sans-first:36.30 14:12:23 INFO - PID 12316 | Values: 75.0 74.0 74.0 185.0 76.0 74.0 74.0 85.0 97.0 75.0 14:12:23 INFO - PID 12316 | 14:12:23 INFO - PID 12316 | [#4] audio-oscillator Cycles:10 Average:91.50 Median:78.00 stddev:21.57 (27.7%) stddev-sans-first:22.32 14:12:23 INFO - PID 12316 | Values: 78.0 77.0 125.0 78.0 77.0 81.0 123.0 78.0 78.0 120.0 14:12:23 INFO - PID 12316 | 14:12:23 INFO - PID 12316 | [#5] imaging-gaussian-blur Cycles:10 Average:113.70 Median:114.00 stddev:0.48 (0.4%) stddev-sans-first:0.44 14:12:23 INFO - PID 12316 | Values: 113.0 114.0 114.0 114.0 114.0 114.0 113.0 113.0 114.0 114.0 14:12:23 INFO - PID 12316 | 14:12:23 INFO - PID 12316 | [#6] imaging-darkroom Cycles:10 Average:149.50 Median:149.50 stddev:2.22 (1.5%) stddev-sans-first:2.29 14:12:23 INFO - PID 12316 | Values: 148.0 148.0 151.0 148.0 150.0 149.0 150.0 155.0 148.0 148.0 14:12:23 INFO - PID 12316 | 14:12:23 INFO - PID 12316 | [#7] imaging-desaturate Cycles:10 Average:94.40 Median:94.00 stddev:1.71 (1.8%) stddev-sans-first:1.81 14:12:23 INFO - PID 12316 | Values: 94.0 95.0 94.0 94.0 93.0 94.0 99.0 94.0 94.0 93.0 14:12:23 INFO - PID 12316 | 14:12:23 INFO - PID 12316 | [#8] json-parse-financial Cycles:10 Average:48.00 Median:48.00 stddev:1.05 (2.2%) stddev-sans-first:1.05 14:12:23 INFO - PID 12316 | Values: 49.0 47.0 48.0 47.0 48.0 48.0 47.0 47.0 50.0 49.0 14:12:23 INFO - PID 12316 | 14:12:23 INFO - PID 12316 | [#9] json-stringify-tinderbox Cycles:10 Average:55.80 Median:56.00 stddev:0.63 (1.1%) stddev-sans-first:0.50 14:12:23 INFO - PID 12316 | Values: 57.0 55.0 55.0 56.0 56.0 55.0 56.0 56.0 56.0 56.0 14:12:23 INFO - PID 12316 | 14:12:23 INFO - PID 12316 | [#10] stanford-crypto-aes Cycles:10 Average:75.00 Median:75.00 stddev:1.49 (2.0%) stddev-sans-first:1.39 14:12:23 INFO - PID 12316 | Values: 77.0 74.0 75.0 74.0 78.0 74.0 73.0 75.0 75.0 75.0 14:12:23 INFO - PID 12316 | 14:12:23 INFO - PID 12316 | [#11] stanford-crypto-ccm Cycles:10 Average:124.70 Median:122.50 stddev:12.95 (10.6%) stddev-sans-first:13.71 14:12:23 INFO - PID 12316 | Values: 127.0 121.0 115.0 115.0 123.0 122.0 124.0 119.0 121.0 160.0 14:12:23 INFO - PID 12316 | 14:12:23 INFO - PID 12316 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:163.20 Median:164.00 stddev:3.19 (1.9%) stddev-sans-first:2.60 14:12:23 INFO - PID 12316 | Values: 169.0 165.0 163.0 162.0 166.0 161.0 161.0 166.0 159.0 160.0 14:12:23 INFO - PID 12316 | 14:12:23 INFO - PID 12316 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:62.60 Median:61.00 stddev:6.13 (10.1%) stddev-sans-first:0.50 14:12:23 INFO - PID 12316 | Values: 80.0 60.0 61.0 61.0 60.0 61.0 61.0 61.0 61.0 60.0 14:12:23 INFO - PID 12316 | -------- Summary: end -------- 14:12:23 INFO - PID 12316 | 14:12:23 INFO - PID 12316 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 14:12:23 INFO - TEST-INFO | 12316: exit 0 14:12:23 INFO - TEST-OK | kraken | took 59405ms 14:12:23 INFO - SUITE-END | took 1168s 14:12:24 INFO - Completed test suite (00:19:28) 14:12:24 INFO - javascript benchmark 14:12:24 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 9072.937249900737, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3483.790972541646, 3501.8774342898005, 3502.737294702898, 3517.6130625631185, 3526.982365088176, 6105.908411373827, 6211.875762484748, 6231.096491008807, 6245.46913512352, 6246.781362652308, 6071.210742603455, 6156.507479401648, 6165.1677023601915, 6176.629402235869, 6185.690715464231, 5422.593305502093, 5431.4840090191365, 5438.755256013469, 5439.102548079562, 5447.782088716446, 5453.890922181554, 5454.481824226692, 5454.972725136368, 5457.781688732446, 5504.119340905456, 5467.480589344006, 5477.260569823083, 5516.393196748354, 5529.198266251391, 5544.029794785896, 5460.754266058037, 5470.425605311465, 5493.148561972901, 5541.5289700375515, 5545.805896793613, 5033.219850923113, 5281.973590132025, 5373.194020896858, 5416.8104116356135, 5421.241026256327, 6037.486813620803, 6062.514998800129, 6112.358202388774, 6116.7553297868035, 6124.938750612526, 6658.766943156967, 6688.29772873851, 6744.7976560703255, 6748.932510674879, 6754.527183097185, 6611.570247933917, 6693.832654183684, 6723.159605049369, 6814.863702725967, 6845.281245469254, 6213.627182369072, 6264.718087686065, 6281.214848143936, 6282.654454005028, 6283.214598175228, 6841.0, 6853.0, 6900.413464855544, 6937.965310173417, 6940.09778728762, 6483.7082331295205, 6578.210614726264, 6600.0, 6608.173978252718, 6663.0, 6652.268250492442, 6660.800175994728, 6676.599404035774, 6742.83142921421, 6767.086443330088, 6592.901106483407, 6632.701528431232, 6693.933060669428, 6699.062131301622, 6723.932760672428, 6697.531172817953, 6706.96646516774, 6784.016317633916, 6786.083878676414, 6794.76218332356, 4762.976185119052, 4814.9518504815205, 4830.0, 4861.586765125004, 4869.878253043631, 4280.571942805695, 4316.287812510964, 4351.08627188294, 4353.542877997828, 4384.320430333303, 6209.2548894133, 6278.6860656966965, 6298.275698294663, 6388.233411990498, 6391.488680905516, 6620.702068406933, 6626.635535045619, 6651.401373876374, 6657.1012913257055, 6658.966705166443, 6279.968600157062, 6284.24589049317, 6294.181756371642, 6295.433410993032, 6304.684765761694, 5384.434634363413, 5387.326584176978, 5388.56891448691, 5393.649412788156, 5400.594955378284, 6929.1684997800585, 6981.650917454107, 6986.266442023616, 6989.161300643854, 7101.964490177516, 6731.562448440738, 6794.966025169842, 6801.625910574966, 6819.829504262235, 6825.590464572141, 7051.435885129074, 7070.893936590853, 7137.036500072424, 7137.678804453916, 7146.928530714834, 6659.134312539339, 6694.0, 6737.59574425536, 6766.830829229309, 6769.559978601375, 6665.200175978914, 6702.564333318319, 6741.359570840762, 6787.5588086774205, 6798.7280508779095, 6525.934740652533, 6540.771073012422, 6542.803715888531, 6553.344665533408, 6585.736570537317, 6478.70845811949, 6486.027095935648, 6562.114114594468, 6577.868442631025, 6595.604263744191, 6401.263854656588, 6435.227772667123, 6461.0, 6509.707063182073, 6531.11829902957, 6516.380943810331, 6543.051257567531, 6555.573887697285, 6640.203175618956, 6641.269460359454, 6227.439530442282, 6297.874042519033, 6299.338569450142, 6324.936750632619, 6375.968120159369], "value": 6093.144570467369, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [902.7562558109313, 913.616281161912, 934.5233930695346, 962.6341990043786, 970.4177493503903, 36422.45366319504, 37175.44236836449, 45036.74816259186, 45832.08335833281, 45852.770736146354, 45665.54334456655, 45686.314705279365, 45870.54129458704, 46050.30924536135, 46127.07745845081, 7556.584387858652, 7688.5771282579435, 7719.112302085276, 7721.03487064117, 7746.728864489744, 7628.160902300742, 7722.304992550669, 7724.304812566867, 7730.0723913130505, 7731.729389471369, 7718.266764657376, 7775.455718099735, 7779.910812486257, 7835.960820195891, 7840.176781437953, 7783.571903545303, 7810.570418626973, 7811.687532498693, 7814.492058016211, 7819.8436031279625, 7501.28737769911, 7523.510971786816, 7549.094108706935, 7562.735304264324, 7604.467687261894, 40547.18905621871, 40730.185396291905, 40788.38817417741, 40798.38802417966, 40847.0, 3530.947035794465, 3566.7503274770775, 3577.177249232665, 3597.7301702372165, 3601.279744051174, 32200.194995125075, 32237.677623223703, 32530.674693253, 32561.209133497647, 32785.36073196331, 5071.290019397287, 5184.818531351385, 5217.165253559412, 5228.633995620308, 5254.97372513135, 207798.0, 207912.0, 208730.95634521882, 208963.0, 209186.0, 52473.47526524686, 52514.0, 52520.0, 52525.0, 52738.0, 55248.0, 55444.445555544735, 55461.44538554644, 55483.72258138764, 55570.0, 15101.244937753068, 15498.84501154974, 16159.353625855068, 16602.83397166037, 17083.316667333416, 13048.021398395158, 13079.215247085205, 13082.803757943639, 13098.148620339647, 13104.410301536454, 15368.615784605474, 15455.072695638297, 15491.922540387452, 15508.069515829086, 15680.510351516588, 6045.244344456943, 6047.334793172748, 6066.787662431882, 6091.2081429414775, 6136.969315153396, 1074.8280275155937, 1102.8235482322789, 1110.2062025651699, 1113.259682311254, 1117.8379135025375, 24545.754542454702, 25056.24831255065, 25077.62383564248, 25126.623100653505, 25314.0, 1220.7436438347868, 1221.43813845632, 1221.9511219551296, 1222.9299363057326, 1233.1984210263402, 17279.74080388795, 17394.65210695779, 17640.38258660941, 17845.52217610346, 17894.194761235776, 274204.0, 275070.0, 276690.0, 277792.0, 281204.0, 61534.69232653808, 61870.69064654648, 61928.69035654793, 61996.0, 62005.68997154985, 1491.5152575413035, 1496.5959191018364, 1555.5488908216491, 1572.4653617770014, 1576.519161655706, 29586.260343491584, 30156.24609384783, 30267.394652106395, 30328.84835575808, 30509.69490305157, 43273.78363108164, 43519.34720979251, 43613.56386436095, 43653.34519982139, 43666.34500482432, 244049.0, 244500.0, 245008.0, 245601.0, 246714.0, 35445.0, 38781.0, 40430.39354409745, 40504.59495405008, 40704.59295407127, 50251.24623130729, 50692.746536267085, 50800.49199508106, 50876.745616271684, 51130.0, 37371.439428408055, 37583.81208093942, 37943.430848536744, 38015.239695206496, 38229.23541529098, 36452.45321320235, 37075.62924370722, 37283.25433491369, 37370.813145934095, 37389.439158412104, 44195.0, 44384.55615443804, 44622.77688611536, 44657.0, 44778.3283250745, 35619.82190089033, 36369.454458183674, 37186.87674511303, 37239.813800930824, 37311.44032839564, 26751.86624066867, 27005.864970675808, 27242.72757272402, 27442.313942151606, 27526.724732752416], "value": 18911.394368898385, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [543.9755211015502, 558.8574913397083, 562.0978329780702, 568.8037627018678, 577.6389756402249, 23131.768682313173, 23722.05111795528, 23886.5222695546, 23918.40203994901, 24752.13367532137, 26950.59574106385, 27398.452030959368, 27424.17727468174, 27444.039458618954, 27451.588226176624, 6472.870542589158, 6574.3754343337305, 6586.440152587036, 6608.471322294205, 6626.536142470029, 6183.752649893999, 6389.616623002611, 6396.2324521057535, 6435.356464353574, 6444.709988050549, 6400.103985442019, 6405.135306733578, 6408.1349017882685, 6410.0, 6411.775587854426, 6408.0, 6411.807645770635, 6412.134361861135, 6412.839679008039, 6417.807465776034, 5912.0, 5927.792527261525, 5937.524998000193, 5939.4357536034, 5946.0, 31380.0, 31607.52588711171, 31969.360612787616, 32140.196495087577, 32150.678493215004, 2258.6499092640665, 2284.1434462076722, 2292.4612716011725, 2293.793558579719, 2294.690216820741, 20263.29078482261, 20778.0, 20802.89598552013, 20814.27150049741, 20831.479213019797, 2406.759324067597, 2454.938626534351, 2468.469279104983, 2500.8749562521984, 2509.1594315904194, 149467.0, 151512.0, 153088.2345588265, 153519.2324038384, 153776.23111884482, 14921.179335136454, 15623.531294061197, 15780.842191578167, 15908.44320448802, 15994.440194593133, 23238.53522929532, 23945.640815387782, 23954.40113997164, 23989.160379386638, 24025.399365015666, 10734.624288149877, 10738.463076846283, 10830.945845270724, 10887.0, 10985.340879547253, 10001.44992025431, 10004.54979525923, 10047.748806279755, 10053.145482633912, 10150.695479135638, 9999.800003999879, 10010.246157690866, 10104.242181836391, 10107.3430227035, 10172.491375431347, 2719.4511162932563, 2735.6990731019573, 2744.6294750208867, 2746.4644394342913, 2857.657081150275, 1061.989380106189, 1069.5668254356997, 1071.35909981895, 1075.6289080267295, 1092.355510248957, 22028.229011984502, 22128.114875405125, 22310.776892231195, 22387.9925403354, 22462.663060053786, 1142.274655593704, 1144.7481554058095, 1153.4751687981948, 1156.248438514972, 1161.3670549550347, 12155.453004614814, 12487.0, 12537.623871283877, 12569.245845249314, 12600.621981340575, 561412.0, 562789.0, 569988.0, 571547.0, 572976.0, 132967.0, 138994.0, 144361.0, 145682.0, 146034.0, 1330.900182486298, 1346.9259190744408, 1389.6248013036422, 1397.168684632642, 1399.9440022399194, 23036.429981455574, 23140.652890207, 23173.652395213747, 23246.651300230173, 23719.762802372446, 66263.66868165821, 67617.0, 68430.65784671044, 69922.65038674774, 70310.64844675743, 82042.0, 82852.58573707093, 83657.16342836738, 85041.57479212564, 85404.57297713471, 15016.774748378564, 15377.692446151239, 15486.148261845707, 15489.0, 15514.612134696723, 25143.87428062848, 25369.87315063413, 25758.484830303663, 25854.87072564625, 25927.48145037051, 21008.789912100685, 21170.682439763106, 21250.14999400007, 21301.46746331354, 21329.253476128262, 16281.837181628032, 17505.737413938547, 18234.72647910256, 18403.72394414058, 19467.415977520697, 21751.238706645192, 22174.88912555427, 22196.334109976728, 22238.888805555867, 22352.88823555872, 15141.167235802137, 15266.465673701367, 15273.541793746206, 15290.388384464497, 15353.6161595961, 20684.58630827405, 20896.37310880676, 20946.895265523573, 21041.158353665684, 21045.368638940858], "value": 13008.420831823869, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1426.8787153091987, 1465.4651052365875, 1465.985340146599, 1488.0476495043174, 1497.528278592244, 15661.13863737494, 16413.179341032945, 16415.58961025975, 16426.342946282133, 16779.0, 16389.180540972964, 16668.58328541787, 16669.41657042004, 16670.58323541912, 16681.0, 2703.945921081582, 2737.534619114755, 2741.1091395296507, 2753.6144939708356, 2754.4628797384516, 2596.5196438658813, 2675.331167208198, 2676.2907829425217, 2676.7724743396834, 2678.410749635077, 2629.973700263002, 2670.5727083666616, 2677.4109695866878, 2677.919662410121, 2678.183154137987, 2534.3157347516158, 2543.910963116282, 2548.1463709657196, 2549.7195308516048, 2558.5010922870047, 2511.3972646564876, 2512.8366656167473, 2516.949661006788, 2533.0247854575937, 2541.263033720237, 15714.0, 15841.0, 16063.518094457186, 16063.518094457186, 16078.678426431406, 8288.088310285864, 8547.74356769298, 8581.570921453902, 8589.312854971588, 8600.827983440297, 5449.618526703132, 5608.588307027976, 5633.183188437694, 5714.371419143891, 5754.74103665336, 1896.6111947050822, 1917.539790450282, 1919.529715219766, 1930.9324173653854, 1951.1707524302115, 28583.28541786451, 28930.71069289301, 28936.855315723285, 28957.85521072402, 29029.0, 6875.621840798804, 6889.758858440031, 6949.93050069503, 7035.92964070363, 7090.680919358641, 18755.812441875405, 18760.437186884414, 18770.81229187718, 18771.24915003412, 18828.623427531646, 8373.0, 8782.209601135928, 8975.28197744179, 8980.191782739585, 8987.056359082333, 6449.193850768654, 6657.900131498031, 6808.8978665320055, 7927.048754149424, 7968.163342849033, 5244.554212891947, 5399.055165346049, 5423.972880135574, 5427.701476418835, 5491.423400542965, 1440.9351579178963, 1446.7540518111737, 1450.2313773699957, 1456.2063675296988, 1459.839417664056, 904.2765787370078, 928.0765638190044, 929.2380248196549, 939.5537119868145, 946.2477330522114, 8031.638576264082, 8052.396070294752, 8069.919300807034, 9676.225901927828, 9867.75330616726, 1033.0, 1057.2282233969092, 1062.2882668612049, 1069.235496619905, 1075.9623413180502, 5432.130859062531, 5585.357683866326, 5765.4522820332, 5799.449052340021, 5819.767209311664, 23570.646440303408, 24011.63982540263, 24271.878640607036, 24279.0, 24426.511469770507, 23222.419439514146, 24004.51990960206, 24514.387140321636, 24664.383390415383, 24744.133955311838, 12245.204061735958, 12626.55807046749, 12730.427130779137, 12769.680757981125, 12800.871991280153, 9116.680916167903, 9288.164065234161, 9424.434533927986, 9546.997565255548, 9564.952175239358, 20114.396568102395, 20452.590948181252, 20602.484937876674, 21499.355019349445, 21643.891780541, 21113.366599002056, 21115.472113197295, 21277.46806329854, 21316.0, 21369.252076177258, 13071.477140914258, 13360.665983350105, 13470.79793803074, 13531.458741650618, 13631.591052268448, 15036.248187590796, 15104.244787760348, 15107.0, 15221.619459513158, 15223.619409514407, 12365.0, 12467.625971220878, 12492.500299987898, 12506.312152831682, 12571.18287311322, 12059.095567832623, 12122.939385303018, 12165.330906799856, 12215.083868709704, 12346.197497162655, 10092.798144037224, 10139.64511242103, 10277.897221027693, 10283.382997020202, 10284.228682848965, 7527.397808175442, 7947.920520794718, 7976.561289129154, 8019.9198008019175, 8098.190180981855, 7942.44402891792, 8049.798755031171, 8054.959725201571, 8073.0, 8191.590420479071], "value": 7087.785026660384, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [512.5412755583752, 519.75051975052, 532.9971910948774, 536.6029138437556, 538.9703566303854, 6142.631442113471, 6150.846228844275, 6213.440790328869, 6243.250809902806, 6257.0, 6056.576039677225, 6110.388961103888, 6125.601835880665, 6173.598716083451, 6203.069539569067, 4894.751838281251, 4912.6315526335575, 4927.556519913207, 4945.876353091166, 4973.502649735015, 4640.605548528362, 4794.664373493857, 4898.828541001066, 4935.53112454318, 4982.252662100677, 4735.431748190222, 4760.476347601779, 4761.166795810719, 4775.331453596499, 4789.7844596993045, 4714.434267887841, 4771.5467030632035, 4780.16347139251, 4841.56425921667, 4860.951390486085, 4302.548232435581, 4313.741175529478, 4338.652907767371, 4344.478662560481, 4355.542668019875, 6022.608530445507, 6050.848728781772, 6069.817905462844, 6117.388261173892, 6122.846928826815, 5661.0, 5693.743781529841, 5731.340895796995, 5737.540996720252, 5768.894353560962, 6574.178227721535, 6617.86764264712, 6620.536562440631, 6625.867482650368, 6637.76767813129, 4903.65674402792, 4925.168028383658, 4939.703617782909, 4949.282354058677, 4953.826616068456, 6555.868882622321, 6645.435138013275, 6791.490638202204, 6863.553868998499, 6881.552699074544, 5013.072581572421, 5015.523525265094, 5073.771680274396, 5085.466026067284, 5089.0, 5092.898142037138, 5115.437301896788, 5153.922691159635, 5159.277701121846, 5184.870378240575, 5720.342160651495, 5744.597878148489, 5750.166225897222, 5784.1034639630925, 5789.363170051291, 6605.966970165215, 6635.668216589152, 6643.445756520238, 6653.933460665428, 6673.4661227101715, 1745.8079611242754, 1766.5760217547952, 1789.2753434858903, 1796.4520821149674, 1808.5478630342413, 1185.4191446191476, 1220.261741646309, 1235.8640549539543, 1248.1325478792153, 1262.7158889249845, 6281.775053864544, 6301.275353334425, 6335.334789847, 6357.936420635827, 6382.32985536512, 6642.335766423319, 6744.224414192333, 6754.594724316458, 6784.559003664746, 6805.421539169226, 6179.6910154493, 6252.155958945576, 6319.210098737658, 6328.177336946167, 6329.240491141092, 3524.7885126891956, 3558.0, 3601.603823579404, 3616.5479315085613, 3621.4748861414946, 6956.130483689539, 7052.435805135577, 7086.291370862872, 7096.290370962965, 7190.568565886064, 6913.239543650195, 6914.827129321707, 6922.273161317989, 7006.264342244093, 7015.158181018209, 6594.604323740591, 7002.7745144598475, 7032.894506582507, 7095.254998225112, 7098.716051357887, 6481.902771458526, 6616.503762217757, 6651.667416629052, 6735.663216839041, 6742.595444273359, 6545.410913017851, 6552.803415897531, 6635.303293154149, 6648.634325112165, 6708.228553716385, 7027.402670773042, 7035.507514474142, 7036.296370363128, 7133.322334378226, 7195.8920616191845, 5016.172331565251, 5018.5232402921665, 5060.266261392151, 5072.163093089746, 5099.847004589868, 6516.185476815398, 6659.966700166662, 6729.327067293231, 6775.661216939232, 6826.180858297036, 6410.1987251593555, 6459.903101453576, 6481.837954051187, 6567.9014814778775, 6582.670866456754, 6439.517036222208, 6475.740970361133, 6502.967485162544, 6535.640539770168, 6568.474522038321, 6447.484201263794, 6478.287388387368, 6503.707333169924, 6522.934770652422, 6525.673716314261, 6554.80335589933, 6594.10979517759, 6596.736130554724, 6717.966410167918, 6718.193816742022, 6342.682865856596, 6371.331010244043, 6409.903851442139, 6437.324080971431, 6469.191351081115], "value": 5111.8012763859215, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [927.1053433436737, 944.9463847809692, 958.5399008475936, 962.9311464274654, 967.1972263021693, 19055.618887622255, 19912.5021874453, 19915.103820328084, 19938.70091948622, 23373.0, 21693.45766355842, 22199.778002219973, 22212.222572209976, 22317.77682223177, 22408.215712450066, 1051.2483574244413, 1071.8820929697727, 1073.5866691323818, 1074.9032587067163, 1077.5420446310327, 1056.96300629478, 1086.6468397770716, 1089.199438412766, 1089.3681664634494, 1097.6926460591046, 1154.0017884529905, 1154.8440960470355, 1155.0240047160137, 1158.866730326015, 1159.843421138144, 1146.1919346860484, 1146.3752255020993, 1148.7817314710178, 1152.6772503698978, 1155.9364234967074, 845.8350621628784, 846.5047946951041, 849.5667209723024, 849.7748096754365, 851.2381418630291, 20485.8975705122, 20908.68636970447, 21047.158113675436, 21187.894060529597, 21232.36302910915, 23121.768782312298, 23309.41726456852, 23439.531209375888, 23455.882720586287, 23959.880200598884, 16705.331786728515, 17487.0, 17767.733483997752, 18675.97282149481, 18831.0, 3816.065064059323, 3831.731778775487, 3839.0594304395604, 3839.731218814684, 3841.673457756094, 145086.0, 146330.99999999892, 147844.0, 147859.0, 149805.25097374443, 17308.480745577654, 17466.650666986843, 17543.473695789147, 17584.56038599045, 17618.73571896397, 33851.15372115717, 34272.82863585666, 34317.82841085779, 34323.0, 34701.47947780785, 8510.36172287081, 8867.0, 9052.728418147466, 9205.309601779893, 9464.716058518256, 4452.131834292347, 4522.88692782683, 4532.0709254602725, 4558.840440584564, 4570.360149579062, 5505.807296744675, 5656.943430565724, 5980.312264089685, 6094.603850749687, 6163.445289923929, 1152.8616566012133, 1174.8237764335247, 1198.6763573835017, 1205.258765859008, 1205.8311836342918, 709.5848928376854, 716.8243780273762, 722.5447967780265, 726.9963650181716, 745.0537816972522, 12894.935525322313, 13041.739165216643, 13325.400356983959, 13789.448422063206, 13884.444622214998, 701.8315604254942, 717.1573401253611, 726.0162479839846, 731.2614259597844, 735.3161559749484, 6283.96858015707, 6448.0, 6527.477801775846, 6552.246491653425, 6582.76960306387, 134438.0, 134582.32708836393, 135302.32348838192, 138505.0, 140302.0, 119066.40466797611, 119340.0, 119375.0, 120988.0, 121906.0, 105229.42155867668, 105876.0, 107038.0, 109609.0, 110378.0, 11865.940670296939, 12150.635480935585, 12230.205036672944, 12248.326342051272, 12334.259944403006, 51528.22707659463, 52027.47972520226, 52085.7395713019, 53481.7325913368, 54431.72784136054, 84469.0, 86031.5698421529, 86612.56693716491, 88047.0, 88903.55548222217, 20934.58130837405, 21317.147314107882, 21585.460363491038, 21626.026828792426, 21874.0, 23510.882445587664, 24122.87938560296, 24443.51112977766, 24552.263432097065, 24732.752672473045, 21816.890915545322, 22170.113195472, 22316.442088947908, 22349.10603575839, 22531.436714081625, 19198.232070717575, 19229.0, 19450.0, 20863.37409877706, 21274.255401060887, 21071.683924740835, 21586.136554537643, 21666.89166554157, 21685.457863553536, 21722.456938576663, 13664.31678416095, 13802.930985345009, 13978.23119728384, 15363.0, 15916.204189790233, 15573.377064917277, 16572.17139143062, 16789.0, 16922.0, 17345.47963561095], "value": 10270.329935183237, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1470.8, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 107.0, 98.0, 107.0, 109.0, 108.0, 107.0, 99.0, 106.0, 109.0], "value": 104.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [144.0, 115.0, 142.0, 162.0, 115.0, 141.0, 139.0, 115.0, 171.0, 113.0], "value": 135.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 163.0, 162.0, 163.0, 161.0, 162.0, 163.0, 162.0, 168.0, 165.0], "value": 163.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 74.0, 74.0, 185.0, 76.0, 74.0, 74.0, 85.0, 97.0, 75.0], "value": 88.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 77.0, 125.0, 78.0, 77.0, 81.0, 123.0, 78.0, 78.0, 120.0], "value": 91.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 114.0, 114.0, 114.0, 114.0, 114.0, 113.0, 113.0, 114.0, 114.0], "value": 113.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 148.0, 151.0, 148.0, 150.0, 149.0, 150.0, 155.0, 148.0, 148.0], "value": 149.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 94.0, 94.0, 93.0, 94.0, 99.0, 94.0, 94.0, 93.0], "value": 94.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [49.0, 47.0, 48.0, 47.0, 48.0, 48.0, 47.0, 47.0, 50.0, 49.0], "value": 48.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 55.0, 55.0, 56.0, 56.0, 55.0, 56.0, 56.0, 56.0, 56.0], "value": 55.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 74.0, 75.0, 74.0, 78.0, 74.0, 73.0, 75.0, 75.0, 75.0], "value": 75.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [127.0, 121.0, 115.0, 115.0, 123.0, 122.0, 124.0, 119.0, 121.0, 160.0], "value": 124.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [169.0, 165.0, 163.0, 162.0, 166.0, 161.0, 161.0, 166.0, 159.0, 160.0], "value": 163.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 60.0, 61.0, 61.0, 60.0, 61.0, 61.0, 61.0, 61.0, 60.0], "value": 62.6, "unit": "score"}]}]} 14:12:24 INFO - Return code: 0 14:12:24 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 14:12:24 INFO - # TBPL SUCCESS # 14:12:24 INFO - Running post-action listener: _package_coverage_data 14:12:24 INFO - Running post-action listener: _resource_record_post_action 14:12:24 INFO - [mozharness: 2017-08-11 21:12:24.517674Z] Finished run-tests step (success) 14:12:24 INFO - Running post-run listener: _resource_record_post_run 14:12:24 INFO - Total resource usage - Wall time: 1187s; CPU: 13.0%; Read bytes: 16384; Write bytes: 429756416; Read time: 276; Write time: 217548 14:12:24 INFO - TinderboxPrint: CPU usage
13.0% 14:12:24 INFO - TinderboxPrint: I/O read bytes / time
16,384 / 276 14:12:24 INFO - TinderboxPrint: I/O write bytes / time
429,756,416 / 217,548 14:12:24 INFO - TinderboxPrint: CPU idle
8,229.2 (86.9%) 14:12:24 INFO - TinderboxPrint: CPU user
1,190.0 (12.6%) 14:12:24 INFO - TinderboxPrint: Swap in / out
0 / 0 14:12:24 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 4096; Write bytes: 108122112; Read time: 68; Write time: 69340 14:12:24 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 14:12:24 INFO - run-tests - Wall time: 1169s; CPU: 13.0%; Read bytes: 8192; Write bytes: 321634304; Read time: 196; Write time: 148208 14:12:25 INFO - Running post-run listener: _upload_blobber_files 14:12:25 INFO - Blob upload gear active. 14:12:25 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 14:12:25 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 14:12:25 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'] 14:12:25 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 14:12:25 INFO - (blobuploader) - INFO - Open directory for files ... 14:12:25 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 14:12:25 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:12:25 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:12:26 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 14:12:26 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:12:26 INFO - (blobuploader) - INFO - Done attempting. 14:12:26 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 14:12:26 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:12:26 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:12:29 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 14:12:29 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:12:29 INFO - (blobuploader) - INFO - Done attempting. 14:12:29 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 14:12:29 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:12:29 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:12:30 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 14:12:30 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:12:30 INFO - (blobuploader) - INFO - Done attempting. 14:12:30 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 14:12:30 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:12:30 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:12:31 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 14:12:31 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:12:31 INFO - (blobuploader) - INFO - Done attempting. 14:12:31 INFO - (blobuploader) - INFO - Iteration through files over. 14:12:31 INFO - Return code: 0 14:12:31 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 14:12:31 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 14:12:31 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/76e010fa6c50a1b602ce63c19e5ce84dca64ff00bed42502c6629ac961f45853a963aa53aee0f2eb03ad31262e81bada353ad6577fda3cc7bd3e5000b6a3d77e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/707645a601bd8e9ee2367b5492197919c311d98f0a08b886e73885bf231652eb36ef0203f58be213c8a5093689b8685c61301822c5e266a43a108a09fd93667e", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/68d12d5e12f9af792e3548ce4931fae4782c1457a69809d0bc4b45cd76b37a3c93899a8a823cac60119cf18208b3736e081071a735782173dd4cd219092b52b8", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/685afcbb540a5cff0dd64bcd7430d36441f9d0944e3a46c6d7118f4204cfef60b5d40848d7bbfa06c711a83fad802cd23f7e90256941559974a24992a8dd54d3"} 14:12:31 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 14:12:31 INFO - Writing to file /builds/slave/test/properties/blobber_files 14:12:31 INFO - Contents: 14:12:31 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/76e010fa6c50a1b602ce63c19e5ce84dca64ff00bed42502c6629ac961f45853a963aa53aee0f2eb03ad31262e81bada353ad6577fda3cc7bd3e5000b6a3d77e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/707645a601bd8e9ee2367b5492197919c311d98f0a08b886e73885bf231652eb36ef0203f58be213c8a5093689b8685c61301822c5e266a43a108a09fd93667e", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/68d12d5e12f9af792e3548ce4931fae4782c1457a69809d0bc4b45cd76b37a3c93899a8a823cac60119cf18208b3736e081071a735782173dd4cd219092b52b8", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/685afcbb540a5cff0dd64bcd7430d36441f9d0944e3a46c6d7118f4204cfef60b5d40848d7bbfa06c711a83fad802cd23f7e90256941559974a24992a8dd54d3"} 14:12:31 INFO - Running post-run listener: copy_logs_to_upload_dir 14:12:31 INFO - Copying logs to upload dir... 14:12:31 INFO - mkdir: /builds/slave/test/build/upload/logs 14:12:31 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1244.398527 ========= master_lag: -0.28 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 44 secs) (at 2017-08-11 14:12:31.194794) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-08-11 14:12:31.198052) ========= 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=ed14279e38b05397cf4aa391000001a4-1502484705.83030-799731030 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/76e010fa6c50a1b602ce63c19e5ce84dca64ff00bed42502c6629ac961f45853a963aa53aee0f2eb03ad31262e81bada353ad6577fda3cc7bd3e5000b6a3d77e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/707645a601bd8e9ee2367b5492197919c311d98f0a08b886e73885bf231652eb36ef0203f58be213c8a5093689b8685c61301822c5e266a43a108a09fd93667e", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/68d12d5e12f9af792e3548ce4931fae4782c1457a69809d0bc4b45cd76b37a3c93899a8a823cac60119cf18208b3736e081071a735782173dd4cd219092b52b8", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/685afcbb540a5cff0dd64bcd7430d36441f9d0944e3a46c6d7118f4204cfef60b5d40848d7bbfa06c711a83fad802cd23f7e90256941559974a24992a8dd54d3"} build_url:https://queue.taskcluster.net/v1/task/fX1fdLQiTay6BlwwYboQrw/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011166 build_url: 'https://queue.taskcluster.net/v1/task/fX1fdLQiTay6BlwwYboQrw/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/76e010fa6c50a1b602ce63c19e5ce84dca64ff00bed42502c6629ac961f45853a963aa53aee0f2eb03ad31262e81bada353ad6577fda3cc7bd3e5000b6a3d77e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/707645a601bd8e9ee2367b5492197919c311d98f0a08b886e73885bf231652eb36ef0203f58be213c8a5093689b8685c61301822c5e266a43a108a09fd93667e", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/68d12d5e12f9af792e3548ce4931fae4782c1457a69809d0bc4b45cd76b37a3c93899a8a823cac60119cf18208b3736e081071a735782173dd4cd219092b52b8", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/685afcbb540a5cff0dd64bcd7430d36441f9d0944e3a46c6d7118f4204cfef60b5d40848d7bbfa06c711a83fad802cd23f7e90256941559974a24992a8dd54d3"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-08-11 14:12:31.225495) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-08-11 14:12:31.225851) ========= 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=ed14279e38b05397cf4aa391000001a4-1502484705.83030-799731030 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004457 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-08-11 14:12:31.307559) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-08-11 14:12:31.310924) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-08-11 14:12:31.311224) ========= ========= Total master_lag: -0.13 =========