builder: mozilla-central_ubuntu64_hw_stylo_test-dromaeojs-e10s slave: talos-linux64-ix-001 starttime: 1501037471.25 results: success (0) revision: 9eddb0a92820c6445f9d1e680e4c239e888e93f0 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-07-25 19:51:11.249447) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-07-25 19:51:11.249947) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-07-25 19:51:11.250235) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-07-25 19:51:11.279364) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-07-25 19:51:11.279777) ========= 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=8887e36bb8e381bfd44124ac000001a8-1501037239.544001-1503337172 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-07-25 19:51:11-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 101M=0s 2017-07-25 19:51:11 (101 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.129278 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-07-25 19:51:11.422496) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-07-25 19:51:11.425310) ========= 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=8887e36bb8e381bfd44124ac000001a8-1501037239.544001-1503337172 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015659 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-07-25 19:51:11.478252) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-07-25 19:51:11.478678) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 9eddb0a92820c6445f9d1e680e4c239e888e93f0 --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 9eddb0a92820c6445f9d1e680e4c239e888e93f0 --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=8887e36bb8e381bfd44124ac000001a8-1501037239.544001-1503337172 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-07-25 19:51:11,932 truncating revision to first 12 chars 2017-07-25 19:51:11,932 Setting DEBUG logging. 2017-07-25 19:51:11,932 attempt 1/10 2017-07-25 19:51:11,932 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/9eddb0a92820?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-07-25 19:51:13,243 unpacking tar archive at: mozilla-central-9eddb0a92820/testing/mozharness/ program finished with exit code 0 elapsedTime=1.606322 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-07-25 19:51:13.100959) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-07-25 19:51:13.101281) ========= script_repo_revision: 9eddb0a92820c6445f9d1e680e4c239e888e93f0 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-07-25 19:51:13.101678) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-07-25 19:51:13.101968) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-07-25 19:51:13.110802) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 55 secs) (at 2017-07-25 19:51:13.111174) ========= /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=8887e36bb8e381bfd44124ac000001a8-1501037239.544001-1503337172 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 19:51:13 INFO - MultiFileLogger online at 20170725 19:51:13 in /builds/slave/test 19:51:13 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 19:51:13 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 19:51:13 INFO - {'append_to_log': False, 19:51:13 INFO - 'base_work_dir': '/builds/slave/test', 19:51:13 INFO - 'blob_upload_branch': 'Firefox', 19:51:13 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 19:51:13 INFO - 'branch': 'Firefox', 19:51:13 INFO - 'buildbot_json_path': 'buildprops.json', 19:51:13 INFO - 'code_coverage': False, 19:51:13 INFO - 'config_files': ('talos/linux_config.py',), 19:51:13 INFO - 'default_actions': ('clobber', 19:51:13 INFO - 'read-buildbot-config', 19:51:13 INFO - 'download-and-extract', 19:51:13 INFO - 'populate-webroot', 19:51:13 INFO - 'create-virtualenv', 19:51:13 INFO - 'install', 19:51:13 INFO - 'setup-mitmproxy', 19:51:13 INFO - 'run-tests'), 19:51:13 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 19:51:13 INFO - 'disable_ccov_upload': False, 19:51:13 INFO - 'download_minidump_stackwalk': True, 19:51:13 INFO - 'download_symbols': 'ondemand', 19:51:13 INFO - 'enable_stylo': False, 19:51:13 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 19:51:13 INFO - 'tooltool.py': '/tools/tooltool.py', 19:51:13 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 19:51:13 INFO - '/tools/misc-python/virtualenv.py')}, 19:51:13 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 19:51:13 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 19:51:13 INFO - 'gecko_profile': False, 19:51:13 INFO - 'gecko_profile_interval': 0, 19:51:13 INFO - 'installer_path': 'installer.exe', 19:51:13 INFO - 'log_level': 'info', 19:51:13 INFO - 'log_name': 'talos', 19:51:13 INFO - 'log_to_console': True, 19:51:13 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 19:51:13 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 19:51:13 INFO - 'opt_config_files': (), 19:51:13 INFO - 'pip_index': False, 19:51:13 INFO - 'suite': 'dromaeojs-e10s', 19:51:13 INFO - 'system_bits': '32', 19:51:13 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 19:51:13 INFO - 'title': 'talos-linux64-ix-001', 19:51:13 INFO - 'tooltool_cache': '/builds/tooltool_cache', 19:51:13 INFO - 'use_talos_json': True, 19:51:13 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 19:51:13 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 19:51:13 INFO - 'work_dir': 'build'} 19:51:13 INFO - [mozharness: 2017-07-26 02:51:13.674195Z] Running clobber step. 19:51:13 INFO - Running pre-action listener: _resource_record_pre_action 19:51:13 INFO - Running main action method: clobber 19:51:13 INFO - rmtree: /builds/slave/test/build 19:51:13 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 19:51:15 INFO - Running post-action listener: _resource_record_post_action 19:51:15 INFO - [mozharness: 2017-07-26 02:51:15.248991Z] Finished clobber step (success) 19:51:15 INFO - [mozharness: 2017-07-26 02:51:15.249093Z] Running read-buildbot-config step. 19:51:15 INFO - Running pre-action listener: _resource_record_pre_action 19:51:15 INFO - Running main action method: read_buildbot_config 19:51:15 INFO - Using buildbot properties: 19:51:15 INFO - { 19:51:15 INFO - "project": "", 19:51:15 INFO - "product": "firefox", 19:51:15 INFO - "who": "kwierso@gmail.com", 19:51:15 INFO - "installer_path": "public/build/target.tar.bz2", 19:51:15 INFO - "builddir": "mozilla-central_ubuntu64_hw_stylo_test-dromaeojs-e10s", 19:51:15 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 19:51:15 INFO - "buildername": "Ubuntu HW 12.04 x64 stylo mozilla-central talos dromaeojs-e10s", 19:51:15 INFO - "stage_platform": "linux64-stylo", 19:51:15 INFO - "basedir": "/builds/slave/test", 19:51:15 INFO - "buildnumber": 50, 19:51:15 INFO - "platform": "ubuntu64_hw_stylo", 19:51:15 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 19:51:15 INFO - "slavebuilddir": "test", 19:51:15 INFO - "taskId": "JrIgjgyXQs6NWzj14xaLTw", 19:51:15 INFO - "branch": "mozilla-central", 19:51:15 INFO - "script_repo_revision": "production", 19:51:15 INFO - "revision": "9eddb0a92820c6445f9d1e680e4c239e888e93f0", 19:51:15 INFO - "slavename": "talos-linux64-ix-001", 19:51:15 INFO - "repo_path": "mozilla-central" 19:51:15 INFO - } 19:51:15 INFO - Finding installer, test and symbols from parent task. 19:51:15 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/JrIgjgyXQs6NWzj14xaLTw'}, attempt #1 19:51:15 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/JrIgjgyXQs6NWzj14xaLTw'}, attempt #1 19:51:16 INFO - Task dependencies: doubB920S6SAYge54loW3Q 19:51:16 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/doubB920S6SAYge54loW3Q'}, attempt #1 19:51:16 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/doubB920S6SAYge54loW3Q/artifacts/public/build/target.tar.bz2 19:51:16 INFO - Set test_url: https://queue.taskcluster.net/v1/task/doubB920S6SAYge54loW3Q/artifacts/public/build/test_packages.json 19:51:16 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/doubB920S6SAYge54loW3Q/artifacts/public/build/target.crashreporter-symbols.zip 19:51:16 INFO - Running post-action listener: _resource_record_post_action 19:51:16 INFO - [mozharness: 2017-07-26 02:51:16.620801Z] Finished read-buildbot-config step (success) 19:51:16 INFO - [mozharness: 2017-07-26 02:51:16.621022Z] Running download-and-extract step. 19:51:16 INFO - Running pre-action listener: _resource_record_pre_action 19:51:16 INFO - Running main action method: download_and_extract 19:51:16 INFO - mkdir: /builds/slave/test/build/tests 19:51: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')]} 19:51:16 INFO - trying https://queue.taskcluster.net/v1/task/doubB920S6SAYge54loW3Q/artifacts/public/build/target.test_packages.json 19:51:16 INFO - Downloading https://queue.taskcluster.net/v1/task/doubB920S6SAYge54loW3Q/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 19:51:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/doubB920S6SAYge54loW3Q/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 19:51:17 INFO - Downloaded 989 bytes. 19:51:17 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 19:51:17 INFO - Using the following test package requirements: 19:51:17 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 19:51:17 INFO - u'common': [u'target.common.tests.zip'], 19:51:17 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 19:51:17 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 19:51:17 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 19:51:17 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 19:51:17 INFO - u'mozbase': [u'target.common.tests.zip'], 19:51:17 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 19:51:17 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 19:51:17 INFO - u'web-platform': [u'target.common.tests.zip', 19:51:17 INFO - u'target.web-platform.tests.tar.gz'], 19:51:17 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 19:51:17 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 19:51:17 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/doubB920S6SAYge54loW3Q/artifacts/public/build/target.common.tests.zip 19:51:17 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/doubB920S6SAYge54loW3Q/artifacts/public/build/target.common.tests.zip'}, attempt #1 19:51:17 INFO - Fetch https://queue.taskcluster.net/v1/task/doubB920S6SAYge54loW3Q/artifacts/public/build/target.common.tests.zip into memory 19:51:18 INFO - Content-Length response header: 72762713 19:51:18 INFO - Bytes received: 72762713 19:51:29 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 19:51:29 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/doubB920S6SAYge54loW3Q/artifacts/public/build/target.common.tests.zip 19:51:29 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/doubB920S6SAYge54loW3Q/artifacts/public/build/target.common.tests.zip'}, attempt #1 19:51:29 INFO - Fetch https://queue.taskcluster.net/v1/task/doubB920S6SAYge54loW3Q/artifacts/public/build/target.common.tests.zip into memory 19:51:31 INFO - Content-Length response header: 72762713 19:51:31 INFO - Bytes received: 72762713 19:51:43 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/doubB920S6SAYge54loW3Q/artifacts/public/build/target.talos.tests.zip 19:51:43 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/doubB920S6SAYge54loW3Q/artifacts/public/build/target.talos.tests.zip'}, attempt #1 19:51:43 INFO - Fetch https://queue.taskcluster.net/v1/task/doubB920S6SAYge54loW3Q/artifacts/public/build/target.talos.tests.zip into memory 19:51:44 INFO - Content-Length response header: 14498866 19:51:44 INFO - Bytes received: 14498866 19:51:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:51:44 INFO - trying https://queue.taskcluster.net/v1/task/doubB920S6SAYge54loW3Q/artifacts/public/build/target.tar.bz2 19:51:44 INFO - Downloading https://queue.taskcluster.net/v1/task/doubB920S6SAYge54loW3Q/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 19:51:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/doubB920S6SAYge54loW3Q/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 19:51:45 INFO - Downloaded 62074509 bytes. 19:51:45 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/doubB920S6SAYge54loW3Q/artifacts/public/build/target.tar.bz2 19:51:45 INFO - mkdir: /builds/slave/test/properties 19:51:45 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 19:51:45 INFO - Writing to file /builds/slave/test/properties/build_url 19:51:45 INFO - Contents: 19:51:45 INFO - build_url:https://queue.taskcluster.net/v1/task/doubB920S6SAYge54loW3Q/artifacts/public/build/target.tar.bz2 19:51:45 INFO - Running post-action listener: _resource_record_post_action 19:51:45 INFO - Running post-action listener: set_extra_try_arguments 19:51:45 INFO - [mozharness: 2017-07-26 02:51:45.622988Z] Finished download-and-extract step (success) 19:51:45 INFO - [mozharness: 2017-07-26 02:51:45.623085Z] Running populate-webroot step. 19:51:45 INFO - Running pre-action listener: _resource_record_pre_action 19:51:45 INFO - Running main action method: populate_webroot 19:51:45 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 19:51:45 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 19:51:45 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 19:51:45 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:51:45 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 19:51:45 INFO - 'tests': ['damp', 'tps']}, 19:51:45 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 19:51:45 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 19:51:45 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 19:51:45 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 19:51:45 INFO - 'other-e10s': {'tests': ['a11yr', 19:51:45 INFO - 'ts_paint', 19:51:45 INFO - 'tpaint', 19:51:45 INFO - 'sessionrestore', 19:51:45 INFO - 'sessionrestore_many_windows', 19:51:45 INFO - 'sessionrestore_no_auto_restore', 19:51:45 INFO - 'tabpaint']}, 19:51:45 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 19:51:45 INFO - 'perf-reftest-singletons-e10s': {'tests': ['bloom_basic_singleton']}, 19:51:45 INFO - 'quantum-pageload-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 19:51:45 INFO - 'talos_options': ['--mitmproxy', 19:51:45 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 19:51:45 INFO - '--firstNonBlankPaint'], 19:51:45 INFO - 'tests': ['quantum_pageload_google', 19:51:45 INFO - 'quantum_pageload_youtube', 19:51:45 INFO - 'quantum_pageload_amazon', 19:51:45 INFO - 'quantum_pageload_facebook']}, 19:51:45 INFO - 'quantum-pageload-stylo-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 19:51:45 INFO - 'talos_options': ['--stylo', 19:51:45 INFO - '--mitmproxy', 19:51:45 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 19:51:45 INFO - '--firstNonBlankPaint'], 19:51:45 INFO - 'tests': ['quantum_pageload_google', 19:51:45 INFO - 'quantum_pageload_youtube', 19:51:45 INFO - 'quantum_pageload_amazon', 19:51:45 INFO - 'quantum_pageload_facebook']}, 19:51:45 INFO - 'svgr-e10s': {'tests': ['tsvgx', 19:51:45 INFO - 'tsvgr_opacity', 19:51:45 INFO - 'tart', 19:51:45 INFO - 'tscrollx', 19:51:45 INFO - 'cart', 19:51:45 INFO - 'tsvg_static']}, 19:51:45 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 19:51:45 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 19:51:45 INFO - 'talos_options': ['--xperf_path', 19:51:45 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:51:45 INFO - 'tests': ['tp5n']}}} 19:51:45 INFO - Running post-action listener: _resource_record_post_action 19:51:45 INFO - [mozharness: 2017-07-26 02:51:45.630397Z] Finished populate-webroot step (success) 19:51:45 INFO - [mozharness: 2017-07-26 02:51:45.630488Z] Running create-virtualenv step. 19:51:45 INFO - Running pre-action listener: _resource_record_pre_action 19:51:45 INFO - Running main action method: create_virtualenv 19:51:45 INFO - Creating virtualenv /builds/slave/test/build/venv 19:51:45 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 19:51:45 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 19:51:45 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 19:51:45 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 19:51:45 INFO - Using real prefix '/usr' 19:51:45 INFO - New python executable in /builds/slave/test/build/venv/bin/python 19:51:46 INFO - Installing distribute.............................................................................................................................................................................................done. 19:51:48 INFO - Installing pip.................done. 19:51:48 INFO - Return code: 0 19:51:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 19:51:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 19:51:48 INFO - Reading from file tmpfile_stdout 19:51:48 INFO - Output received: 19:51:48 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) 19:51:48 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 19:51:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:51:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:51:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:51:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:51:48 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 0x10d91f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12a5a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1448d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1445eb0>, '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 0x1446db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1447240>, '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': '8887e36bb8e381bfd44124ac000001a8-1501037239.544001-1503337172', '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 19:51:48 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 19:51:48 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 19:51:48 INFO - Using env: {'DISPLAY': ':0', 19:51:48 INFO - 'HOME': '/home/cltbld', 19:51:48 INFO - 'LANG': 'en_US.UTF-8', 19:51:48 INFO - 'LANGUAGE': 'en_US:en', 19:51:48 INFO - 'LOGNAME': 'cltbld', 19:51:48 INFO - 'MAIL': '/var/mail/cltbld', 19:51:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:51:48 INFO - 'MOZ_NO_REMOTE': '1', 19:51:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:51:48 INFO - 'NO_EM_RESTART': '1', 19:51:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:51:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:51:48 INFO - 'PWD': '/builds/slave/test', 19:51:48 INFO - 'SHELL': '/bin/bash', 19:51:48 INFO - 'SHLVL': '1', 19:51:48 INFO - 'TERM': 'linux', 19:51:48 INFO - 'TMOUT': '86400', 19:51:48 INFO - 'USER': 'cltbld', 19:51:48 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1501037239.544001-1503337172', 19:51:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:51:48 INFO - '_': '/tools/buildbot/bin/python'} 19:51:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:51:48 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 19:51:48 INFO - Cleaning up... 19:51:48 INFO - Return code: 0 19:51:48 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 19:51:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:51:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:51:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:51:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:51:48 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 0x10d91f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12a5a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1448d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1445eb0>, '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 0x1446db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1447240>, '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': '8887e36bb8e381bfd44124ac000001a8-1501037239.544001-1503337172', '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 19:51:48 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 19:51:48 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 19:51:48 INFO - Using env: {'DISPLAY': ':0', 19:51:48 INFO - 'HOME': '/home/cltbld', 19:51:48 INFO - 'LANG': 'en_US.UTF-8', 19:51:48 INFO - 'LANGUAGE': 'en_US:en', 19:51:48 INFO - 'LOGNAME': 'cltbld', 19:51:48 INFO - 'MAIL': '/var/mail/cltbld', 19:51:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:51:48 INFO - 'MOZ_NO_REMOTE': '1', 19:51:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:51:48 INFO - 'NO_EM_RESTART': '1', 19:51:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:51:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:51:48 INFO - 'PWD': '/builds/slave/test', 19:51:48 INFO - 'SHELL': '/bin/bash', 19:51:48 INFO - 'SHLVL': '1', 19:51:48 INFO - 'TERM': 'linux', 19:51:48 INFO - 'TMOUT': '86400', 19:51:48 INFO - 'USER': 'cltbld', 19:51:48 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1501037239.544001-1503337172', 19:51:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:51:48 INFO - '_': '/tools/buildbot/bin/python'} 19:51:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:51:48 INFO - Downloading/unpacking psutil>=3.1.1 19:51:48 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 19:51:48 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 19:51:48 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 19:51:48 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 19:51:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 19:51:50 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:51:50 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:51:50 INFO - Installing collected packages: psutil 19:51:50 INFO - Running setup.py install for psutil 19:51:50 INFO - building 'psutil._psutil_linux' extension 19:51:50 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 19:51:50 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 19:51:50 INFO - building 'psutil._psutil_posix' extension 19:51:50 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 19:51:50 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 19:51:50 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:51:50 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:51:50 INFO - Successfully installed psutil 19:51:50 INFO - Cleaning up... 19:51:50 INFO - Return code: 0 19:51:50 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 19:51:50 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')]} 19:51:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:51:50 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')]} 19:51:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:51:50 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 0x10d91f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12a5a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1448d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1445eb0>, '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 0x1446db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1447240>, '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': '8887e36bb8e381bfd44124ac000001a8-1501037239.544001-1503337172', '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 19:51:50 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 19:51:50 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 19:51:50 INFO - Using env: {'DISPLAY': ':0', 19:51:50 INFO - 'HOME': '/home/cltbld', 19:51:50 INFO - 'LANG': 'en_US.UTF-8', 19:51:50 INFO - 'LANGUAGE': 'en_US:en', 19:51:50 INFO - 'LOGNAME': 'cltbld', 19:51:50 INFO - 'MAIL': '/var/mail/cltbld', 19:51:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:51:50 INFO - 'MOZ_NO_REMOTE': '1', 19:51:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:51:50 INFO - 'NO_EM_RESTART': '1', 19:51:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:51:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:51:50 INFO - 'PWD': '/builds/slave/test', 19:51:50 INFO - 'SHELL': '/bin/bash', 19:51:50 INFO - 'SHLVL': '1', 19:51:50 INFO - 'TERM': 'linux', 19:51:50 INFO - 'TMOUT': '86400', 19:51:50 INFO - 'USER': 'cltbld', 19:51:50 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1501037239.544001-1503337172', 19:51:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:51:50 INFO - '_': '/tools/buildbot/bin/python'} 19:51:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:51:50 INFO - Downloading/unpacking mozsystemmonitor==0.3 19:51:50 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 19:51:50 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 19:51:50 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 19:51:50 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 19:51:51 INFO - Downloading mozsystemmonitor-0.3.tar.gz 19:51:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 19:51:51 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 19:51:51 INFO - Installing collected packages: mozsystemmonitor 19:51:51 INFO - Running setup.py install for mozsystemmonitor 19:51:52 INFO - Successfully installed mozsystemmonitor 19:51:52 INFO - Cleaning up... 19:51:52 INFO - Return code: 0 19:51:52 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 19:51:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:51:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:51:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:51:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:51:52 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 0x10d91f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12a5a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1448d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1445eb0>, '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 0x1446db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1447240>, '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': '8887e36bb8e381bfd44124ac000001a8-1501037239.544001-1503337172', '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 19:51:52 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 19:51:52 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 19:51:52 INFO - Using env: {'DISPLAY': ':0', 19:51:52 INFO - 'HOME': '/home/cltbld', 19:51:52 INFO - 'LANG': 'en_US.UTF-8', 19:51:52 INFO - 'LANGUAGE': 'en_US:en', 19:51:52 INFO - 'LOGNAME': 'cltbld', 19:51:52 INFO - 'MAIL': '/var/mail/cltbld', 19:51:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:51:52 INFO - 'MOZ_NO_REMOTE': '1', 19:51:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:51:52 INFO - 'NO_EM_RESTART': '1', 19:51:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:51:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:51:52 INFO - 'PWD': '/builds/slave/test', 19:51:52 INFO - 'SHELL': '/bin/bash', 19:51:52 INFO - 'SHLVL': '1', 19:51:52 INFO - 'TERM': 'linux', 19:51:52 INFO - 'TMOUT': '86400', 19:51:52 INFO - 'USER': 'cltbld', 19:51:52 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1501037239.544001-1503337172', 19:51:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:51:52 INFO - '_': '/tools/buildbot/bin/python'} 19:51:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:51:52 INFO - Downloading/unpacking jsonschema==2.5.1 19:51:52 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 19:51:52 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 19:51:52 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 19:51:52 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 19:51:53 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 19:51:53 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 19:51:53 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 19:51:53 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 19:51:53 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 19:51:53 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 19:51:53 INFO - Downloading functools32-3.2.3-2.tar.gz 19:51:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 19:51:53 INFO - warning: no files found matching '*.txt' 19:51:53 INFO - no previously-included directories found matching 'build' 19:51:53 INFO - no previously-included directories found matching 'dist' 19:51:53 INFO - no previously-included directories found matching '.git*' 19:51:53 INFO - Installing collected packages: jsonschema, functools32 19:51:53 INFO - Running setup.py install for functools32 19:51:53 INFO - warning: no files found matching '*.txt' 19:51:53 INFO - no previously-included directories found matching 'build' 19:51:53 INFO - no previously-included directories found matching 'dist' 19:51:53 INFO - no previously-included directories found matching '.git*' 19:51:53 INFO - Successfully installed jsonschema functools32 19:51:53 INFO - Cleaning up... 19:51:53 INFO - Return code: 0 19:51:53 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 19:51:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:51:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:51:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:51:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:51:53 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10d91f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12a5a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1448d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1445eb0>, '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 0x1446db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1447240>, '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': '8887e36bb8e381bfd44124ac000001a8-1501037239.544001-1503337172', '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 19:51:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 19:51:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 19:51:53 INFO - Using env: {'DISPLAY': ':0', 19:51:53 INFO - 'HOME': '/home/cltbld', 19:51:53 INFO - 'LANG': 'en_US.UTF-8', 19:51:53 INFO - 'LANGUAGE': 'en_US:en', 19:51:53 INFO - 'LOGNAME': 'cltbld', 19:51:53 INFO - 'MAIL': '/var/mail/cltbld', 19:51:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:51:53 INFO - 'MOZ_NO_REMOTE': '1', 19:51:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:51:53 INFO - 'NO_EM_RESTART': '1', 19:51:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:51:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:51:53 INFO - 'PWD': '/builds/slave/test', 19:51:53 INFO - 'SHELL': '/bin/bash', 19:51:53 INFO - 'SHLVL': '1', 19:51:53 INFO - 'TERM': 'linux', 19:51:53 INFO - 'TMOUT': '86400', 19:51:53 INFO - 'USER': 'cltbld', 19:51:53 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1501037239.544001-1503337172', 19:51:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:51:53 INFO - '_': '/tools/buildbot/bin/python'} 19:51:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:51:53 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 19:51:53 INFO - Cleaning up... 19:51:54 INFO - Return code: 0 19:51:54 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 19:51:54 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')]} 19:51:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:51:54 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')]} 19:51:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:51:54 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 0x10d91f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12a5a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1448d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1445eb0>, '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 0x1446db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1447240>, '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': '8887e36bb8e381bfd44124ac000001a8-1501037239.544001-1503337172', '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 19:51:54 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 19:51:54 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 19:51:54 INFO - Using env: {'DISPLAY': ':0', 19:51:54 INFO - 'HOME': '/home/cltbld', 19:51:54 INFO - 'LANG': 'en_US.UTF-8', 19:51:54 INFO - 'LANGUAGE': 'en_US:en', 19:51:54 INFO - 'LOGNAME': 'cltbld', 19:51:54 INFO - 'MAIL': '/var/mail/cltbld', 19:51:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:51:54 INFO - 'MOZ_NO_REMOTE': '1', 19:51:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:51:54 INFO - 'NO_EM_RESTART': '1', 19:51:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:51:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:51:54 INFO - 'PWD': '/builds/slave/test', 19:51:54 INFO - 'SHELL': '/bin/bash', 19:51:54 INFO - 'SHLVL': '1', 19:51:54 INFO - 'TERM': 'linux', 19:51:54 INFO - 'TMOUT': '86400', 19:51:54 INFO - 'USER': 'cltbld', 19:51:54 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1501037239.544001-1503337172', 19:51:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:51:54 INFO - '_': '/tools/buildbot/bin/python'} 19:51:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:51:54 INFO - Downloading/unpacking blobuploader==1.2.4 19:51:54 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 19:51:54 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 19:51:54 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 19:51:54 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 19:51:55 INFO - Downloading blobuploader-1.2.4.tar.gz 19:51:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 19:51:55 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 19:51:55 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 19:51:55 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 19:51:55 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 19:51:55 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 19:51:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 19:51:55 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 19:51:55 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 19:51:55 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 19:51:55 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 19:51:55 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 19:51:55 INFO - Downloading docopt-0.6.1.tar.gz 19:51:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 19:51:55 INFO - Installing collected packages: blobuploader, requests, docopt 19:51:55 INFO - Running setup.py install for blobuploader 19:51:55 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 19:51:55 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 19:51:55 INFO - Running setup.py install for requests 19:51:56 INFO - Running setup.py install for docopt 19:51:56 INFO - Successfully installed blobuploader requests docopt 19:51:56 INFO - Cleaning up... 19:51:56 INFO - Return code: 0 19:51:56 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:51:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:51:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:51:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:51:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:51:56 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 0x10d91f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12a5a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1448d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1445eb0>, '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 0x1446db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1447240>, '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': '8887e36bb8e381bfd44124ac000001a8-1501037239.544001-1503337172', '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 19:51:56 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 19:51:56 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 19:51:56 INFO - Using env: {'DISPLAY': ':0', 19:51:56 INFO - 'HOME': '/home/cltbld', 19:51:56 INFO - 'LANG': 'en_US.UTF-8', 19:51:56 INFO - 'LANGUAGE': 'en_US:en', 19:51:56 INFO - 'LOGNAME': 'cltbld', 19:51:56 INFO - 'MAIL': '/var/mail/cltbld', 19:51:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:51:56 INFO - 'MOZ_NO_REMOTE': '1', 19:51:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:51:56 INFO - 'NO_EM_RESTART': '1', 19:51:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:51:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:51:56 INFO - 'PWD': '/builds/slave/test', 19:51:56 INFO - 'SHELL': '/bin/bash', 19:51:56 INFO - 'SHLVL': '1', 19:51:56 INFO - 'TERM': 'linux', 19:51:56 INFO - 'TMOUT': '86400', 19:51:56 INFO - 'USER': 'cltbld', 19:51:56 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1501037239.544001-1503337172', 19:51:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:51:56 INFO - '_': '/tools/buildbot/bin/python'} 19:51:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:51:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:51:56 INFO - Running setup.py (path:/tmp/pip-TML33k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:51:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:51:56 INFO - Running setup.py (path:/tmp/pip-F2S_zy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:51:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:51:56 INFO - Running setup.py (path:/tmp/pip-3qgk6F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:51:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:51:56 INFO - Running setup.py (path:/tmp/pip-PxuTE8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:51:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:51:56 INFO - Running setup.py (path:/tmp/pip-nMD4C_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:51:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:51:57 INFO - Running setup.py (path:/tmp/pip-wiom4j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:51:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:51:57 INFO - Running setup.py (path:/tmp/pip-KAPKsA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:51:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:51:57 INFO - Running setup.py (path:/tmp/pip-s3UVp1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:51:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:51:57 INFO - Running setup.py (path:/tmp/pip-dsdd7Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:51:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:51:57 INFO - Running setup.py (path:/tmp/pip-1et4Pl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:51:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:51:57 INFO - Running setup.py (path:/tmp/pip-4pkLzJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:51:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:51:57 INFO - Running setup.py (path:/tmp/pip-AySp9B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:51:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:51:57 INFO - Running setup.py (path:/tmp/pip-QKpWa2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:51:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:51:57 INFO - Running setup.py (path:/tmp/pip-7snDOg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:51:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:51:57 INFO - Running setup.py (path:/tmp/pip-x0ILvS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:51:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:51:57 INFO - Running setup.py (path:/tmp/pip-WOjdMv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:51:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:51:57 INFO - Running setup.py (path:/tmp/pip-M_Lg7j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:51:57 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 19:51:57 INFO - Running setup.py install for manifestparser 19:51:57 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 19:51:58 INFO - Running setup.py install for mozcrash 19:51:58 INFO - Running setup.py install for mozdebug 19:51:58 INFO - Running setup.py install for mozdevice 19:51:58 INFO - Installing dm script to /builds/slave/test/build/venv/bin 19:51:58 INFO - Running setup.py install for mozfile 19:51:58 INFO - Running setup.py install for mozhttpd 19:51:58 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 19:51:58 INFO - Running setup.py install for mozinfo 19:51:58 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 19:51:58 INFO - Running setup.py install for mozInstall 19:51:58 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 19:51:58 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 19:51:58 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 19:51:58 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 19:51:58 INFO - Running setup.py install for mozleak 19:51:58 INFO - Running setup.py install for mozlog 19:51:58 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 19:51:58 INFO - Running setup.py install for moznetwork 19:51:59 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 19:51:59 INFO - Running setup.py install for mozprocess 19:51:59 INFO - Running setup.py install for mozprofile 19:51:59 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 19:51:59 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 19:51:59 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 19:51:59 INFO - Running setup.py install for mozrunner 19:51:59 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 19:51:59 INFO - Running setup.py install for mozscreenshot 19:51:59 INFO - Running setup.py install for moztest 19:51:59 INFO - Running setup.py install for mozversion 19:51:59 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 19:51:59 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 19:51:59 INFO - Cleaning up... 19:51:59 INFO - Return code: 0 19:51:59 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:51:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:51:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:51:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:51:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:51:59 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 0x10d91f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12a5a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1448d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1445eb0>, '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 0x1446db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1447240>, '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': '8887e36bb8e381bfd44124ac000001a8-1501037239.544001-1503337172', '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 19:51:59 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 19:51:59 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 19:51:59 INFO - Using env: {'DISPLAY': ':0', 19:51:59 INFO - 'HOME': '/home/cltbld', 19:51:59 INFO - 'LANG': 'en_US.UTF-8', 19:51:59 INFO - 'LANGUAGE': 'en_US:en', 19:51:59 INFO - 'LOGNAME': 'cltbld', 19:51:59 INFO - 'MAIL': '/var/mail/cltbld', 19:51:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:51:59 INFO - 'MOZ_NO_REMOTE': '1', 19:51:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:51:59 INFO - 'NO_EM_RESTART': '1', 19:51:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:51:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:51:59 INFO - 'PWD': '/builds/slave/test', 19:51:59 INFO - 'SHELL': '/bin/bash', 19:51:59 INFO - 'SHLVL': '1', 19:51:59 INFO - 'TERM': 'linux', 19:51:59 INFO - 'TMOUT': '86400', 19:51:59 INFO - 'USER': 'cltbld', 19:51:59 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1501037239.544001-1503337172', 19:51:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:51:59 INFO - '_': '/tools/buildbot/bin/python'} 19:51:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:51:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:51:59 INFO - Running setup.py (path:/tmp/pip-_kT6Va-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:51:59 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)) 19:51:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:51:59 INFO - Running setup.py (path:/tmp/pip-4zpVlq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:52:00 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)) 19:52:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:52:00 INFO - Running setup.py (path:/tmp/pip-JMgHUw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:52:00 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)) 19:52:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:52:00 INFO - Running setup.py (path:/tmp/pip-jtc1V0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:52:00 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)) 19:52:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:52:00 INFO - Running setup.py (path:/tmp/pip-yU3dzC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:52:00 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)) 19:52:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:52:00 INFO - Running setup.py (path:/tmp/pip-Yq1OVN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:52:00 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)) 19:52:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:52:00 INFO - Running setup.py (path:/tmp/pip-L0TYvh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:52:00 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)) 19:52:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:52:00 INFO - Running setup.py (path:/tmp/pip-KrDwpA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:52:00 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)) 19:52:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:52:00 INFO - Running setup.py (path:/tmp/pip-Amfmio-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:52:00 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)) 19:52:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:52:00 INFO - Running setup.py (path:/tmp/pip-KjeV8I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:52:00 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)) 19:52:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:52:00 INFO - Running setup.py (path:/tmp/pip-s1aVyn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:52:00 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)) 19:52:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:52:00 INFO - Running setup.py (path:/tmp/pip-klWV80-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:52:00 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)) 19:52:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:52:00 INFO - Running setup.py (path:/tmp/pip-D0D7Nj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:52:00 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)) 19:52:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:52:00 INFO - Running setup.py (path:/tmp/pip-I197QG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:52:00 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)) 19:52:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:52:00 INFO - Running setup.py (path:/tmp/pip-MolgM3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:52:00 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)) 19:52:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:52:00 INFO - Running setup.py (path:/tmp/pip-FNdU1X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:52:01 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)) 19:52:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:52:01 INFO - Running setup.py (path:/tmp/pip-rEKFMl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:52:01 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)) 19:52:01 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)) 19:52:01 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)) 19:52:01 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)) 19:52:01 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)) 19:52:01 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)) 19:52:01 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)) 19:52:01 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 19:52:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:52:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:52:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:52:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:52:02 INFO - Downloading blessings-1.6.tar.gz 19:52:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 19:52:02 INFO - Installing collected packages: blessings 19:52:02 INFO - Running setup.py install for blessings 19:52:02 INFO - Successfully installed blessings 19:52:02 INFO - Cleaning up... 19:52:02 INFO - Return code: 0 19:52:02 INFO - Done creating virtualenv /builds/slave/test/build/venv. 19:52:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:52:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:52:02 INFO - Reading from file tmpfile_stdout 19:52:02 INFO - Current package versions: 19:52:02 INFO - argparse == 1.2.1 19:52:02 INFO - blessings == 1.6 19:52:02 INFO - blobuploader == 1.2.4 19:52:02 INFO - docopt == 0.6.1 19:52:02 INFO - functools32 == 3.2.3-2 19:52:02 INFO - jsonschema == 2.5.1 19:52:02 INFO - manifestparser == 1.1 19:52:02 INFO - mozInstall == 1.13 19:52:02 INFO - mozcrash == 1.0 19:52:02 INFO - mozdebug == 0.1 19:52:02 INFO - mozdevice == 0.51 19:52:02 INFO - mozfile == 1.2 19:52:02 INFO - mozhttpd == 0.7 19:52:02 INFO - mozinfo == 0.10 19:52:02 INFO - mozleak == 0.1 19:52:02 INFO - mozlog == 3.5 19:52:02 INFO - moznetwork == 0.27 19:52:02 INFO - mozprocess == 0.25 19:52:02 INFO - mozprofile == 0.28 19:52:02 INFO - mozrunner == 6.13 19:52:02 INFO - mozscreenshot == 0.1 19:52:02 INFO - mozsystemmonitor == 0.3 19:52:02 INFO - moztest == 0.8 19:52:02 INFO - mozversion == 1.4 19:52:02 INFO - psutil == 3.1.1 19:52:02 INFO - requests == 1.2.3 19:52:02 INFO - wsgiref == 0.1.2 19:52:02 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:52:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:52:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:52:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:52:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:52:02 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 0x10d91f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12a5a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1448d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1445eb0>, '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 0x1446db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1447240>, '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': '8887e36bb8e381bfd44124ac000001a8-1501037239.544001-1503337172', '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 19:52:02 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 19:52:02 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 19:52:02 INFO - Using env: {'DISPLAY': ':0', 19:52:02 INFO - 'HOME': '/home/cltbld', 19:52:02 INFO - 'LANG': 'en_US.UTF-8', 19:52:02 INFO - 'LANGUAGE': 'en_US:en', 19:52:02 INFO - 'LOGNAME': 'cltbld', 19:52:02 INFO - 'MAIL': '/var/mail/cltbld', 19:52:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:52:02 INFO - 'MOZ_NO_REMOTE': '1', 19:52:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:52:02 INFO - 'NO_EM_RESTART': '1', 19:52:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:52:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:52:02 INFO - 'PWD': '/builds/slave/test', 19:52:02 INFO - 'SHELL': '/bin/bash', 19:52:02 INFO - 'SHLVL': '1', 19:52:02 INFO - 'TERM': 'linux', 19:52:02 INFO - 'TMOUT': '86400', 19:52:02 INFO - 'USER': 'cltbld', 19:52:02 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1501037239.544001-1503337172', 19:52:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:52:02 INFO - '_': '/tools/buildbot/bin/python'} 19:52:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:52:02 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)) 19:52:02 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)) 19:52:02 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)) 19:52:02 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)) 19:52:02 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)) 19:52:02 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)) 19:52:02 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)) 19:52:02 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)) 19:52:02 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)) 19:52:02 INFO - Downloading/unpacking marionette-driver>=1.4.0 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 19:52:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:52:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:52:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:52:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:52:03 INFO - Downloading marionette_driver-1.4.0.tar.gz 19:52:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/marionette-driver/setup.py) egg_info for package marionette-driver 19:52:04 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 11)) 19:52:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:52:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:52:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:52:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:52:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 19:52:04 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)) 19:52:04 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)) 19:52:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner>=6.9 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from marionette-driver>=1.4.0->-r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 19:52:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice>=0.37 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozrunner>=6.9->marionette-driver>=1.4.0->-r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 19:52:04 INFO - Installing collected packages: marionette-driver, simplejson 19:52:04 INFO - Running setup.py install for marionette-driver 19:52:04 INFO - Running setup.py install for simplejson 19:52:04 INFO - building 'simplejson._speedups' extension 19:52:04 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 19:52:05 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 19:52:05 INFO - Successfully installed marionette-driver simplejson 19:52:05 INFO - Cleaning up... 19:52:05 INFO - Return code: 0 19:52:05 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 19:52:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:52:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:52:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:52:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:52:05 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10d91f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12a5a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1448d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1445eb0>, '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 0x1446db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1447240>, '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': '8887e36bb8e381bfd44124ac000001a8-1501037239.544001-1503337172', '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 19:52:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 19:52:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 19:52:05 INFO - Using env: {'DISPLAY': ':0', 19:52:05 INFO - 'HOME': '/home/cltbld', 19:52:05 INFO - 'LANG': 'en_US.UTF-8', 19:52:05 INFO - 'LANGUAGE': 'en_US:en', 19:52:05 INFO - 'LOGNAME': 'cltbld', 19:52:05 INFO - 'MAIL': '/var/mail/cltbld', 19:52:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:52:05 INFO - 'MOZ_NO_REMOTE': '1', 19:52:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:52:05 INFO - 'NO_EM_RESTART': '1', 19:52:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:52:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:52:05 INFO - 'PWD': '/builds/slave/test', 19:52:05 INFO - 'SHELL': '/bin/bash', 19:52:05 INFO - 'SHLVL': '1', 19:52:05 INFO - 'TERM': 'linux', 19:52:05 INFO - 'TMOUT': '86400', 19:52:05 INFO - 'USER': 'cltbld', 19:52:05 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1501037239.544001-1503337172', 19:52:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:52:05 INFO - '_': '/tools/buildbot/bin/python'} 19:52:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:52:05 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 19:52:05 INFO - Cleaning up... 19:52:05 INFO - Return code: 0 19:52:05 INFO - Running post-action listener: _resource_record_post_action 19:52:05 INFO - Running post-action listener: _start_resource_monitoring 19:52:05 INFO - Starting resource monitoring. 19:52:05 INFO - [mozharness: 2017-07-26 02:52:05.718834Z] Finished create-virtualenv step (success) 19:52:05 INFO - [mozharness: 2017-07-26 02:52:05.719353Z] Running install step. 19:52:05 INFO - Running pre-action listener: _resource_record_pre_action 19:52:05 INFO - Running main action method: install 19:52:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:52:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:52:05 INFO - Reading from file tmpfile_stdout 19:52:05 INFO - Detecting whether we're running mozinstall >=1.0... 19:52:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 19:52:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 19:52:06 INFO - Reading from file tmpfile_stdout 19:52:06 INFO - Output received: 19:52:06 INFO - Usage: mozinstall [options] installer 19:52:06 INFO - Options: 19:52:06 INFO - -h, --help show this help message and exit 19:52:06 INFO - -d DEST, --destination=DEST 19:52:06 INFO - Directory to install application into. [default: 19:52:06 INFO - "/builds/slave/test"] 19:52:06 INFO - --app=APP Application being installed. [default: firefox] 19:52:06 INFO - mkdir: /builds/slave/test/build/application 19:52:06 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'] 19:52:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 19:52:24 INFO - Reading from file tmpfile_stdout 19:52:24 INFO - Output received: 19:52:24 INFO - /builds/slave/test/build/application/firefox/firefox 19:52:24 INFO - Running post-action listener: _resource_record_post_action 19:52:24 INFO - [mozharness: 2017-07-26 02:52:24.035980Z] Finished install step (success) 19:52:24 INFO - [mozharness: 2017-07-26 02:52:24.036129Z] Running setup-mitmproxy step. 19:52:24 INFO - Running pre-action listener: _resource_record_pre_action 19:52:24 INFO - Running main action method: setup_mitmproxy 19:52:24 INFO - Skipping: mitmproxy is not required 19:52:24 INFO - Running post-action listener: _resource_record_post_action 19:52:24 INFO - [mozharness: 2017-07-26 02:52:24.036660Z] Finished setup-mitmproxy step (success) 19:52:24 INFO - [mozharness: 2017-07-26 02:52:24.036764Z] Running run-tests step. 19:52:24 INFO - Running pre-action listener: _resource_record_pre_action 19:52:24 INFO - Running pre-action listener: _set_gcov_prefix 19:52:24 INFO - Running main action method: run_tests 19:52:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 19:52:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 19:52:24 INFO - Python 2.7.3 19:52:24 INFO - Return code: 0 19:52:24 INFO - grabbing minidump binary from tooltool 19:52:24 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')]} 19:52:24 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 0x1445eb0>, '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 0x1446db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1447240>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 19:52:24 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 19:52:24 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 19:52:24 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 19:52:24 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 19:52:24 INFO - Return code: 0 19:52:24 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 19:52:24 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 19:52:24 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 19:52:24 INFO - ENV: RUST_BACKTRACE is now 1 19:52:24 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 19:52:24 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 19:52:24 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/doubB920S6SAYge54loW3Q/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-001', '--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 19:52:24 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/doubB920S6SAYge54loW3Q/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-001 --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 19:52:24 INFO - Using env: {'DISPLAY': ':0', 19:52:24 INFO - 'HOME': '/home/cltbld', 19:52:24 INFO - 'LANG': 'en_US.UTF-8', 19:52:24 INFO - 'LANGUAGE': 'en_US:en', 19:52:24 INFO - 'LOGNAME': 'cltbld', 19:52:24 INFO - 'MAIL': '/var/mail/cltbld', 19:52:24 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 19:52:24 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 19:52:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:52:24 INFO - 'MOZ_NO_REMOTE': '1', 19:52:24 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 19:52:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:52:24 INFO - 'NO_EM_RESTART': '1', 19:52:24 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:52:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:52:24 INFO - 'PWD': '/builds/slave/test', 19:52:24 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 19:52:24 INFO - 'RUST_BACKTRACE': '1', 19:52:24 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 19:52:24 INFO - 'SHELL': '/bin/bash', 19:52:24 INFO - 'SHLVL': '1', 19:52:24 INFO - 'STYLO_FORCE_ENABLED': '1', 19:52:24 INFO - 'TERM': 'linux', 19:52:24 INFO - 'TMOUT': '86400', 19:52:24 INFO - 'USER': 'cltbld', 19:52:24 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1501037239.544001-1503337172', 19:52:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:52:24 INFO - '_': '/tools/buildbot/bin/python'} 19:52:24 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/doubB920S6SAYge54loW3Q/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-001', '--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 19:52:24 INFO - mozversion application_buildid: 20170726020448 19:52:24 INFO - mozversion application_changeset: 9eddb0a92820c6445f9d1e680e4c239e888e93f0 19:52:24 INFO - mozversion application_display_name: Nightly 19:52:24 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 19:52:24 INFO - mozversion application_name: Firefox 19:52:24 INFO - mozversion application_remotingname: firefox 19:52:24 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 19:52:24 INFO - mozversion application_vendor: Mozilla 19:52:24 INFO - mozversion application_version: 56.0a1 19:52:24 INFO - mozversion platform_buildid: 20170726020448 19:52:24 INFO - mozversion platform_changeset: 9eddb0a92820c6445f9d1e680e4c239e888e93f0 19:52:24 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 19:52:24 INFO - mozversion platform_version: 56.0a1 19:52:24 INFO - using testdate: 1501037544 19:52:24 INFO - actual date: 1501037544 19:52:24 INFO - starting webserver on 'localhost:47807' 19:52:24 INFO - SUITE-START | Running 2 tests 19:52:24 INFO - TEST-START | dromaeo_css 19:52:24 INFO - Initialising browser for dromaeo_css test... 19:52:24 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:47807/getInfo.html -profile /tmp/tmpPzXrAp/profile 19:52:24 INFO - TEST-INFO | started process 7898 (/builds/slave/test/build/application/firefox/firefox http://localhost:47807/getInfo.html) 19:52:30 INFO - TEST-INFO | 7898: exit 0 19:52:30 INFO - Browser initialized. 19:52:30 INFO - Running cycle 1/1 for dromaeo_css test... 19:52:30 INFO - TEST-INFO | started process 8123 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpPzXrAp/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 19:52:31 INFO - PID 8123 | 19:52:31 INFO - PID 8123 | (/builds/slave/test/build/application/firefox/firefox:8180): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 19:52:31 INFO - PID 8123 | 19:52:42 INFO - PID 8123 | RSS: Main: 171122688 19:52:42 INFO - PID 8123 | 19:55:41 INFO - PID 8123 | Cycle 1(1): loaded http://localhost:47807/tests/dromaeo/cssquery-dojo.html (next: http://localhost:47807/tests/dromaeo/cssquery-ext.html) 19:55:43 INFO - PID 8123 | RSS: Main: 175243264 19:55:43 INFO - PID 8123 | 19:58:45 INFO - PID 8123 | Cycle 1(1): loaded http://localhost:47807/tests/dromaeo/cssquery-ext.html (next: http://localhost:47807/tests/dromaeo/cssquery-jquery.html) 19:58:45 INFO - PID 8123 | RSS: Main: 173973504 19:58:45 INFO - PID 8123 | 20:01:47 INFO - PID 8123 | Cycle 1(1): loaded http://localhost:47807/tests/dromaeo/cssquery-jquery.html (next: http://localhost:47807/tests/dromaeo/cssquery-mootools.html) 20:01:48 INFO - PID 8123 | RSS: Main: 175448064 20:01:48 INFO - PID 8123 | 20:04:50 INFO - PID 8123 | Cycle 1(1): loaded http://localhost:47807/tests/dromaeo/cssquery-mootools.html (next: http://localhost:47807/tests/dromaeo/cssquery-prototype.html) 20:04:50 INFO - PID 8123 | RSS: Main: 173654016 20:04:50 INFO - PID 8123 | 20:07:54 INFO - PID 8123 | Cycle 1(1): loaded http://localhost:47807/tests/dromaeo/cssquery-prototype.html (next: http://localhost:47807/tests/dromaeo/cssquery-yui.html) 20:07:55 INFO - PID 8123 | RSS: Main: 175316992 20:07:55 INFO - PID 8123 | 20:10:57 INFO - PID 8123 | Cycle 1(1): loaded http://localhost:47807/tests/dromaeo/cssquery-yui.html (next: http://localhost:47807/tests/dromaeo/cssquery-dojo.html) 20:10:57 INFO - PID 8123 | RSS: Main: 178040832 20:10:57 INFO - PID 8123 | 20:10:57 INFO - PID 8123 | __start_tp_report 20:10:57 INFO - PID 8123 | _x_x_mozilla_page_load 20:10:57 INFO - PID 8123 | _x_x_mozilla_page_load_details 20:10:57 INFO - PID 8123 | |i|pagename|runs| 20:10:57 INFO - PID 8123 | |0;dojo.html;3084.7069528394795;3123.187971127506;3142.7171554560086;3155.9211019724503;3186.808791472512;6053.152558641794;6063.181470501481;6089.482393996515;6137.601055931367;6146.846328841775;6222.937770622292;6261.092141639471;6320.083587879754;6321.6523091229965;6326.240851097863;5678.687672178018;5705.2012718219485;5726.62776919501;5760.337561180455;5819.010768169422;5530.391656917735;5599.608027438081;5645.350784659755;5725.198472213893;5738.3687794342795;5577.163425486189;5686.175504551838;5690.089585666295;5702.6293290935955;5703.287089113882;5619.719014049281;5656.604037717361;5720.8855822883725;5723.51350135239;5738.196652468658;5504.4495550445035;5564.387917329091;5598.216249725042;5665.206871038058;5691.573132015115;6026.397360263983;6036.456718895277;6046.909296360558;6092.969535152296;6108.816735497942;6567.376099270562;6569.113169722074;6633.601983880934;6639.435647969928;6648.335166483362;6644.335566443317;6665.400113989765;6677.465802735818;6716.664166791641;6727.091842601235;6009.248843894513;6098.573099883054;6106.572539922163;6143.017117261216;6267.561270711052;6689.1972963244725;6694.59832410057;6707.49693772969;6717.992301154768;6718.025886246564;6294.402031806971;6365.649889256043;6367.777127800505;6372.203474565679;6400;6468.8059358219325;6473.190851143607;6484.837879053061;6485.156929599122;6503.512236582275;6387.680615969183;6398.29618741938;6419.325970773095;6424.453921416732;6467.547271691031;6482.092507049017;6499.707513161919;6508.121403610547;6520.250171230369;6598.637074960923;5356.384015838228;5356.651817631841;5407.891842163135;5422.349318081777;5432.592555558349;4594;4637.698549594265;4647.070585882837;4659.976700116477;4661.230896901973;5627.606067575312;5709.600327977002;5716.57125715573;5717.456841600041;5724.79963201286;6587.769428069994;6682.431993280528;6686.665666716742;6688.230853451818;6693.732250710014;5710.2862142232225;5765.88468230633;5796.768129274782;5808;5822.563307751935;5818.127280907897;5821.679807610537;5904.9704751475965;5906.645601263938;5931.851703707442;6258.812235632939;6365.777197798055;6371.722051968083;6413.583117097373;6510;6623.238327592196;6673.933260667525;6680.5991640501725;6683.6324002180345;6693.866122677422;6344.746210151542;6408.807735767934;6442.935570644234;6490.156279683611;6521.054447105048;6480.837979050561;6529.249136349381;6533.379328963741;6606.273309935807;6612.437942774918;6492.448141907802;6572.474202063728;6650.73397064112;6749.797506074826;6770.4922130839395;6367.61794292344;6461.870762584816;6472.967635161794;6490.643014634241;6497.935020649922;6375.489960803217;6388.968055159695;6482.902756458751;6497.577657452251;6513.088167656437;6297.2128483939505;6308.873822523432;6394.680265986775;6399.232092148972;6459.224893012869;6249.375062493714;6411;6421.068945003042;6493.253275873335;6543.1821022372205;6285.1515045470105;6289.528285378707;6291.150694656163;6291.811245662638;6303 20:10:57 INFO - PID 8123 | |1;ext.html;820.6594263380694;857.7598272483705;880.3353468131563;891.1845661219984;1155.9826602600958;32226;32770.34459310815;32828.17929551762;43272.35091473623;44226;43798.34302485465;44257.557424425744;44407;44496.33255501162;44610.33084503735;7450.739224127156;7763;7890.605469726519;8035.477693949903;8068.677252909906;7885.250901164381;7978.2420670036545;8002.119766825645;8008.919910800905;8013.959930200341;7941.28528432441;7989.121196668362;7998.880016799752;8000.759977200693;8020.959895200516;7949.721759738411;7998.800029999267;8002.079760827463;8002.119766825645;8005.4796438231915;7870.724524641667;7907.327877130451;7932.405069619744;7934.523928564305;7935.920640793576;40564.39153412701;41070;41086.794566027274;41255.174896502205;41373.37939930904;3590.407582748843;3617.0595645132194;3631.455281707739;3640.9453858192146;3644;32287.192820179447;32344.35311293761;32449;32494.350112997843;32594;4848.806047758086;4873.439554451213;4985.202367621199;5097.541221290102;5167.689938603658;184452;185895;186225.0688746561;186490;186565;49412.0117597646;49717;49926.25110623344;50022.749886250334;50277.24584131241;53680.73159634177;53843.46156538463;53944.460555394726;53958.190627140626;53963.460365396626;16252.837471625133;16564;16577;16799.496015119566;16924.153792310583;11925;12087.576934807239;12088.818667719992;13491.920646348268;13686.52097176614;14966.326515306837;14996.625084372978;15014.024088434217;15204.239788010555;15319.387224511118;6066.545009124334;6078.665673388006;6089.269287685506;6098.207233059763;6120.357362476965;985.393982700634;995.9701208963743;1008.1380419741163;1016.2732999547602;1033.478093562746;22438.887805561193;22846.885765571067;23531.17640882595;28475.857620712177;29639.407211855643;1030.5362586835954;1033.5762337441763;1083.1443159903745;1088.3959402531514;1091.497910960967;11768.58809941648;12318.670625514716;12410.317432541116;12451;15907.920460397623;247049;250228;250554;250658;251003;59569.404305956385;60027.19918402455;60141;60164;60264.397356026755;1447.1751101872042;1503.2934520775218;1523.535321726884;1525.5499627609881;1528.4039224702376;27208.591871121553;27379.178624641292;27449.588256175775;27865.16404507787;27944.720552795025;38898;39499;39506.802465987486;39571.60428395679;39642.2071558573;217639;218751;219207;219709;220714;34888.12779680528;38648.42027369648;39156.80421597874;39304;39433.211335773696;47296;48751.756241218565;48982;49026.26460603022;49977;34280.657193427745;34801.30397392088;35058.82470587733;35335.293294134484;35565.82217088898;33287.33425331528;33357.49963750594;34670.479942800375;34888.825555872056;35110;38394.42408363821;38584.80707596444;38773;38832.41751373675;38907.80546097364;32721.672783272814;33407;33707.49438758371;33740.83129584337;34018;24032.158874439312;24080.51838963246;24509.338437779625;24943.251702448957;24994.750052499243 20:10:57 INFO - PID 8123 | |2;jquery.html;559.4908633143834;561.441365840988;567.4949295127337;588.6144575303176;603.1706403694919;22411.775882241174;22613.773862261372;23458.530829383424;23510.29469115927;23540.17609383672;25160.37099072524;25792;26941.730582694217;27088.864555677243;27127.1861844145;6533.705983230754;6711.664416779166;6719.8656026879435;6721.563098398613;6724.95763156709;5960.552958528127;6604.141461609984;6680.632565208936;6685.231198412196;6693.364130407604;6328.715207815636;6467.353264673542;6485.189351331083;6491.837704057389;6502.804915852532;6448.516361272923;6472.676366181696;6475.384838440341;6491.772787952399;6509.4466970307585;6015.518758499354;6036.486898613623;6042.9395706042815;6045.3047899491685;6053.303870054956;27345.726542734516;28277.71722282792;28782.136535903956;28901.277468063257;29174;1850.481865077767;1927.3736035788286;1928.845692344609;1930.5270208798934;1937.5446770009037;18460.53848653781;19202.231910723553;19204.327848525234;19210.423687289403;19223.134958926883;2325.813934885205;2337.18198630478;2364.408897775556;2380.8571485710913;2426.3085020768995;127036.36481817624;129294.35352823269;129627.99999999905;129682.3515882424;130071;14185.290735463186;14779.778303325458;14865.182414967281;15083.245837708071;15656.686866262839;22308;23413.180538681063;23892.52214955726;23957.760422395902;23959.760402396103;10171.593136274614;10230.488475576192;10324.638637647797;10339.4313312767;10356.119729823049;9382;9389.765255868659;9418.576164072632;9466.763330916645;9649.179819715262;9220.8616870747;9339.766505837408;9404.012578679278;9452.669156579625;9745.463999479955;2694.1648089092446;2758.682751483605;2765.9308517287227;2854.1152242804797;2889.6099026631555;963.7638778499313;978.9608415663436;979.3242662562809;995.2684776689127;1023.6570748799087;19253.133608987628;19471.805281947283;19669.704954425695;19717.408477745692;20306.79693203049;1025.487256371814;1063.771289172816;1068.5832525315134;1071.1109778883508;1080.9459527023616;10907.83638245427;11071.501782419811;11078.889211107948;11114.166437517219;11359.034482068952;454119;466126;468197;475503;481990;107887.46056269668;109181;109810;110156.449217755;110205;1212.1878341511208;1230.0958795285458;1242.1118899986373;1256.9057320700983;1259.6976725585976;16683.74974375361;20928.37214883556;21925;22287.777122229218;22292.331230063122;52510;52913;53893.46106539041;56157;57403.712981436496;67945.66027169832;68535.65732171308;69116;69444.30555694379;69887.65056174686;14870.925645371704;15128.54614361527;15200.46798362052;15205.239738012833;15313.234338282818;23680;23708.288751337488;23758.287251382488;24044.15845445401;24190.395240119138;18485.353012644493;18681;18845;18865.71701424452;18992.715109273096;16450.424235151713;17383;17687.64624707473;18062.096895155453;18356.816431835512;18571.535711607317;19845.702314465583;19856;20057.498562536053;20109.39671809848;14313.998020138906;14358.425662973365;14386.928065359607;14658.267086645412;14674.33965471535;18538;18827.717584235972;19018.23927042903;19173.616527669088;19187.712184317526 20:10:57 INFO - PID 8123 | |3;mootools.html;1352.09409695504;1409.9718005639888;1436.073732442575;1436.4254298280687;1438.791375250588;12991.285479298647;13377.197368157917;13658.453661853526;13685.589432317021;13697.589072327833;14171.645708857284;14250.928745356285;14440.277986100678;14457.0602910811;14478.42086316546;2615.62073499343;2680.1825443239804;2681.932951676214;2683.7047924728363;2684.6912605050475;2485.0680994627014;2621.9213423597225;2669.893204271827;2670.9465810683773;2671.6927553331325;2581.6256642786784;2622.9344266393396;2623.724508926564;2625.0681008242086;2625.2518032360686;2545.1982625472915;2547.8025328095764;2569.79441644668;2573.356660834782;2576.8067394945456;2471.283327834926;2477.306354220803;2514.1828905605753;2518.9118380856767;2530.4812513434704;13027.478900843955;13302.667433314244;13346.26595537245;13348.933255333759;13350.666233344244;7309.597972111532;7547.28300811422;7590.848183036308;7607.429442791813;7609.391248700091;4894.3147959285725;4948.233023881304;5018.5232402921665;5086.287919691246;5099.515546023122;1783.5362805670488;1799.8020217776166;1825.4067428085925;1857.4241984984699;1858.6468570971472;20768.48078798042;20801.5839683207;20870.89564552183;20908;21018.789812101837;6132.63204207749;6173.722182501798;6298.149749783812;6391.07329437229;6625.536212465177;15350.539483815503;15358.462453814287;15567.29947152381;16066.75899861503;16145.112018838841;7417.221191774786;7618.200088990576;7618.809529761689;7633.084029916446;7668.156502784689;6762.594244345355;6964.582125072512;7029.156501219886;7034.366906978396;7046.1192350956135;4785.234362501983;4928.852134435972;4962.627802914723;4975.701457912537;5140.665856719376;1386.8335799703898;1398.440623750508;1411.5412490940485;1411.9223442710545;1415.5753274017754;851.3997631669658;856.8586183279814;865.6580650643086;886.7472770260445;912.3431129586687;7064.470164737665;7091.078159839188;7150.141982962078;7183.92816071843;7214.242504537053;657.2540166910495;671.3990978074596;707.1302298173173;708.3872450330427;711.8256027273351;4606;4716.528347165256;4813.807447702053;4889.462159162489;5112.3865136183895;17749.55626109332;18076.276948922157;18385.448436546925;18395.264189432273;18414.539636509195;18607.16267767954;18883.244670213313;18897.90551047236;18916;18932.337368192046;9839.262055345878;10318.071373576415;10407.323523970766;10424.426656533811;10475.47622618866;7458.925410745823;7795.493292935941;8096.352291816758;8155.510669359857;8362.331013518782;15439.922800386375;16499.17504124813;16624;16852.747208792123;16854;16500.257488413292;16652.833471665614;16678.16609169561;16844.747328790323;16941.91529042347;11136.220464567403;11229.943850280697;11349.48927298257;11371.43142842871;11384.089272857986;12692.873071269169;12938.353082346033;12940.935295323463;12958.740825183255;12963;9881;9985.800283994135;10061.14480269156;10326.896731032593;10452.954704529486;10150.54322555472;10249.38503689781;10459.424731639529;10519.631812886511;10556.102731267929;9411.811763764823;9567.665131720356;9567.712968610953;9571.664991725256;9577.760555985877;6533.640649764308;6875.690593923186;7009.12385951756;7079.362857342658;7092.5389849659605;6312.179416675803;6535.607863528204;6590.50571207171;6866.6566671667215;6918.5502942308585 20:10:57 INFO - PID 8123 | |4;prototype.html;494.24133954380034;496.9985479259293;525.6163001009264;534.5286676947337;538.1524099543218;6068.514518838493;6146.354632763557;6233.719482623282;6245.781397651083;6317;6021.367756385582;6067.87864242716;6077.817665470032;6101.481374083197;6138.140660307549;4941.481144479822;4963.875903102433;4970.900581988358;4986.4514903360605;5010.198368261079;4878.512148785111;4920.188168952119;4957.603391728671;4962.865967633916;4968.3292755477905;4957.5786058185095;4965.3296804931415;4965.577925876305;4983.626228032894;4988.625853061017;4928.137575924235;4951.702897826124;4982.427020892607;5007.098722229997;5021.096202683516;4451.910961780746;4456.442944631921;4488.304312831517;4492.460904691458;4515.277555591089;6040.879182416327;6087.908681369783;6094.481969032638;6132.049532322497;6143.017117261262;5573.916391254134;5598.1602759585985;5704.629199102086;5714.257146570919;5733.569982251348;6465.579737317059;6497.870042599122;6500.772472963424;6537.378948999837;6555.573887697332;4890.24201248807;4900.362952816146;4924;4947.233178857283;4948.455669876346;6700.83247918806;6827.337338438063;6839.760608378732;6855.104610035366;6883.070785443951;4960.50394960501;4992.750362481861;4998.150314446553;4998.800047998039;5014.674046186986;5041.59667226621;5066.138756411419;5116.897662046738;5119.8720031998755;5130.56344223618;5505.366882808528;5573.136163894603;5617.662940223599;5645.633033852869;5651.321841379061;6223.813285601439;6455.868244323637;6458.903116453257;6496.473328767735;6516.869662606816;1687.4094067076426;1738.8089158926175;1746.1531157388656;1753.7194048952106;1754.6402987387555;1189.6668932698858;1197.3354788092518;1205.3370646144585;1206.8913797758244;1215.3133479584008;5647.272799952094;5688.488036076773;5730.627509211888;5747;5786.884262314814;6632.635205063768;6682.599044057372;6684.364985326386;6703.932960670429;6710.899336509956;5757.596968212269;5773.566982476247;5791.8552036199435;5818.6217895836635;5830.47525722687;3498.4052711039185;3562.127278816655;3593.5867375252183;3596.5324507813816;3607.603163651996;6423.839404014843;6480.060391243243;6480.416762491398;6487.7080531376205;6511.609303441809;6729.562578432484;6736.012876201532;6770.458363330922;6786.287439818748;6817.284185160586;6321;6347.492200623939;6407.423331900151;6442.645654488954;6495.837604059747;6554.410103090745;6583.835404114935;6674.332566743286;6689.598624082376;6759.459243260429;6511;6552.115464412243;6570.901436478361;6599.241087275025;6683.365080317362;6414.74912392079;6424.807255782334;6456.995828233157;6501.349865013461;6548.116004339353;5033.899322013613;5058.241263810311;5060.873478163076;5062.974810075999;5079.568236699774;6359.713812878339;6622.1722284714415;6681.198256209286;6783.559068660521;6799.422049125879;6367.713452894538;6410.5192110592825;6411.7300176909175;6467.644279564481;6536.7712130075215;6456.2575303838785;6460.45086167681;6499.7400103995315;6530.869382612416;6575.704093315717;6309.652969086745;6384.7446102157255;6414.7434102637235;6442.425877626937;6445.323241059621;6502.804915852532;6517.283098859217;6570.638614876228;6592.736595385315;6629.834254143685;6292.622442653455;6320.304766475776;6375.075614035846;6380.9361906380345;6386.742761191733 20:10:57 INFO - PID 8123 | |5;yui.html;915.1306259053896;921.5898924978384;936.765808547863;940.0176815228086;953.5613617735842;14747.705045899076;15137.621559461006;15155.318010689518;21042.684359734616;22023;19307.613847723038;19504.317348892793;20456.8977155114;20541.486462838435;20542.281020164297;987.8863930647996;1011.7318910488726;1011.9898801012006;1012.1396812709212;1014.2697257974284;973.1193270090579;1054.8206804843196;1059.6873922192972;1061.0768631290787;1061.1828891753385;1110.7112150840799;1117.6311817100338;1118.8601424821898;1119.5857532712907;1119.8208286674135;1107.7064577886867;1109.4508218431847;1110.8666959964817;1112.6272698645964;1112.9109671226283;811.809224832164;816.930560902324;817.0195765081866;817.284875733733;818.7953011747063;18426.815731842646;18769.53076173093;18998.05009749507;19032.61934761311;19142.808571914244;20008.599828003506;20151.294704685264;20584.691229631568;20592.073356698984;20678;15991.600209994727;16238.350465981464;16452.259648315736;16503;16587.170641467997;3496.7377446691344;3535.7701749386206;3547.467879818022;3552.662497062775;3554.36021516127;119840;121658;124310;126349;126833;15456.768148477782;15880;16078.919605402132;16093.839061609468;16113.919430402773;23635.645465318034;24034.639480407808;30156.94450694259;30178.24554386158;30433.847830761148;8497.490150590984;8723.08407617191;8740.125987401336;8768.210861022411;8771.298296136294;4013.7591744495426;4116.197341518375;4142.337226043818;4161.354989976498;4180.686448516312;4912;5132.8460146195675;5139.486051394905;5158.6131040171385;5165.483451654804;1038.0916697889347;1062.8193207154802;1081.4430568257353;1083.4853444613902;1087.260662749338;653.8724948634971;672.4015626092781;673.2657787506016;700.9264027277164;704.4505285877024;11234.662960111209;11531.654050378502;12118.81821772674;12774.489020439078;13188.604341869759;596.0790578556141;600.7146605362418;610.2798697536861;649.3247023096021;656.1142457682091;5132.435432102466;5172.301739265226;5251.632385732962;5337.6797392156595;5374.167004114291;95852;97045.51477242568;104791;106574.46712766541;107518;87829.56085219533;88291.55854220688;89187;94284;94503.52748236214;75516;78171;81388.77916831253;81519;83450;10798.13614910821;10837.45812709377;10879.564817407216;11092.500837462172;11138.498767555642;34295.31409371749;35398.9871675113;36003.81998089993;36055.27889442249;37508.81245593754;47398.28902566395;48185;48327.516724832305;48876;49358.50641493539;15734.685306294039;16428.42500512476;16432.75350869714;16548.007119572863;16613.91693041527;16405.67188656244;17015.14924253807;17155.485335439957;17161.399351022654;17316.65366692634;14264.429422823387;14363.712725745218;14417.711645767236;14526.564203073502;14531.564053078424;15367;15556.844431555539;15617.14105724196;15626.45307414235;15853.048817071012;15362.615934601277;15776;17566.73649895278;18371.448856534324;18396.080195990413;12951.5466958656;13385.598432047054;13746.381412836246;13849;14113.858861411254;13587.796183057064;13627.182369057888;13728;14246.928765356108;14378.352974116398 20:10:57 INFO - PID 8123 | __end_tp_report 20:10:57 INFO - PID 8123 | __start_cc_report 20:10:57 INFO - PID 8123 | _x_x_mozilla_cycle_collect,373 20:10:57 INFO - PID 8123 | __end_cc_report 20:10:57 INFO - PID 8123 | __startTimestamp1501038657438__endTimestamp 20:10:57 INFO - PID 8123 | 20:10:57 INFO - PID 8123 | ------- Summary: start ------- 20:10:57 INFO - PID 8123 | Number of tests: 6 20:10:57 INFO - PID 8123 | 20:10:57 INFO - PID 8123 | [#0] dojo.html Cycles:165 Average:6079.07 Median:6320.08 stddev:699.23 (11.1%) stddev-sans-first:660.74 20:10:57 INFO - PID 8123 | Values: 3084.7 3123.2 3142.7 3155.9 3186.8 6053.2 6063.2 6089.5 6137.6 6146.8 6222.9 6261.1 6320.1 6321.7 6326.2 5678.7 5705.2 5726.6 5760.3 5819.0 5530.4 5599.6 5645.4 5725.2 5738.4 5577.2 5686.2 5690.1 5702.6 5703.3 5619.7 5656.6 5720.9 5723.5 5738.2 5504.4 5564.4 5598.2 5665.2 5691.6 6026.4 6036.5 6046.9 6093.0 6108.8 6567.4 6569.1 6633.6 6639.4 6648.3 6644.3 6665.4 6677.5 6716.7 6727.1 6009.2 6098.6 6106.6 6143.0 6267.6 6689.2 6694.6 6707.5 6718.0 6718.0 6294.4 6365.6 6367.8 6372.2 6400.0 6468.8 6473.2 6484.8 6485.2 6503.5 6387.7 6398.3 6419.3 6424.5 6467.5 6482.1 6499.7 6508.1 6520.3 6598.6 5356.4 5356.7 5407.9 5422.3 5432.6 4594.0 4637.7 4647.1 4660.0 4661.2 5627.6 5709.6 5716.6 5717.5 5724.8 6587.8 6682.4 6686.7 6688.2 6693.7 5710.3 5765.9 5796.8 5808.0 5822.6 5818.1 5821.7 5905.0 5906.6 5931.9 6258.8 6365.8 6371.7 6413.6 6510.0 6623.2 6673.9 6680.6 6683.6 6693.9 6344.7 6408.8 6442.9 6490.2 6521.1 6480.8 6529.2 6533.4 6606.3 6612.4 6492.4 6572.5 6650.7 6749.8 6770.5 6367.6 6461.9 6473.0 6490.6 6497.9 6375.5 6389.0 6482.9 6497.6 6513.1 6297.2 6308.9 6394.7 6399.2 6459.2 6249.4 6411.0 6421.1 6493.3 6543.2 6285.2 6289.5 6291.2 6291.8 6303.0 20:10:57 INFO - PID 8123 | 20:10:57 INFO - PID 8123 | [#1] ext.html Cycles:180 Average:39873.43 Median:3636.20 stddev:57072.45 (1569.6%) stddev-sans-first:57157.22 20:10:57 INFO - PID 8123 | Values: 820.7 857.8 880.3 891.2 1156.0 32226.0 32770.3 32828.2 43272.4 44226.0 43798.3 44257.6 44407.0 44496.3 44610.3 7450.7 7763.0 7890.6 8035.5 8068.7 7885.3 7978.2 8002.1 8008.9 8014.0 7941.3 7989.1 7998.9 8000.8 8021.0 7949.7 7998.8 8002.1 8002.1 8005.5 7870.7 7907.3 7932.4 7934.5 7935.9 40564.4 41070.0 41086.8 41255.2 41373.4 3590.4 3617.1 3631.5 3640.9 3644.0 32287.2 32344.4 32449.0 32494.4 32594.0 4848.8 4873.4 4985.2 5097.5 5167.7 184452.0 185895.0 186225.1 186490.0 186565.0 49412.0 49717.0 49926.3 50022.7 50277.2 53680.7 53843.5 53944.5 53958.2 53963.5 16252.8 16564.0 16577.0 16799.5 16924.2 11925.0 12087.6 12088.8 13491.9 13686.5 14966.3 14996.6 15014.0 15204.2 15319.4 6066.5 6078.7 6089.3 6098.2 6120.4 985.4 996.0 1008.1 1016.3 1033.5 22438.9 22846.9 23531.2 28475.9 29639.4 1030.5 1033.6 1083.1 1088.4 1091.5 11768.6 12318.7 12410.3 12451.0 15907.9 247049.0 250228.0 250554.0 250658.0 251003.0 59569.4 60027.2 60141.0 60164.0 60264.4 1447.2 1503.3 1523.5 1525.5 1528.4 27208.6 27379.2 27449.6 27865.2 27944.7 38898.0 39499.0 39506.8 39571.6 39642.2 217639.0 218751.0 219207.0 219709.0 220714.0 34888.1 38648.4 39156.8 39304.0 39433.2 47296.0 48751.8 48982.0 49026.3 49977.0 34280.7 34801.3 35058.8 35335.3 35565.8 33287.3 33357.5 34670.5 34888.8 35110.0 38394.4 38584.8 38773.0 38832.4 38907.8 32721.7 33407.0 33707.5 33740.8 34018.0 24032.2 24080.5 24509.3 24943.3 24994.8 20:10:57 INFO - PID 8123 | 20:10:57 INFO - PID 8123 | [#2] jquery.html Cycles:180 Average:33868.19 Median:12875.18 stddev:78817.30 (612.2%) stddev-sans-first:78998.72 20:10:57 INFO - PID 8123 | Values: 559.5 561.4 567.5 588.6 603.2 22411.8 22613.8 23458.5 23510.3 23540.2 25160.4 25792.0 26941.7 27088.9 27127.2 6533.7 6711.7 6719.9 6721.6 6725.0 5960.6 6604.1 6680.6 6685.2 6693.4 6328.7 6467.4 6485.2 6491.8 6502.8 6448.5 6472.7 6475.4 6491.8 6509.4 6015.5 6036.5 6042.9 6045.3 6053.3 27345.7 28277.7 28782.1 28901.3 29174.0 1850.5 1927.4 1928.8 1930.5 1937.5 18460.5 19202.2 19204.3 19210.4 19223.1 2325.8 2337.2 2364.4 2380.9 2426.3 127036.4 129294.4 129628.0 129682.4 130071.0 14185.3 14779.8 14865.2 15083.2 15656.7 22308.0 23413.2 23892.5 23957.8 23959.8 10171.6 10230.5 10324.6 10339.4 10356.1 9382.0 9389.8 9418.6 9466.8 9649.2 9220.9 9339.8 9404.0 9452.7 9745.5 2694.2 2758.7 2765.9 2854.1 2889.6 963.8 979.0 979.3 995.3 1023.7 19253.1 19471.8 19669.7 19717.4 20306.8 1025.5 1063.8 1068.6 1071.1 1080.9 10907.8 11071.5 11078.9 11114.2 11359.0 454119.0 466126.0 468197.0 475503.0 481990.0 107887.5 109181.0 109810.0 110156.4 110205.0 1212.2 1230.1 1242.1 1256.9 1259.7 16683.7 20928.4 21925.0 22287.8 22292.3 52510.0 52913.0 53893.5 56157.0 57403.7 67945.7 68535.7 69116.0 69444.3 69887.7 14870.9 15128.5 15200.5 15205.2 15313.2 23680.0 23708.3 23758.3 24044.2 24190.4 18485.4 18681.0 18845.0 18865.7 18992.7 16450.4 17383.0 17687.6 18062.1 18356.8 18571.5 19845.7 19856.0 20057.5 20109.4 14314.0 14358.4 14386.9 14658.3 14674.3 18538.0 18827.7 19018.2 19173.6 19187.7 20:10:57 INFO - PID 8123 | 20:10:57 INFO - PID 8123 | [#3] mootools.html Cycles:180 Average:8431.77 Median:2571.58 stddev:5671.02 (220.5%) stddev-sans-first:5661.97 20:10:57 INFO - PID 8123 | Values: 1352.1 1410.0 1436.1 1436.4 1438.8 12991.3 13377.2 13658.5 13685.6 13697.6 14171.6 14250.9 14440.3 14457.1 14478.4 2615.6 2680.2 2681.9 2683.7 2684.7 2485.1 2621.9 2669.9 2670.9 2671.7 2581.6 2622.9 2623.7 2625.1 2625.3 2545.2 2547.8 2569.8 2573.4 2576.8 2471.3 2477.3 2514.2 2518.9 2530.5 13027.5 13302.7 13346.3 13348.9 13350.7 7309.6 7547.3 7590.8 7607.4 7609.4 4894.3 4948.2 5018.5 5086.3 5099.5 1783.5 1799.8 1825.4 1857.4 1858.6 20768.5 20801.6 20870.9 20908.0 21018.8 6132.6 6173.7 6298.1 6391.1 6625.5 15350.5 15358.5 15567.3 16066.8 16145.1 7417.2 7618.2 7618.8 7633.1 7668.2 6762.6 6964.6 7029.2 7034.4 7046.1 4785.2 4928.9 4962.6 4975.7 5140.7 1386.8 1398.4 1411.5 1411.9 1415.6 851.4 856.9 865.7 886.7 912.3 7064.5 7091.1 7150.1 7183.9 7214.2 657.3 671.4 707.1 708.4 711.8 4606.0 4716.5 4813.8 4889.5 5112.4 17749.6 18076.3 18385.4 18395.3 18414.5 18607.2 18883.2 18897.9 18916.0 18932.3 9839.3 10318.1 10407.3 10424.4 10475.5 7458.9 7795.5 8096.4 8155.5 8362.3 15439.9 16499.2 16624.0 16852.7 16854.0 16500.3 16652.8 16678.2 16844.7 16941.9 11136.2 11229.9 11349.5 11371.4 11384.1 12692.9 12938.4 12940.9 12958.7 12963.0 9881.0 9985.8 10061.1 10326.9 10453.0 10150.5 10249.4 10459.4 10519.6 10556.1 9411.8 9567.7 9567.7 9571.7 9577.8 6533.6 6875.7 7009.1 7079.4 7092.5 6312.2 6535.6 6590.5 6866.7 6918.6 20:10:57 INFO - PID 8123 | 20:10:57 INFO - PID 8123 | [#4] prototype.html Cycles:180 Average:5480.73 Median:6091.20 stddev:1527.01 (25.1%) stddev-sans-first:1484.72 20:10:57 INFO - PID 8123 | Values: 494.2 497.0 525.6 534.5 538.2 6068.5 6146.4 6233.7 6245.8 6317.0 6021.4 6067.9 6077.8 6101.5 6138.1 4941.5 4963.9 4970.9 4986.5 5010.2 4878.5 4920.2 4957.6 4962.9 4968.3 4957.6 4965.3 4965.6 4983.6 4988.6 4928.1 4951.7 4982.4 5007.1 5021.1 4451.9 4456.4 4488.3 4492.5 4515.3 6040.9 6087.9 6094.5 6132.0 6143.0 5573.9 5598.2 5704.6 5714.3 5733.6 6465.6 6497.9 6500.8 6537.4 6555.6 4890.2 4900.4 4924.0 4947.2 4948.5 6700.8 6827.3 6839.8 6855.1 6883.1 4960.5 4992.8 4998.2 4998.8 5014.7 5041.6 5066.1 5116.9 5119.9 5130.6 5505.4 5573.1 5617.7 5645.6 5651.3 6223.8 6455.9 6458.9 6496.5 6516.9 1687.4 1738.8 1746.2 1753.7 1754.6 1189.7 1197.3 1205.3 1206.9 1215.3 5647.3 5688.5 5730.6 5747.0 5786.9 6632.6 6682.6 6684.4 6703.9 6710.9 5757.6 5773.6 5791.9 5818.6 5830.5 3498.4 3562.1 3593.6 3596.5 3607.6 6423.8 6480.1 6480.4 6487.7 6511.6 6729.6 6736.0 6770.5 6786.3 6817.3 6321.0 6347.5 6407.4 6442.6 6495.8 6554.4 6583.8 6674.3 6689.6 6759.5 6511.0 6552.1 6570.9 6599.2 6683.4 6414.7 6424.8 6457.0 6501.3 6548.1 5033.9 5058.2 5060.9 5063.0 5079.6 6359.7 6622.2 6681.2 6783.6 6799.4 6367.7 6410.5 6411.7 6467.6 6536.8 6456.3 6460.5 6499.7 6530.9 6575.7 6309.7 6384.7 6414.7 6442.4 6445.3 6502.8 6517.3 6570.6 6592.7 6629.8 6292.6 6320.3 6375.1 6380.9 6386.7 20:10:57 INFO - PID 8123 | 20:10:57 INFO - PID 8123 | [#5] yui.html Cycles:180 Average:21790.01 Median:18883.79 stddev:29874.45 (158.2%) stddev-sans-first:29917.14 20:10:57 INFO - PID 8123 | Values: 915.1 921.6 936.8 940.0 953.6 14747.7 15137.6 15155.3 21042.7 22023.0 19307.6 19504.3 20456.9 20541.5 20542.3 987.9 1011.7 1012.0 1012.1 1014.3 973.1 1054.8 1059.7 1061.1 1061.2 1110.7 1117.6 1118.9 1119.6 1119.8 1107.7 1109.5 1110.9 1112.6 1112.9 811.8 816.9 817.0 817.3 818.8 18426.8 18769.5 18998.1 19032.6 19142.8 20008.6 20151.3 20584.7 20592.1 20678.0 15991.6 16238.4 16452.3 16503.0 16587.2 3496.7 3535.8 3547.5 3552.7 3554.4 119840.0 121658.0 124310.0 126349.0 126833.0 15456.8 15880.0 16078.9 16093.8 16113.9 23635.6 24034.6 30156.9 30178.2 30433.8 8497.5 8723.1 8740.1 8768.2 8771.3 4013.8 4116.2 4142.3 4161.4 4180.7 4912.0 5132.8 5139.5 5158.6 5165.5 1038.1 1062.8 1081.4 1083.5 1087.3 653.9 672.4 673.3 700.9 704.5 11234.7 11531.7 12118.8 12774.5 13188.6 596.1 600.7 610.3 649.3 656.1 5132.4 5172.3 5251.6 5337.7 5374.2 95852.0 97045.5 104791.0 106574.5 107518.0 87829.6 88291.6 89187.0 94284.0 94503.5 75516.0 78171.0 81388.8 81519.0 83450.0 10798.1 10837.5 10879.6 11092.5 11138.5 34295.3 35399.0 36003.8 36055.3 37508.8 47398.3 48185.0 48327.5 48876.0 49358.5 15734.7 16428.4 16432.8 16548.0 16613.9 16405.7 17015.1 17155.5 17161.4 17316.7 14264.4 14363.7 14417.7 14526.6 14531.6 15367.0 15556.8 15617.1 15626.5 15853.0 15362.6 15776.0 17566.7 18371.4 18396.1 12951.5 13385.6 13746.4 13849.0 14113.9 13587.8 13627.2 13728.0 14246.9 14378.4 20:10:57 INFO - PID 8123 | -------- Summary: end -------- 20:10:57 INFO - PID 8123 | 20:10:58 INFO - TEST-INFO | 8123: exit 0 20:10:58 INFO - TEST-OK | dromaeo_css | took 1113759ms 20:10:58 INFO - TEST-START | kraken 20:10:58 INFO - Initialising browser for kraken test... 20:10:58 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:47807/getInfo.html -profile /tmp/tmpiPyoGm/profile 20:10:58 INFO - TEST-INFO | started process 8498 (/builds/slave/test/build/application/firefox/firefox http://localhost:47807/getInfo.html) 20:11:04 INFO - TEST-INFO | 8498: exit 0 20:11:04 INFO - Browser initialized. 20:11:04 INFO - Running cycle 1/1 for kraken test... 20:11:04 INFO - TEST-INFO | started process 8726 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpiPyoGm/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 20:11:05 INFO - PID 8726 | 20:11:05 INFO - PID 8726 | (/builds/slave/test/build/application/firefox/firefox:8781): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 20:11:05 INFO - PID 8726 | 20:11:15 INFO - PID 8726 | RSS: Main: 171442176 20:11:15 INFO - PID 8726 | 20:11:18 INFO - PID 8726 | Cycle 1(1): loaded http://localhost:47807/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:47807/tests/kraken/driver.html?testName=audio-beat-detection) 20:11:19 INFO - PID 8726 | RSS: Main: 177680384 20:11:19 INFO - PID 8726 | 20:11:21 INFO - PID 8726 | Cycle 1(1): loaded http://localhost:47807/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:47807/tests/kraken/driver.html?testName=audio-dft) 20:11:22 INFO - PID 8726 | RSS: Main: 178827264 20:11:22 INFO - PID 8726 | 20:11:25 INFO - PID 8726 | Cycle 1(1): loaded http://localhost:47807/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:47807/tests/kraken/driver.html?testName=audio-fft) 20:11:26 INFO - PID 8726 | RSS: Main: 173862912 20:11:26 INFO - PID 8726 | 20:11:28 INFO - PID 8726 | Cycle 1(1): loaded http://localhost:47807/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:47807/tests/kraken/driver.html?testName=audio-oscillator) 20:11:28 INFO - PID 8726 | RSS: Main: 174256128 20:11:28 INFO - PID 8726 | 20:11:31 INFO - PID 8726 | Cycle 1(1): loaded http://localhost:47807/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:47807/tests/kraken/driver.html?testName=imaging-gaussian-blur) 20:11:31 INFO - PID 8726 | RSS: Main: 173920256 20:11:31 INFO - PID 8726 | 20:11:34 INFO - PID 8726 | Cycle 1(1): loaded http://localhost:47807/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:47807/tests/kraken/driver.html?testName=imaging-darkroom) 20:11:35 INFO - PID 8726 | RSS: Main: 177627136 20:11:35 INFO - PID 8726 | 20:11:38 INFO - PID 8726 | Cycle 1(1): loaded http://localhost:47807/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:47807/tests/kraken/driver.html?testName=imaging-desaturate) 20:11:39 INFO - PID 8726 | RSS: Main: 176717824 20:11:39 INFO - PID 8726 | 20:11:42 INFO - PID 8726 | Cycle 1(1): loaded http://localhost:47807/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:47807/tests/kraken/driver.html?testName=json-parse-financial) 20:11:43 INFO - PID 8726 | RSS: Main: 177614848 20:11:43 INFO - PID 8726 | 20:11:44 INFO - PID 8726 | Cycle 1(1): loaded http://localhost:47807/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:47807/tests/kraken/driver.html?testName=json-stringify-tinderbox) 20:11:45 INFO - PID 8726 | RSS: Main: 177123328 20:11:45 INFO - PID 8726 | 20:11:47 INFO - PID 8726 | Cycle 1(1): loaded http://localhost:47807/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:47807/tests/kraken/driver.html?testName=stanford-crypto-aes) 20:11:47 INFO - PID 8726 | RSS: Main: 174473216 20:11:47 INFO - PID 8726 | 20:11:49 INFO - PID 8726 | Cycle 1(1): loaded http://localhost:47807/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:47807/tests/kraken/driver.html?testName=stanford-crypto-ccm) 20:11:50 INFO - PID 8726 | RSS: Main: 175185920 20:11:50 INFO - PID 8726 | 20:11:53 INFO - PID 8726 | Cycle 1(1): loaded http://localhost:47807/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:47807/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 20:11:54 INFO - PID 8726 | RSS: Main: 175521792 20:11:54 INFO - PID 8726 | 20:11:57 INFO - PID 8726 | Cycle 1(1): loaded http://localhost:47807/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:47807/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 20:11:57 INFO - PID 8726 | RSS: Main: 175321088 20:11:57 INFO - PID 8726 | 20:11:59 INFO - PID 8726 | Cycle 1(1): loaded http://localhost:47807/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:47807/tests/kraken/driver.html?testName=ai-astar) 20:11:59 INFO - PID 8726 | RSS: Main: 176623616 20:11:59 INFO - PID 8726 | 20:11:59 INFO - PID 8726 | __start_tp_report 20:11:59 INFO - PID 8726 | _x_x_mozilla_page_load 20:11:59 INFO - PID 8726 | _x_x_mozilla_page_load_details 20:11:59 INFO - PID 8726 | |i|pagename|runs| 20:11:59 INFO - PID 8726 | |0;ai-astar;100;109;103;107;108;108;109;110;109;114 20:11:59 INFO - PID 8726 | |1;audio-beat-detection;149;117;145;168;125;150;141;118;172;119 20:11:59 INFO - PID 8726 | |2;audio-dft;165;162;162;162;162;163;169;164;167;164 20:11:59 INFO - PID 8726 | |3;audio-fft;76;79;80;170;77;76;77;76;171;75 20:11:59 INFO - PID 8726 | |4;audio-oscillator;82;78;136;79;82;80;124;79;79;132 20:11:59 INFO - PID 8726 | |5;imaging-gaussian-blur;115;115;114;115;113;116;117;118;113;117 20:11:59 INFO - PID 8726 | |6;imaging-darkroom;152;153;154;152;150;150;151;152;151;150 20:11:59 INFO - PID 8726 | |7;imaging-desaturate;94;94;94;95;94;94;99;94;96;94 20:11:59 INFO - PID 8726 | |8;json-parse-financial;55;54;54;54;61;54;53;53;54;53 20:11:59 INFO - PID 8726 | |9;json-stringify-tinderbox;54;54;54;53;55;54;55;54;54;55 20:11:59 INFO - PID 8726 | |10;stanford-crypto-aes;94;79;87;88;96;79;78;79;95;79 20:11:59 INFO - PID 8726 | |11;stanford-crypto-ccm;132;126;126;128;140;129;138;133;127;170 20:11:59 INFO - PID 8726 | |12;stanford-crypto-pbkdf2;185;178;177;183;173;175;177;187;176;173 20:11:59 INFO - PID 8726 | |13;stanford-crypto-sha256-iterative;72;68;70;67;70;69;69;67;67;71 20:11:59 INFO - PID 8726 | __end_tp_report 20:11:59 INFO - PID 8726 | __start_cc_report 20:11:59 INFO - PID 8726 | _x_x_mozilla_cycle_collect,968 20:11:59 INFO - PID 8726 | __end_cc_report 20:11:59 INFO - PID 8726 | __startTimestamp1501038719733__endTimestamp 20:11:59 INFO - PID 8726 | 20:11:59 INFO - PID 8726 | ------- Summary: start ------- 20:11:59 INFO - PID 8726 | Number of tests: 14 20:11:59 INFO - PID 8726 | 20:11:59 INFO - PID 8726 | [#0] ai-astar Cycles:10 Average:107.70 Median:109.00 stddev:3.83 (3.5%) stddev-sans-first:2.88 20:11:59 INFO - PID 8726 | Values: 100.0 109.0 103.0 107.0 108.0 108.0 109.0 110.0 109.0 114.0 20:11:59 INFO - PID 8726 | 20:11:59 INFO - PID 8726 | [#1] audio-beat-detection Cycles:10 Average:140.40 Median:147.00 stddev:20.26 (13.8%) stddev-sans-first:21.24 20:11:59 INFO - PID 8726 | Values: 149.0 117.0 145.0 168.0 125.0 150.0 141.0 118.0 172.0 119.0 20:11:59 INFO - PID 8726 | 20:11:59 INFO - PID 8726 | [#2] audio-dft Cycles:10 Average:164.00 Median:164.00 stddev:2.40 (1.5%) stddev-sans-first:2.52 20:11:59 INFO - PID 8726 | Values: 165.0 162.0 162.0 162.0 162.0 163.0 169.0 164.0 167.0 164.0 20:11:59 INFO - PID 8726 | 20:11:59 INFO - PID 8726 | [#3] audio-fft Cycles:10 Average:95.70 Median:76.50 stddev:39.45 (51.6%) stddev-sans-first:41.20 20:11:59 INFO - PID 8726 | Values: 76.0 79.0 80.0 170.0 77.0 76.0 77.0 76.0 171.0 75.0 20:11:59 INFO - PID 8726 | 20:11:59 INFO - PID 8726 | [#4] audio-oscillator Cycles:10 Average:95.10 Median:79.00 stddev:24.75 (31.3%) stddev-sans-first:25.79 20:11:59 INFO - PID 8726 | Values: 82.0 78.0 136.0 79.0 82.0 80.0 124.0 79.0 79.0 132.0 20:11:59 INFO - PID 8726 | 20:11:59 INFO - PID 8726 | [#5] imaging-gaussian-blur Cycles:10 Average:115.30 Median:115.50 stddev:1.70 (1.5%) stddev-sans-first:1.80 20:11:59 INFO - PID 8726 | Values: 115.0 115.0 114.0 115.0 113.0 116.0 117.0 118.0 113.0 117.0 20:11:59 INFO - PID 8726 | 20:11:59 INFO - PID 8726 | [#6] imaging-darkroom Cycles:10 Average:151.50 Median:152.00 stddev:1.35 (0.9%) stddev-sans-first:1.42 20:11:59 INFO - PID 8726 | Values: 152.0 153.0 154.0 152.0 150.0 150.0 151.0 152.0 151.0 150.0 20:11:59 INFO - PID 8726 | 20:11:59 INFO - PID 8726 | [#7] imaging-desaturate Cycles:10 Average:94.80 Median:94.00 stddev:1.62 (1.7%) stddev-sans-first:1.69 20:11:59 INFO - PID 8726 | Values: 94.0 94.0 94.0 95.0 94.0 94.0 99.0 94.0 96.0 94.0 20:11:59 INFO - PID 8726 | 20:11:59 INFO - PID 8726 | [#8] json-parse-financial Cycles:10 Average:54.50 Median:54.00 stddev:2.37 (4.4%) stddev-sans-first:2.51 20:11:59 INFO - PID 8726 | Values: 55.0 54.0 54.0 54.0 61.0 54.0 53.0 53.0 54.0 53.0 20:11:59 INFO - PID 8726 | 20:11:59 INFO - PID 8726 | [#9] json-stringify-tinderbox Cycles:10 Average:54.20 Median:54.00 stddev:0.63 (1.2%) stddev-sans-first:0.67 20:11:59 INFO - PID 8726 | Values: 54.0 54.0 54.0 53.0 55.0 54.0 55.0 54.0 54.0 55.0 20:11:59 INFO - PID 8726 | 20:11:59 INFO - PID 8726 | [#10] stanford-crypto-aes Cycles:10 Average:85.40 Median:87.50 stddev:7.50 (8.6%) stddev-sans-first:7.28 20:11:59 INFO - PID 8726 | Values: 94.0 79.0 87.0 88.0 96.0 79.0 78.0 79.0 95.0 79.0 20:11:59 INFO - PID 8726 | 20:11:59 INFO - PID 8726 | [#11] stanford-crypto-ccm Cycles:10 Average:134.90 Median:132.50 stddev:13.26 (10.0%) stddev-sans-first:14.02 20:11:59 INFO - PID 8726 | Values: 132.0 126.0 126.0 128.0 140.0 129.0 138.0 133.0 127.0 170.0 20:11:59 INFO - PID 8726 | 20:11:59 INFO - PID 8726 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:178.40 Median:177.50 stddev:4.93 (2.8%) stddev-sans-first:4.61 20:11:59 INFO - PID 8726 | Values: 185.0 178.0 177.0 183.0 173.0 175.0 177.0 187.0 176.0 173.0 20:11:59 INFO - PID 8726 | 20:11:59 INFO - PID 8726 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.00 Median:69.50 stddev:1.76 (2.5%) stddev-sans-first:1.50 20:11:59 INFO - PID 8726 | Values: 72.0 68.0 70.0 67.0 70.0 69.0 69.0 67.0 67.0 71.0 20:11:59 INFO - PID 8726 | -------- Summary: end -------- 20:11:59 INFO - PID 8726 | 20:12:00 INFO - PID 8726 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 20:12:00 INFO - TEST-INFO | 8726: exit 0 20:12:00 INFO - TEST-OK | kraken | took 62241ms 20:12:00 INFO - SUITE-END | took 1176s 20:12:00 INFO - Completed test suite (00:19:36) 20:12:00 INFO - javascript benchmark 20:12:00 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8400.29209286788, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3084.7069528394795, 3123.187971127506, 3142.7171554560086, 3155.9211019724503, 3186.808791472512, 6053.152558641794, 6063.181470501481, 6089.482393996515, 6137.601055931367, 6146.846328841775, 6222.937770622292, 6261.092141639471, 6320.083587879754, 6321.6523091229965, 6326.240851097863, 5678.687672178018, 5705.2012718219485, 5726.62776919501, 5760.337561180455, 5819.010768169422, 5530.391656917735, 5599.608027438081, 5645.350784659755, 5725.198472213893, 5738.3687794342795, 5577.163425486189, 5686.175504551838, 5690.089585666295, 5702.6293290935955, 5703.287089113882, 5619.719014049281, 5656.604037717361, 5720.8855822883725, 5723.51350135239, 5738.196652468658, 5504.4495550445035, 5564.387917329091, 5598.216249725042, 5665.206871038058, 5691.573132015115, 6026.397360263983, 6036.456718895277, 6046.909296360558, 6092.969535152296, 6108.816735497942, 6567.376099270562, 6569.113169722074, 6633.601983880934, 6639.435647969928, 6648.335166483362, 6644.335566443317, 6665.400113989765, 6677.465802735818, 6716.664166791641, 6727.091842601235, 6009.248843894513, 6098.573099883054, 6106.572539922163, 6143.017117261216, 6267.561270711052, 6689.1972963244725, 6694.59832410057, 6707.49693772969, 6717.992301154768, 6718.025886246564, 6294.402031806971, 6365.649889256043, 6367.777127800505, 6372.203474565679, 6400.0, 6468.8059358219325, 6473.190851143607, 6484.837879053061, 6485.156929599122, 6503.512236582275, 6387.680615969183, 6398.29618741938, 6419.325970773095, 6424.453921416732, 6467.547271691031, 6482.092507049017, 6499.707513161919, 6508.121403610547, 6520.250171230369, 6598.637074960923, 5356.384015838228, 5356.651817631841, 5407.891842163135, 5422.349318081777, 5432.592555558349, 4594.0, 4637.698549594265, 4647.070585882837, 4659.976700116477, 4661.230896901973, 5627.606067575312, 5709.600327977002, 5716.57125715573, 5717.456841600041, 5724.79963201286, 6587.769428069994, 6682.431993280528, 6686.665666716742, 6688.230853451818, 6693.732250710014, 5710.2862142232225, 5765.88468230633, 5796.768129274782, 5808.0, 5822.563307751935, 5818.127280907897, 5821.679807610537, 5904.9704751475965, 5906.645601263938, 5931.851703707442, 6258.812235632939, 6365.777197798055, 6371.722051968083, 6413.583117097373, 6510.0, 6623.238327592196, 6673.933260667525, 6680.5991640501725, 6683.6324002180345, 6693.866122677422, 6344.746210151542, 6408.807735767934, 6442.935570644234, 6490.156279683611, 6521.054447105048, 6480.837979050561, 6529.249136349381, 6533.379328963741, 6606.273309935807, 6612.437942774918, 6492.448141907802, 6572.474202063728, 6650.73397064112, 6749.797506074826, 6770.4922130839395, 6367.61794292344, 6461.870762584816, 6472.967635161794, 6490.643014634241, 6497.935020649922, 6375.489960803217, 6388.968055159695, 6482.902756458751, 6497.577657452251, 6513.088167656437, 6297.2128483939505, 6308.873822523432, 6394.680265986775, 6399.232092148972, 6459.224893012869, 6249.375062493714, 6411.0, 6421.068945003042, 6493.253275873335, 6543.1821022372205, 6285.1515045470105, 6289.528285378707, 6291.150694656163, 6291.811245662638, 6303.0], "value": 6027.671128820721, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [820.6594263380694, 857.7598272483705, 880.3353468131563, 891.1845661219984, 1155.9826602600958, 32226.0, 32770.34459310815, 32828.17929551762, 43272.35091473623, 44226.0, 43798.34302485465, 44257.557424425744, 44407.0, 44496.33255501162, 44610.33084503735, 7450.739224127156, 7763.0, 7890.605469726519, 8035.477693949903, 8068.677252909906, 7885.250901164381, 7978.2420670036545, 8002.119766825645, 8008.919910800905, 8013.959930200341, 7941.28528432441, 7989.121196668362, 7998.880016799752, 8000.759977200693, 8020.959895200516, 7949.721759738411, 7998.800029999267, 8002.079760827463, 8002.119766825645, 8005.4796438231915, 7870.724524641667, 7907.327877130451, 7932.405069619744, 7934.523928564305, 7935.920640793576, 40564.39153412701, 41070.0, 41086.794566027274, 41255.174896502205, 41373.37939930904, 3590.407582748843, 3617.0595645132194, 3631.455281707739, 3640.9453858192146, 3644.0, 32287.192820179447, 32344.35311293761, 32449.0, 32494.350112997843, 32594.0, 4848.806047758086, 4873.439554451213, 4985.202367621199, 5097.541221290102, 5167.689938603658, 184452.0, 185895.0, 186225.0688746561, 186490.0, 186565.0, 49412.0117597646, 49717.0, 49926.25110623344, 50022.749886250334, 50277.24584131241, 53680.73159634177, 53843.46156538463, 53944.460555394726, 53958.190627140626, 53963.460365396626, 16252.837471625133, 16564.0, 16577.0, 16799.496015119566, 16924.153792310583, 11925.0, 12087.576934807239, 12088.818667719992, 13491.920646348268, 13686.52097176614, 14966.326515306837, 14996.625084372978, 15014.024088434217, 15204.239788010555, 15319.387224511118, 6066.545009124334, 6078.665673388006, 6089.269287685506, 6098.207233059763, 6120.357362476965, 985.393982700634, 995.9701208963743, 1008.1380419741163, 1016.2732999547602, 1033.478093562746, 22438.887805561193, 22846.885765571067, 23531.17640882595, 28475.857620712177, 29639.407211855643, 1030.5362586835954, 1033.5762337441763, 1083.1443159903745, 1088.3959402531514, 1091.497910960967, 11768.58809941648, 12318.670625514716, 12410.317432541116, 12451.0, 15907.920460397623, 247049.0, 250228.0, 250554.0, 250658.0, 251003.0, 59569.404305956385, 60027.19918402455, 60141.0, 60164.0, 60264.397356026755, 1447.1751101872042, 1503.2934520775218, 1523.535321726884, 1525.5499627609881, 1528.4039224702376, 27208.591871121553, 27379.178624641292, 27449.588256175775, 27865.16404507787, 27944.720552795025, 38898.0, 39499.0, 39506.802465987486, 39571.60428395679, 39642.2071558573, 217639.0, 218751.0, 219207.0, 219709.0, 220714.0, 34888.12779680528, 38648.42027369648, 39156.80421597874, 39304.0, 39433.211335773696, 47296.0, 48751.756241218565, 48982.0, 49026.26460603022, 49977.0, 34280.657193427745, 34801.30397392088, 35058.82470587733, 35335.293294134484, 35565.82217088898, 33287.33425331528, 33357.49963750594, 34670.479942800375, 34888.825555872056, 35110.0, 38394.42408363821, 38584.80707596444, 38773.0, 38832.41751373675, 38907.80546097364, 32721.672783272814, 33407.0, 33707.49438758371, 33740.83129584337, 34018.0, 24032.158874439312, 24080.51838963246, 24509.338437779625, 24943.251702448957, 24994.750052499243], "value": 17990.190764029136, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [559.4908633143834, 561.441365840988, 567.4949295127337, 588.6144575303176, 603.1706403694919, 22411.775882241174, 22613.773862261372, 23458.530829383424, 23510.29469115927, 23540.17609383672, 25160.37099072524, 25792.0, 26941.730582694217, 27088.864555677243, 27127.1861844145, 6533.705983230754, 6711.664416779166, 6719.8656026879435, 6721.563098398613, 6724.95763156709, 5960.552958528127, 6604.141461609984, 6680.632565208936, 6685.231198412196, 6693.364130407604, 6328.715207815636, 6467.353264673542, 6485.189351331083, 6491.837704057389, 6502.804915852532, 6448.516361272923, 6472.676366181696, 6475.384838440341, 6491.772787952399, 6509.4466970307585, 6015.518758499354, 6036.486898613623, 6042.9395706042815, 6045.3047899491685, 6053.303870054956, 27345.726542734516, 28277.71722282792, 28782.136535903956, 28901.277468063257, 29174.0, 1850.481865077767, 1927.3736035788286, 1928.845692344609, 1930.5270208798934, 1937.5446770009037, 18460.53848653781, 19202.231910723553, 19204.327848525234, 19210.423687289403, 19223.134958926883, 2325.813934885205, 2337.18198630478, 2364.408897775556, 2380.8571485710913, 2426.3085020768995, 127036.36481817624, 129294.35352823269, 129627.99999999905, 129682.3515882424, 130071.0, 14185.290735463186, 14779.778303325458, 14865.182414967281, 15083.245837708071, 15656.686866262839, 22308.0, 23413.180538681063, 23892.52214955726, 23957.760422395902, 23959.760402396103, 10171.593136274614, 10230.488475576192, 10324.638637647797, 10339.4313312767, 10356.119729823049, 9382.0, 9389.765255868659, 9418.576164072632, 9466.763330916645, 9649.179819715262, 9220.8616870747, 9339.766505837408, 9404.012578679278, 9452.669156579625, 9745.463999479955, 2694.1648089092446, 2758.682751483605, 2765.9308517287227, 2854.1152242804797, 2889.6099026631555, 963.7638778499313, 978.9608415663436, 979.3242662562809, 995.2684776689127, 1023.6570748799087, 19253.133608987628, 19471.805281947283, 19669.704954425695, 19717.408477745692, 20306.79693203049, 1025.487256371814, 1063.771289172816, 1068.5832525315134, 1071.1109778883508, 1080.9459527023616, 10907.83638245427, 11071.501782419811, 11078.889211107948, 11114.166437517219, 11359.034482068952, 454119.0, 466126.0, 468197.0, 475503.0, 481990.0, 107887.46056269668, 109181.0, 109810.0, 110156.449217755, 110205.0, 1212.1878341511208, 1230.0958795285458, 1242.1118899986373, 1256.9057320700983, 1259.6976725585976, 16683.74974375361, 20928.37214883556, 21925.0, 22287.777122229218, 22292.331230063122, 52510.0, 52913.0, 53893.46106539041, 56157.0, 57403.712981436496, 67945.66027169832, 68535.65732171308, 69116.0, 69444.30555694379, 69887.65056174686, 14870.925645371704, 15128.54614361527, 15200.46798362052, 15205.239738012833, 15313.234338282818, 23680.0, 23708.288751337488, 23758.287251382488, 24044.15845445401, 24190.395240119138, 18485.353012644493, 18681.0, 18845.0, 18865.71701424452, 18992.715109273096, 16450.424235151713, 17383.0, 17687.64624707473, 18062.096895155453, 18356.816431835512, 18571.535711607317, 19845.702314465583, 19856.0, 20057.498562536053, 20109.39671809848, 14313.998020138906, 14358.425662973365, 14386.928065359607, 14658.267086645412, 14674.33965471535, 18538.0, 18827.717584235972, 19018.23927042903, 19173.616527669088, 19187.712184317526], "value": 12049.177676830264, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1352.09409695504, 1409.9718005639888, 1436.073732442575, 1436.4254298280687, 1438.791375250588, 12991.285479298647, 13377.197368157917, 13658.453661853526, 13685.589432317021, 13697.589072327833, 14171.645708857284, 14250.928745356285, 14440.277986100678, 14457.0602910811, 14478.42086316546, 2615.62073499343, 2680.1825443239804, 2681.932951676214, 2683.7047924728363, 2684.6912605050475, 2485.0680994627014, 2621.9213423597225, 2669.893204271827, 2670.9465810683773, 2671.6927553331325, 2581.6256642786784, 2622.9344266393396, 2623.724508926564, 2625.0681008242086, 2625.2518032360686, 2545.1982625472915, 2547.8025328095764, 2569.79441644668, 2573.356660834782, 2576.8067394945456, 2471.283327834926, 2477.306354220803, 2514.1828905605753, 2518.9118380856767, 2530.4812513434704, 13027.478900843955, 13302.667433314244, 13346.26595537245, 13348.933255333759, 13350.666233344244, 7309.597972111532, 7547.28300811422, 7590.848183036308, 7607.429442791813, 7609.391248700091, 4894.3147959285725, 4948.233023881304, 5018.5232402921665, 5086.287919691246, 5099.515546023122, 1783.5362805670488, 1799.8020217776166, 1825.4067428085925, 1857.4241984984699, 1858.6468570971472, 20768.48078798042, 20801.5839683207, 20870.89564552183, 20908.0, 21018.789812101837, 6132.63204207749, 6173.722182501798, 6298.149749783812, 6391.07329437229, 6625.536212465177, 15350.539483815503, 15358.462453814287, 15567.29947152381, 16066.75899861503, 16145.112018838841, 7417.221191774786, 7618.200088990576, 7618.809529761689, 7633.084029916446, 7668.156502784689, 6762.594244345355, 6964.582125072512, 7029.156501219886, 7034.366906978396, 7046.1192350956135, 4785.234362501983, 4928.852134435972, 4962.627802914723, 4975.701457912537, 5140.665856719376, 1386.8335799703898, 1398.440623750508, 1411.5412490940485, 1411.9223442710545, 1415.5753274017754, 851.3997631669658, 856.8586183279814, 865.6580650643086, 886.7472770260445, 912.3431129586687, 7064.470164737665, 7091.078159839188, 7150.141982962078, 7183.92816071843, 7214.242504537053, 657.2540166910495, 671.3990978074596, 707.1302298173173, 708.3872450330427, 711.8256027273351, 4606.0, 4716.528347165256, 4813.807447702053, 4889.462159162489, 5112.3865136183895, 17749.55626109332, 18076.276948922157, 18385.448436546925, 18395.264189432273, 18414.539636509195, 18607.16267767954, 18883.244670213313, 18897.90551047236, 18916.0, 18932.337368192046, 9839.262055345878, 10318.071373576415, 10407.323523970766, 10424.426656533811, 10475.47622618866, 7458.925410745823, 7795.493292935941, 8096.352291816758, 8155.510669359857, 8362.331013518782, 15439.922800386375, 16499.17504124813, 16624.0, 16852.747208792123, 16854.0, 16500.257488413292, 16652.833471665614, 16678.16609169561, 16844.747328790323, 16941.91529042347, 11136.220464567403, 11229.943850280697, 11349.48927298257, 11371.43142842871, 11384.089272857986, 12692.873071269169, 12938.353082346033, 12940.935295323463, 12958.740825183255, 12963.0, 9881.0, 9985.800283994135, 10061.14480269156, 10326.896731032593, 10452.954704529486, 10150.54322555472, 10249.38503689781, 10459.424731639529, 10519.631812886511, 10556.102731267929, 9411.811763764823, 9567.665131720356, 9567.712968610953, 9571.664991725256, 9577.760555985877, 6533.640649764308, 6875.690593923186, 7009.12385951756, 7079.362857342658, 7092.5389849659605, 6312.179416675803, 6535.607863528204, 6590.50571207171, 6866.6566671667215, 6918.5502942308585], "value": 6145.859208525618, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [494.24133954380034, 496.9985479259293, 525.6163001009264, 534.5286676947337, 538.1524099543218, 6068.514518838493, 6146.354632763557, 6233.719482623282, 6245.781397651083, 6317.0, 6021.367756385582, 6067.87864242716, 6077.817665470032, 6101.481374083197, 6138.140660307549, 4941.481144479822, 4963.875903102433, 4970.900581988358, 4986.4514903360605, 5010.198368261079, 4878.512148785111, 4920.188168952119, 4957.603391728671, 4962.865967633916, 4968.3292755477905, 4957.5786058185095, 4965.3296804931415, 4965.577925876305, 4983.626228032894, 4988.625853061017, 4928.137575924235, 4951.702897826124, 4982.427020892607, 5007.098722229997, 5021.096202683516, 4451.910961780746, 4456.442944631921, 4488.304312831517, 4492.460904691458, 4515.277555591089, 6040.879182416327, 6087.908681369783, 6094.481969032638, 6132.049532322497, 6143.017117261262, 5573.916391254134, 5598.1602759585985, 5704.629199102086, 5714.257146570919, 5733.569982251348, 6465.579737317059, 6497.870042599122, 6500.772472963424, 6537.378948999837, 6555.573887697332, 4890.24201248807, 4900.362952816146, 4924.0, 4947.233178857283, 4948.455669876346, 6700.83247918806, 6827.337338438063, 6839.760608378732, 6855.104610035366, 6883.070785443951, 4960.50394960501, 4992.750362481861, 4998.150314446553, 4998.800047998039, 5014.674046186986, 5041.59667226621, 5066.138756411419, 5116.897662046738, 5119.8720031998755, 5130.56344223618, 5505.366882808528, 5573.136163894603, 5617.662940223599, 5645.633033852869, 5651.321841379061, 6223.813285601439, 6455.868244323637, 6458.903116453257, 6496.473328767735, 6516.869662606816, 1687.4094067076426, 1738.8089158926175, 1746.1531157388656, 1753.7194048952106, 1754.6402987387555, 1189.6668932698858, 1197.3354788092518, 1205.3370646144585, 1206.8913797758244, 1215.3133479584008, 5647.272799952094, 5688.488036076773, 5730.627509211888, 5747.0, 5786.884262314814, 6632.635205063768, 6682.599044057372, 6684.364985326386, 6703.932960670429, 6710.899336509956, 5757.596968212269, 5773.566982476247, 5791.8552036199435, 5818.6217895836635, 5830.47525722687, 3498.4052711039185, 3562.127278816655, 3593.5867375252183, 3596.5324507813816, 3607.603163651996, 6423.839404014843, 6480.060391243243, 6480.416762491398, 6487.7080531376205, 6511.609303441809, 6729.562578432484, 6736.012876201532, 6770.458363330922, 6786.287439818748, 6817.284185160586, 6321.0, 6347.492200623939, 6407.423331900151, 6442.645654488954, 6495.837604059747, 6554.410103090745, 6583.835404114935, 6674.332566743286, 6689.598624082376, 6759.459243260429, 6511.0, 6552.115464412243, 6570.901436478361, 6599.241087275025, 6683.365080317362, 6414.74912392079, 6424.807255782334, 6456.995828233157, 6501.349865013461, 6548.116004339353, 5033.899322013613, 5058.241263810311, 5060.873478163076, 5062.974810075999, 5079.568236699774, 6359.713812878339, 6622.1722284714415, 6681.198256209286, 6783.559068660521, 6799.422049125879, 6367.713452894538, 6410.5192110592825, 6411.7300176909175, 6467.644279564481, 6536.7712130075215, 6456.2575303838785, 6460.45086167681, 6499.7400103995315, 6530.869382612416, 6575.704093315717, 6309.652969086745, 6384.7446102157255, 6414.7434102637235, 6442.425877626937, 6445.323241059621, 6502.804915852532, 6517.283098859217, 6570.638614876228, 6592.736595385315, 6629.834254143685, 6292.622442653455, 6320.304766475776, 6375.075614035846, 6380.9361906380345, 6386.742761191733], "value": 5031.253311791441, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [915.1306259053896, 921.5898924978384, 936.765808547863, 940.0176815228086, 953.5613617735842, 14747.705045899076, 15137.621559461006, 15155.318010689518, 21042.684359734616, 22023.0, 19307.613847723038, 19504.317348892793, 20456.8977155114, 20541.486462838435, 20542.281020164297, 987.8863930647996, 1011.7318910488726, 1011.9898801012006, 1012.1396812709212, 1014.2697257974284, 973.1193270090579, 1054.8206804843196, 1059.6873922192972, 1061.0768631290787, 1061.1828891753385, 1110.7112150840799, 1117.6311817100338, 1118.8601424821898, 1119.5857532712907, 1119.8208286674135, 1107.7064577886867, 1109.4508218431847, 1110.8666959964817, 1112.6272698645964, 1112.9109671226283, 811.809224832164, 816.930560902324, 817.0195765081866, 817.284875733733, 818.7953011747063, 18426.815731842646, 18769.53076173093, 18998.05009749507, 19032.61934761311, 19142.808571914244, 20008.599828003506, 20151.294704685264, 20584.691229631568, 20592.073356698984, 20678.0, 15991.600209994727, 16238.350465981464, 16452.259648315736, 16503.0, 16587.170641467997, 3496.7377446691344, 3535.7701749386206, 3547.467879818022, 3552.662497062775, 3554.36021516127, 119840.0, 121658.0, 124310.0, 126349.0, 126833.0, 15456.768148477782, 15880.0, 16078.919605402132, 16093.839061609468, 16113.919430402773, 23635.645465318034, 24034.639480407808, 30156.94450694259, 30178.24554386158, 30433.847830761148, 8497.490150590984, 8723.08407617191, 8740.125987401336, 8768.210861022411, 8771.298296136294, 4013.7591744495426, 4116.197341518375, 4142.337226043818, 4161.354989976498, 4180.686448516312, 4912.0, 5132.8460146195675, 5139.486051394905, 5158.6131040171385, 5165.483451654804, 1038.0916697889347, 1062.8193207154802, 1081.4430568257353, 1083.4853444613902, 1087.260662749338, 653.8724948634971, 672.4015626092781, 673.2657787506016, 700.9264027277164, 704.4505285877024, 11234.662960111209, 11531.654050378502, 12118.81821772674, 12774.489020439078, 13188.604341869759, 596.0790578556141, 600.7146605362418, 610.2798697536861, 649.3247023096021, 656.1142457682091, 5132.435432102466, 5172.301739265226, 5251.632385732962, 5337.6797392156595, 5374.167004114291, 95852.0, 97045.51477242568, 104791.0, 106574.46712766541, 107518.0, 87829.56085219533, 88291.55854220688, 89187.0, 94284.0, 94503.52748236214, 75516.0, 78171.0, 81388.77916831253, 81519.0, 83450.0, 10798.13614910821, 10837.45812709377, 10879.564817407216, 11092.500837462172, 11138.498767555642, 34295.31409371749, 35398.9871675113, 36003.81998089993, 36055.27889442249, 37508.81245593754, 47398.28902566395, 48185.0, 48327.516724832305, 48876.0, 49358.50641493539, 15734.685306294039, 16428.42500512476, 16432.75350869714, 16548.007119572863, 16613.91693041527, 16405.67188656244, 17015.14924253807, 17155.485335439957, 17161.399351022654, 17316.65366692634, 14264.429422823387, 14363.712725745218, 14417.711645767236, 14526.564203073502, 14531.564053078424, 15367.0, 15556.844431555539, 15617.14105724196, 15626.45307414235, 15853.048817071012, 15362.615934601277, 15776.0, 17566.73649895278, 18371.448856534324, 18396.080195990413, 12951.5466958656, 13385.598432047054, 13746.381412836246, 13849.0, 14113.858861411254, 13587.796183057064, 13627.182369057888, 13728.0, 14246.928765356108, 14378.352974116398], "value": 8696.326895150949, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1540.9, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [100.0, 109.0, 103.0, 107.0, 108.0, 108.0, 109.0, 110.0, 109.0, 114.0], "value": 107.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 117.0, 145.0, 168.0, 125.0, 150.0, 141.0, 118.0, 172.0, 119.0], "value": 140.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 162.0, 162.0, 162.0, 162.0, 163.0, 169.0, 164.0, 167.0, 164.0], "value": 164.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 79.0, 80.0, 170.0, 77.0, 76.0, 77.0, 76.0, 171.0, 75.0], "value": 95.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 78.0, 136.0, 79.0, 82.0, 80.0, 124.0, 79.0, 79.0, 132.0], "value": 95.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 115.0, 114.0, 115.0, 113.0, 116.0, 117.0, 118.0, 113.0, 117.0], "value": 115.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 153.0, 154.0, 152.0, 150.0, 150.0, 151.0, 152.0, 151.0, 150.0], "value": 151.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 94.0, 95.0, 94.0, 94.0, 99.0, 94.0, 96.0, 94.0], "value": 94.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 54.0, 54.0, 54.0, 61.0, 54.0, 53.0, 53.0, 54.0, 53.0], "value": 54.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 54.0, 54.0, 53.0, 55.0, 54.0, 55.0, 54.0, 54.0, 55.0], "value": 54.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 79.0, 87.0, 88.0, 96.0, 79.0, 78.0, 79.0, 95.0, 79.0], "value": 85.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [132.0, 126.0, 126.0, 128.0, 140.0, 129.0, 138.0, 133.0, 127.0, 170.0], "value": 134.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [185.0, 178.0, 177.0, 183.0, 173.0, 175.0, 177.0, 187.0, 176.0, 173.0], "value": 178.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 68.0, 70.0, 67.0, 70.0, 69.0, 69.0, 67.0, 67.0, 71.0], "value": 69.0, "unit": "score"}]}]} 20:12:00 INFO - Return code: 0 20:12:01 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 20:12:01 INFO - # TBPL SUCCESS # 20:12:01 INFO - Running post-action listener: _package_coverage_data 20:12:01 INFO - Running post-action listener: _resource_record_post_action 20:12:01 INFO - [mozharness: 2017-07-26 03:12:01.021830Z] Finished run-tests step (success) 20:12:01 INFO - Running post-run listener: _resource_record_post_run 20:12:01 INFO - Total resource usage - Wall time: 1195s; CPU: 13.0%; Read bytes: 4096; Write bytes: 436256768; Read time: 8; Write time: 251044 20:12:01 INFO - TinderboxPrint: CPU usage
13.1% 20:12:01 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 8 20:12:01 INFO - TinderboxPrint: I/O write bytes / time
436,256,768 / 251,044 20:12:01 INFO - TinderboxPrint: CPU idle
8,274.9 (86.8%) 20:12:01 INFO - TinderboxPrint: CPU user
1,203.2 (12.6%) 20:12:01 INFO - TinderboxPrint: Swap in / out
0 / 0 20:12:01 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 107536384; Read time: 0; Write time: 78948 20:12:01 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 20:12:01 INFO - run-tests - Wall time: 1177s; CPU: 13.0%; Read bytes: 0; Write bytes: 328720384; Read time: 0; Write time: 172096 20:12:01 INFO - Running post-run listener: _upload_blobber_files 20:12:01 INFO - Blob upload gear active. 20:12:01 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 20:12:01 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 20:12:01 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'] 20:12:01 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 20:12:02 INFO - (blobuploader) - INFO - Open directory for files ... 20:12:02 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 20:12:02 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:12:02 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:12:05 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 20:12:05 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:12:05 INFO - (blobuploader) - INFO - Done attempting. 20:12:05 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 20:12:05 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:12:05 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:12:06 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 20:12:06 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:12:06 INFO - (blobuploader) - INFO - Done attempting. 20:12:06 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 20:12:06 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:12:06 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:12:07 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 20:12:07 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:12:07 INFO - (blobuploader) - INFO - Done attempting. 20:12:07 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 20:12:07 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:12:07 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:12:08 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 20:12:08 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:12:08 INFO - (blobuploader) - INFO - Done attempting. 20:12:08 INFO - (blobuploader) - INFO - Iteration through files over. 20:12:08 INFO - Return code: 0 20:12:08 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 20:12:08 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 20:12:08 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/faa7406952f1f8fa54d19cf2fb27c2019db52891ea2a9df82c958876a1f12e37cc340136c852c95892c2593a0c59bb578bb81a6871394eb0427e16a15dfd89ed", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ded09327bc34d7f9fc4a88ba6ad2a2bee530790d32251d39ec00237e8827160bccc09003ddc3950d2ccf11e0da9d3e7899e5221c6c4611202e82a3eddaf91812", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/cc32802947b852731d90c09196f1b6b5d4fa663898d773f42a46995a2b767d81c58a618f1dfd21efbdbe22e1aaea1b67f16f52d7a6f0d4a5a599face5e519d2e", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1105638bdb134112056f9c6bcf63d79e8b3fddd54265235ecb75f08d43c76761cdfb380ace49ea93b1c577816357dc9ce8efe6e323f251d322de8cde8b1d2eca"} 20:12:08 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 20:12:08 INFO - Writing to file /builds/slave/test/properties/blobber_files 20:12:08 INFO - Contents: 20:12:08 INFO - blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/faa7406952f1f8fa54d19cf2fb27c2019db52891ea2a9df82c958876a1f12e37cc340136c852c95892c2593a0c59bb578bb81a6871394eb0427e16a15dfd89ed", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ded09327bc34d7f9fc4a88ba6ad2a2bee530790d32251d39ec00237e8827160bccc09003ddc3950d2ccf11e0da9d3e7899e5221c6c4611202e82a3eddaf91812", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/cc32802947b852731d90c09196f1b6b5d4fa663898d773f42a46995a2b767d81c58a618f1dfd21efbdbe22e1aaea1b67f16f52d7a6f0d4a5a599face5e519d2e", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1105638bdb134112056f9c6bcf63d79e8b3fddd54265235ecb75f08d43c76761cdfb380ace49ea93b1c577816357dc9ce8efe6e323f251d322de8cde8b1d2eca"} 20:12:08 INFO - Running post-run listener: copy_logs_to_upload_dir 20:12:08 INFO - Copying logs to upload dir... 20:12:08 INFO - mkdir: /builds/slave/test/build/upload/logs 20:12:08 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1254.996970 ========= master_lag: 0.06 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 55 secs) (at 2017-07-25 20:12:08.165351) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-07-25 20:12:08.173198) ========= 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=8887e36bb8e381bfd44124ac000001a8-1501037239.544001-1503337172 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/faa7406952f1f8fa54d19cf2fb27c2019db52891ea2a9df82c958876a1f12e37cc340136c852c95892c2593a0c59bb578bb81a6871394eb0427e16a15dfd89ed", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ded09327bc34d7f9fc4a88ba6ad2a2bee530790d32251d39ec00237e8827160bccc09003ddc3950d2ccf11e0da9d3e7899e5221c6c4611202e82a3eddaf91812", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/cc32802947b852731d90c09196f1b6b5d4fa663898d773f42a46995a2b767d81c58a618f1dfd21efbdbe22e1aaea1b67f16f52d7a6f0d4a5a599face5e519d2e", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1105638bdb134112056f9c6bcf63d79e8b3fddd54265235ecb75f08d43c76761cdfb380ace49ea93b1c577816357dc9ce8efe6e323f251d322de8cde8b1d2eca"} build_url:https://queue.taskcluster.net/v1/task/doubB920S6SAYge54loW3Q/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011188 build_url: 'https://queue.taskcluster.net/v1/task/doubB920S6SAYge54loW3Q/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/faa7406952f1f8fa54d19cf2fb27c2019db52891ea2a9df82c958876a1f12e37cc340136c852c95892c2593a0c59bb578bb81a6871394eb0427e16a15dfd89ed", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ded09327bc34d7f9fc4a88ba6ad2a2bee530790d32251d39ec00237e8827160bccc09003ddc3950d2ccf11e0da9d3e7899e5221c6c4611202e82a3eddaf91812", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/cc32802947b852731d90c09196f1b6b5d4fa663898d773f42a46995a2b767d81c58a618f1dfd21efbdbe22e1aaea1b67f16f52d7a6f0d4a5a599face5e519d2e", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1105638bdb134112056f9c6bcf63d79e8b3fddd54265235ecb75f08d43c76761cdfb380ace49ea93b1c577816357dc9ce8efe6e323f251d322de8cde8b1d2eca"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-07-25 20:12:08.200343) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-07-25 20:12:08.200727) ========= 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=8887e36bb8e381bfd44124ac000001a8-1501037239.544001-1503337172 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004462 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-07-25 20:12:08.286835) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-07-25 20:12:08.287261) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-07-25 20:12:08.287619) ========= ========= Total master_lag: 0.22 =========