builder: mozilla-central_ubuntu64_hw_qr_test-dromaeojs-e10s slave: talos-linux64-ix-010 starttime: 1502852753.22 results: success (0) revision: 4e93516e92e58d166ad37b8544c3230024afb587 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-08-15 20:05:53.220368) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-08-15 20:05:53.220815) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-08-15 20:05:53.221093) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-08-15 20:05:53.241987) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-15 20:05:53.242388) ========= 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=eca2ab57546de7b41f256b19000001ef-1502852752.375122-25052663 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-08-15 20:05:53-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 37.6M=0s 2017-08-15 20:05:53 (37.6 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.128577 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-15 20:05:53.386118) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-08-15 20:05:53.389527) ========= 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=eca2ab57546de7b41f256b19000001ef-1502852752.375122-25052663 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020710 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-08-15 20:05:53.440185) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-15 20:05:53.440569) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 4e93516e92e58d166ad37b8544c3230024afb587 --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 4e93516e92e58d166ad37b8544c3230024afb587 --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=eca2ab57546de7b41f256b19000001ef-1502852752.375122-25052663 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-08-15 20:05:53,502 truncating revision to first 12 chars 2017-08-15 20:05:53,502 Setting DEBUG logging. 2017-08-15 20:05:53,502 attempt 1/10 2017-08-15 20:05:53,502 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/4e93516e92e5?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-08-15 20:05:54,036 unpacking tar archive at: mozilla-central-4e93516e92e5/testing/mozharness/ program finished with exit code 0 elapsedTime=0.842452 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-15 20:05:54.305529) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-08-15 20:05:54.305946) ========= script_repo_revision: 4e93516e92e58d166ad37b8544c3230024afb587 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-08-15 20:05:54.306350) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-08-15 20:05:54.306614) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-08-15 20:05:54.320238) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 1 secs) (at 2017-08-15 20:05:54.320632) ========= /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=eca2ab57546de7b41f256b19000001ef-1502852752.375122-25052663 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 20:05:54 INFO - MultiFileLogger online at 20170815 20:05:54 in /builds/slave/test 20:05:54 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 20:05:54 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 20:05:54 INFO - {'append_to_log': False, 20:05:54 INFO - 'base_work_dir': '/builds/slave/test', 20:05:54 INFO - 'blob_upload_branch': 'Firefox', 20:05:54 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 20:05:54 INFO - 'branch': 'Firefox', 20:05:54 INFO - 'buildbot_json_path': 'buildprops.json', 20:05:54 INFO - 'code_coverage': False, 20:05:54 INFO - 'config_files': ('talos/linux_config.py',), 20:05:54 INFO - 'default_actions': ('clobber', 20:05:54 INFO - 'read-buildbot-config', 20:05:54 INFO - 'download-and-extract', 20:05:54 INFO - 'populate-webroot', 20:05:54 INFO - 'create-virtualenv', 20:05:54 INFO - 'install', 20:05:54 INFO - 'setup-mitmproxy', 20:05:54 INFO - 'run-tests'), 20:05:54 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 20:05:54 INFO - 'disable_ccov_upload': False, 20:05:54 INFO - 'download_minidump_stackwalk': True, 20:05:54 INFO - 'download_symbols': 'ondemand', 20:05:54 INFO - 'enable_stylo': False, 20:05:54 INFO - 'enable_webrender': False, 20:05:54 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 20:05:54 INFO - 'tooltool.py': '/tools/tooltool.py', 20:05:54 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 20:05:54 INFO - '/tools/misc-python/virtualenv.py')}, 20:05:54 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 20:05:54 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 20:05:54 INFO - 'gecko_profile': False, 20:05:54 INFO - 'gecko_profile_interval': 0, 20:05:54 INFO - 'installer_path': 'installer.exe', 20:05:54 INFO - 'log_level': 'info', 20:05:54 INFO - 'log_name': 'talos', 20:05:54 INFO - 'log_to_console': True, 20:05:54 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 20:05:54 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 20:05:54 INFO - 'opt_config_files': (), 20:05:54 INFO - 'pip_index': False, 20:05:54 INFO - 'suite': 'dromaeojs-e10s', 20:05:54 INFO - 'system_bits': '32', 20:05:54 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 20:05:54 INFO - 'title': 'talos-linux64-ix-010', 20:05:54 INFO - 'tooltool_cache': '/builds/tooltool_cache', 20:05:54 INFO - 'use_talos_json': True, 20:05:54 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 20:05:54 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 20:05:54 INFO - 'work_dir': 'build'} 20:05:54 INFO - [mozharness: 2017-08-16 03:05:54.486314Z] Running clobber step. 20:05:54 INFO - Running pre-action listener: _resource_record_pre_action 20:05:54 INFO - Running main action method: clobber 20:05:54 INFO - rmtree: /builds/slave/test/build 20:05:54 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 20:05:55 INFO - Running post-action listener: _resource_record_post_action 20:05:55 INFO - [mozharness: 2017-08-16 03:05:55.729931Z] Finished clobber step (success) 20:05:55 INFO - [mozharness: 2017-08-16 03:05:55.730034Z] Running read-buildbot-config step. 20:05:55 INFO - Running pre-action listener: _resource_record_pre_action 20:05:55 INFO - Running main action method: read_buildbot_config 20:05:55 INFO - Using buildbot properties: 20:05:55 INFO - { 20:05:55 INFO - "project": "", 20:05:55 INFO - "product": "firefox", 20:05:55 INFO - "who": "kwierso@gmail.com", 20:05:55 INFO - "installer_path": "public/build/target.tar.bz2", 20:05:55 INFO - "builddir": "mozilla-central_ubuntu64_hw_qr_test-dromaeojs-e10s", 20:05:55 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 20:05:55 INFO - "buildername": "Ubuntu HW 12.04 x64 qr mozilla-central talos dromaeojs-e10s", 20:05:55 INFO - "stage_platform": "linux64-qr", 20:05:55 INFO - "basedir": "/builds/slave/test", 20:05:55 INFO - "buildnumber": 1, 20:05:55 INFO - "platform": "ubuntu64_hw_qr", 20:05:55 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 20:05:55 INFO - "slavebuilddir": "test", 20:05:55 INFO - "taskId": "QFtF4kIESaSuAT28fM1k8A", 20:05:55 INFO - "branch": "mozilla-central", 20:05:55 INFO - "script_repo_revision": "production", 20:05:55 INFO - "revision": "4e93516e92e58d166ad37b8544c3230024afb587", 20:05:55 INFO - "slavename": "talos-linux64-ix-010", 20:05:55 INFO - "repo_path": "mozilla-central" 20:05:55 INFO - } 20:05:55 INFO - Finding installer, test and symbols from parent task. 20:05:55 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/QFtF4kIESaSuAT28fM1k8A'}, attempt #1 20:05:56 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/QFtF4kIESaSuAT28fM1k8A'}, attempt #1 20:05:56 INFO - Task dependencies: CfE8SazFTyCmvfD5YyBUnw 20:05:56 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/CfE8SazFTyCmvfD5YyBUnw'}, attempt #1 20:05:57 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/CfE8SazFTyCmvfD5YyBUnw/artifacts/public/build/target.tar.bz2 20:05:57 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/CfE8SazFTyCmvfD5YyBUnw/artifacts/public/build/target.test_packages.json 20:05:57 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/CfE8SazFTyCmvfD5YyBUnw/artifacts/public/build/target.crashreporter-symbols.zip 20:05:57 INFO - Running post-action listener: _resource_record_post_action 20:05:57 INFO - [mozharness: 2017-08-16 03:05:57.094986Z] Finished read-buildbot-config step (success) 20:05:57 INFO - [mozharness: 2017-08-16 03:05:57.095208Z] Running download-and-extract step. 20:05:57 INFO - Running pre-action listener: _resource_record_pre_action 20:05:57 INFO - Running main action method: download_and_extract 20:05:57 INFO - mkdir: /builds/slave/test/build/tests 20:05:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:05:57 INFO - trying https://queue.taskcluster.net/v1/task/CfE8SazFTyCmvfD5YyBUnw/artifacts/public/build/target.test_packages.json 20:05:57 INFO - Downloading https://queue.taskcluster.net/v1/task/CfE8SazFTyCmvfD5YyBUnw/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 20:05:57 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/CfE8SazFTyCmvfD5YyBUnw/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 20:05:57 INFO - Downloaded 989 bytes. 20:05:57 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 20:05:57 INFO - Using the following test package requirements: 20:05:57 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 20:05:57 INFO - u'common': [u'target.common.tests.zip'], 20:05:57 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 20:05:57 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 20:05:57 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 20:05:57 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 20:05:57 INFO - u'mozbase': [u'target.common.tests.zip'], 20:05:57 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 20:05:57 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 20:05:57 INFO - u'web-platform': [u'target.common.tests.zip', 20:05:57 INFO - u'target.web-platform.tests.tar.gz'], 20:05:57 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 20:05:57 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 20:05:57 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/CfE8SazFTyCmvfD5YyBUnw/artifacts/public/build/target.common.tests.zip 20:05:57 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/CfE8SazFTyCmvfD5YyBUnw/artifacts/public/build/target.common.tests.zip'}, attempt #1 20:05:57 INFO - Fetch https://queue.taskcluster.net/v1/task/CfE8SazFTyCmvfD5YyBUnw/artifacts/public/build/target.common.tests.zip into memory 20:05:58 INFO - Content-Length response header: 54004333 20:05:58 INFO - Bytes received: 54004333 20:06:09 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 20:06:09 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/CfE8SazFTyCmvfD5YyBUnw/artifacts/public/build/target.common.tests.zip 20:06:09 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/CfE8SazFTyCmvfD5YyBUnw/artifacts/public/build/target.common.tests.zip'}, attempt #1 20:06:09 INFO - Fetch https://queue.taskcluster.net/v1/task/CfE8SazFTyCmvfD5YyBUnw/artifacts/public/build/target.common.tests.zip into memory 20:06:10 INFO - Content-Length response header: 54004333 20:06:10 INFO - Bytes received: 54004333 20:06:23 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/CfE8SazFTyCmvfD5YyBUnw/artifacts/public/build/target.talos.tests.zip 20:06:23 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/CfE8SazFTyCmvfD5YyBUnw/artifacts/public/build/target.talos.tests.zip'}, attempt #1 20:06:23 INFO - Fetch https://queue.taskcluster.net/v1/task/CfE8SazFTyCmvfD5YyBUnw/artifacts/public/build/target.talos.tests.zip into memory 20:06:24 INFO - Content-Length response header: 14496050 20:06:24 INFO - Bytes received: 14496050 20:06: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')]} 20:06:24 INFO - trying https://queue.taskcluster.net/v1/task/CfE8SazFTyCmvfD5YyBUnw/artifacts/public/build/target.tar.bz2 20:06:24 INFO - Downloading https://queue.taskcluster.net/v1/task/CfE8SazFTyCmvfD5YyBUnw/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 20:06:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/CfE8SazFTyCmvfD5YyBUnw/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 20:06:25 INFO - Downloaded 61853457 bytes. 20:06:25 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/CfE8SazFTyCmvfD5YyBUnw/artifacts/public/build/target.tar.bz2 20:06:25 INFO - mkdir: /builds/slave/test/properties 20:06:25 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 20:06:25 INFO - Writing to file /builds/slave/test/properties/build_url 20:06:25 INFO - Contents: 20:06:25 INFO - build_url:https://queue.taskcluster.net/v1/task/CfE8SazFTyCmvfD5YyBUnw/artifacts/public/build/target.tar.bz2 20:06:25 INFO - Running post-action listener: _resource_record_post_action 20:06:25 INFO - Running post-action listener: set_extra_try_arguments 20:06:25 INFO - [mozharness: 2017-08-16 03:06:25.855815Z] Finished download-and-extract step (success) 20:06:25 INFO - [mozharness: 2017-08-16 03:06:25.855914Z] Running populate-webroot step. 20:06:25 INFO - Running pre-action listener: _resource_record_pre_action 20:06:25 INFO - Running main action method: populate_webroot 20:06:25 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 20:06:25 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 20:06:25 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 20:06:25 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 20:06:25 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 20:06:25 INFO - 'tests': ['damp', 'tps']}, 20:06:25 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 20:06:25 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 20:06:25 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 20:06:25 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 20:06:25 INFO - 'other-e10s': {'tests': ['a11yr', 20:06:25 INFO - 'ts_paint', 20:06:25 INFO - 'tpaint', 20:06:25 INFO - 'sessionrestore', 20:06:25 INFO - 'sessionrestore_many_windows', 20:06:25 INFO - 'sessionrestore_no_auto_restore', 20:06:25 INFO - 'tabpaint']}, 20:06:25 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 20:06:25 INFO - 'perf-reftest-singletons-e10s': {'tests': ['bloom_basic_singleton']}, 20:06:25 INFO - 'svgr-e10s': {'tests': ['tsvgx', 20:06:25 INFO - 'tsvgr_opacity', 20:06:25 INFO - 'tart', 20:06:25 INFO - 'tscrollx', 20:06:25 INFO - 'tsvg_static']}, 20:06:25 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 20:06:25 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 20:06:25 INFO - 'talos_options': ['--mitmproxy', 20:06:25 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 20:06:25 INFO - '--firstNonBlankPaint'], 20:06:25 INFO - 'tests': ['tp6_google', 20:06:25 INFO - 'tp6_youtube', 20:06:25 INFO - 'tp6_amazon', 20:06:25 INFO - 'tp6_facebook']}, 20:06:25 INFO - 'tp6-stylo-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 20:06:25 INFO - 'talos_options': ['--stylo', 20:06:25 INFO - '--mitmproxy', 20:06:25 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 20:06:25 INFO - '--firstNonBlankPaint'], 20:06:25 INFO - 'tests': ['tp6_google', 20:06:25 INFO - 'tp6_youtube', 20:06:25 INFO - 'tp6_amazon', 20:06:25 INFO - 'tp6_facebook']}, 20:06:25 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 20:06:25 INFO - 'talos_options': ['--stylo', 20:06:25 INFO - '--stylo-threads=1', 20:06:25 INFO - '--mitmproxy', 20:06:25 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 20:06:25 INFO - '--firstNonBlankPaint'], 20:06:25 INFO - 'tests': ['tp6_google', 20:06:25 INFO - 'tp6_youtube', 20:06:25 INFO - 'tp6_amazon', 20:06:25 INFO - 'tp6_facebook']}, 20:06:25 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 20:06:25 INFO - 'talos_options': ['--xperf_path', 20:06:25 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 20:06:25 INFO - 'tests': ['tp5n']}}} 20:06:25 INFO - Running post-action listener: _resource_record_post_action 20:06:25 INFO - [mozharness: 2017-08-16 03:06:25.864364Z] Finished populate-webroot step (success) 20:06:25 INFO - [mozharness: 2017-08-16 03:06:25.864455Z] Running create-virtualenv step. 20:06:25 INFO - Running pre-action listener: _resource_record_pre_action 20:06:25 INFO - Running main action method: create_virtualenv 20:06:25 INFO - Creating virtualenv /builds/slave/test/build/venv 20:06:25 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 20:06:25 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 20:06:25 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 20:06:25 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 20:06:25 INFO - Using real prefix '/usr' 20:06:25 INFO - New python executable in /builds/slave/test/build/venv/bin/python 20:06:26 INFO - Installing distribute.............................................................................................................................................................................................done. 20:06:28 INFO - Installing pip.................done. 20:06:28 INFO - Return code: 0 20:06:28 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 20:06:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 20:06:28 INFO - Reading from file tmpfile_stdout 20:06:28 INFO - Output received: 20:06:28 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) 20:06:28 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 20:06:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:06:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:06:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:06:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:06:28 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 0x20651f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2169a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x230cef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x230a0b0>, '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 0x230afb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x230b440>, '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': 'eca2ab57546de7b41f256b19000001ef-1502852752.375122-25052663', '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 20:06:28 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 20:06:28 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 20:06:28 INFO - Using env: {'DISPLAY': ':0', 20:06:28 INFO - 'HOME': '/home/cltbld', 20:06:28 INFO - 'LANG': 'en_US.UTF-8', 20:06:28 INFO - 'LANGUAGE': 'en_US:en', 20:06:28 INFO - 'LOGNAME': 'cltbld', 20:06:28 INFO - 'MAIL': '/var/mail/cltbld', 20:06:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:06:28 INFO - 'MOZ_NO_REMOTE': '1', 20:06:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:06:28 INFO - 'NO_EM_RESTART': '1', 20:06:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:06:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:06:28 INFO - 'PWD': '/builds/slave/test', 20:06:28 INFO - 'SHELL': '/bin/bash', 20:06:28 INFO - 'SHLVL': '1', 20:06:28 INFO - 'TERM': 'linux', 20:06:28 INFO - 'TMOUT': '86400', 20:06:28 INFO - 'USER': 'cltbld', 20:06:28 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1502852752.375122-25052663', 20:06:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:06:28 INFO - '_': '/tools/buildbot/bin/python'} 20:06:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:06:28 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 20:06:28 INFO - Cleaning up... 20:06:28 INFO - Return code: 0 20:06:28 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 20:06:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:06:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:06:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:06:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:06:28 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 0x20651f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2169a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x230cef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x230a0b0>, '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 0x230afb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x230b440>, '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': 'eca2ab57546de7b41f256b19000001ef-1502852752.375122-25052663', '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 20:06:28 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 20:06:28 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 20:06:28 INFO - Using env: {'DISPLAY': ':0', 20:06:28 INFO - 'HOME': '/home/cltbld', 20:06:28 INFO - 'LANG': 'en_US.UTF-8', 20:06:28 INFO - 'LANGUAGE': 'en_US:en', 20:06:28 INFO - 'LOGNAME': 'cltbld', 20:06:28 INFO - 'MAIL': '/var/mail/cltbld', 20:06:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:06:28 INFO - 'MOZ_NO_REMOTE': '1', 20:06:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:06:28 INFO - 'NO_EM_RESTART': '1', 20:06:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:06:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:06:28 INFO - 'PWD': '/builds/slave/test', 20:06:28 INFO - 'SHELL': '/bin/bash', 20:06:28 INFO - 'SHLVL': '1', 20:06:28 INFO - 'TERM': 'linux', 20:06:28 INFO - 'TMOUT': '86400', 20:06:28 INFO - 'USER': 'cltbld', 20:06:28 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1502852752.375122-25052663', 20:06:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:06:28 INFO - '_': '/tools/buildbot/bin/python'} 20:06:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:06:29 INFO - Downloading/unpacking psutil>=3.1.1 20:06:29 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 20:06:29 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 20:06:29 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 20:06:29 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 20:06:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 20:06:30 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 20:06:30 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 20:06:30 INFO - Installing collected packages: psutil 20:06:30 INFO - Running setup.py install for psutil 20:06:30 INFO - building 'psutil._psutil_linux' extension 20:06:30 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 20:06:30 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 20:06:30 INFO - building 'psutil._psutil_posix' extension 20:06:30 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 20:06:30 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 20:06:30 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 20:06:30 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 20:06:30 INFO - Successfully installed psutil 20:06:30 INFO - Cleaning up... 20:06:30 INFO - Return code: 0 20:06:30 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 20:06:30 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')]} 20:06:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:06:30 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')]} 20:06:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:06:30 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 0x20651f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2169a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x230cef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x230a0b0>, '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 0x230afb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x230b440>, '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': 'eca2ab57546de7b41f256b19000001ef-1502852752.375122-25052663', '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 20:06:30 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 20:06:30 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 20:06:30 INFO - Using env: {'DISPLAY': ':0', 20:06:30 INFO - 'HOME': '/home/cltbld', 20:06:30 INFO - 'LANG': 'en_US.UTF-8', 20:06:30 INFO - 'LANGUAGE': 'en_US:en', 20:06:30 INFO - 'LOGNAME': 'cltbld', 20:06:30 INFO - 'MAIL': '/var/mail/cltbld', 20:06:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:06:30 INFO - 'MOZ_NO_REMOTE': '1', 20:06:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:06:30 INFO - 'NO_EM_RESTART': '1', 20:06:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:06:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:06:30 INFO - 'PWD': '/builds/slave/test', 20:06:30 INFO - 'SHELL': '/bin/bash', 20:06:30 INFO - 'SHLVL': '1', 20:06:30 INFO - 'TERM': 'linux', 20:06:30 INFO - 'TMOUT': '86400', 20:06:30 INFO - 'USER': 'cltbld', 20:06:30 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1502852752.375122-25052663', 20:06:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:06:30 INFO - '_': '/tools/buildbot/bin/python'} 20:06:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:06:31 INFO - Downloading/unpacking mozsystemmonitor==0.3 20:06:31 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 20:06:31 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 20:06:31 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 20:06:31 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 20:06:32 INFO - Downloading mozsystemmonitor-0.3.tar.gz 20:06:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 20:06:32 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 20:06:32 INFO - Installing collected packages: mozsystemmonitor 20:06:32 INFO - Running setup.py install for mozsystemmonitor 20:06:32 INFO - Successfully installed mozsystemmonitor 20:06:32 INFO - Cleaning up... 20:06:32 INFO - Return code: 0 20:06:32 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 20:06:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:06:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:06:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:06:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:06:32 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 0x20651f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2169a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x230cef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x230a0b0>, '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 0x230afb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x230b440>, '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': 'eca2ab57546de7b41f256b19000001ef-1502852752.375122-25052663', '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 20:06:32 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 20:06:32 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 20:06:32 INFO - Using env: {'DISPLAY': ':0', 20:06:32 INFO - 'HOME': '/home/cltbld', 20:06:32 INFO - 'LANG': 'en_US.UTF-8', 20:06:32 INFO - 'LANGUAGE': 'en_US:en', 20:06:32 INFO - 'LOGNAME': 'cltbld', 20:06:32 INFO - 'MAIL': '/var/mail/cltbld', 20:06:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:06:32 INFO - 'MOZ_NO_REMOTE': '1', 20:06:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:06:32 INFO - 'NO_EM_RESTART': '1', 20:06:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:06:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:06:32 INFO - 'PWD': '/builds/slave/test', 20:06:32 INFO - 'SHELL': '/bin/bash', 20:06:32 INFO - 'SHLVL': '1', 20:06:32 INFO - 'TERM': 'linux', 20:06:32 INFO - 'TMOUT': '86400', 20:06:32 INFO - 'USER': 'cltbld', 20:06:32 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1502852752.375122-25052663', 20:06:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:06:32 INFO - '_': '/tools/buildbot/bin/python'} 20:06:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:06:32 INFO - Downloading/unpacking jsonschema==2.5.1 20:06:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:06:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:06:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:06:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:06:33 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 20:06:33 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 20:06:33 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 20:06:33 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 20:06:33 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 20:06:33 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 20:06:33 INFO - Downloading functools32-3.2.3-2.tar.gz 20:06:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 20:06:33 INFO - warning: no files found matching '*.txt' 20:06:33 INFO - no previously-included directories found matching 'build' 20:06:33 INFO - no previously-included directories found matching 'dist' 20:06:33 INFO - no previously-included directories found matching '.git*' 20:06:33 INFO - Installing collected packages: jsonschema, functools32 20:06:33 INFO - Running setup.py install for functools32 20:06:33 INFO - warning: no files found matching '*.txt' 20:06:33 INFO - no previously-included directories found matching 'build' 20:06:33 INFO - no previously-included directories found matching 'dist' 20:06:33 INFO - no previously-included directories found matching '.git*' 20:06:33 INFO - Successfully installed jsonschema functools32 20:06:33 INFO - Cleaning up... 20:06:34 INFO - Return code: 0 20:06:34 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 20:06:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:06:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:06:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:06:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:06:34 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 0x20651f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2169a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x230cef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x230a0b0>, '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 0x230afb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x230b440>, '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': 'eca2ab57546de7b41f256b19000001ef-1502852752.375122-25052663', '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 20:06:34 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 20:06:34 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 20:06:34 INFO - Using env: {'DISPLAY': ':0', 20:06:34 INFO - 'HOME': '/home/cltbld', 20:06:34 INFO - 'LANG': 'en_US.UTF-8', 20:06:34 INFO - 'LANGUAGE': 'en_US:en', 20:06:34 INFO - 'LOGNAME': 'cltbld', 20:06:34 INFO - 'MAIL': '/var/mail/cltbld', 20:06:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:06:34 INFO - 'MOZ_NO_REMOTE': '1', 20:06:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:06:34 INFO - 'NO_EM_RESTART': '1', 20:06:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:06:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:06:34 INFO - 'PWD': '/builds/slave/test', 20:06:34 INFO - 'SHELL': '/bin/bash', 20:06:34 INFO - 'SHLVL': '1', 20:06:34 INFO - 'TERM': 'linux', 20:06:34 INFO - 'TMOUT': '86400', 20:06:34 INFO - 'USER': 'cltbld', 20:06:34 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1502852752.375122-25052663', 20:06:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:06:34 INFO - '_': '/tools/buildbot/bin/python'} 20:06:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:06:34 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 20:06:34 INFO - Cleaning up... 20:06:34 INFO - Return code: 0 20:06:34 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 20:06:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:06:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:06:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:06:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:06:34 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 0x20651f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2169a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x230cef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x230a0b0>, '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 0x230afb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x230b440>, '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': 'eca2ab57546de7b41f256b19000001ef-1502852752.375122-25052663', '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 20:06:34 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 20:06:34 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 20:06:34 INFO - Using env: {'DISPLAY': ':0', 20:06:34 INFO - 'HOME': '/home/cltbld', 20:06:34 INFO - 'LANG': 'en_US.UTF-8', 20:06:34 INFO - 'LANGUAGE': 'en_US:en', 20:06:34 INFO - 'LOGNAME': 'cltbld', 20:06:34 INFO - 'MAIL': '/var/mail/cltbld', 20:06:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:06:34 INFO - 'MOZ_NO_REMOTE': '1', 20:06:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:06:34 INFO - 'NO_EM_RESTART': '1', 20:06:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:06:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:06:34 INFO - 'PWD': '/builds/slave/test', 20:06:34 INFO - 'SHELL': '/bin/bash', 20:06:34 INFO - 'SHLVL': '1', 20:06:34 INFO - 'TERM': 'linux', 20:06:34 INFO - 'TMOUT': '86400', 20:06:34 INFO - 'USER': 'cltbld', 20:06:34 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1502852752.375122-25052663', 20:06:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:06:34 INFO - '_': '/tools/buildbot/bin/python'} 20:06:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:06:34 INFO - Downloading/unpacking blobuploader==1.2.4 20:06:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:06:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:06:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:06:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:06:35 INFO - Downloading blobuploader-1.2.4.tar.gz 20:06:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 20:06:35 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 20:06:35 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 20:06:35 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 20:06:35 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 20:06:35 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 20:06:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 20:06:35 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 20:06:35 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 20:06:35 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 20:06:35 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 20:06:35 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 20:06:36 INFO - Downloading docopt-0.6.1.tar.gz 20:06:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 20:06:36 INFO - Installing collected packages: blobuploader, requests, docopt 20:06:36 INFO - Running setup.py install for blobuploader 20:06:36 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 20:06:36 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 20:06:36 INFO - Running setup.py install for requests 20:06:36 INFO - Running setup.py install for docopt 20:06:36 INFO - Successfully installed blobuploader requests docopt 20:06:36 INFO - Cleaning up... 20:06:36 INFO - Return code: 0 20:06:36 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:06:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:06:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:06:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:06:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:06:36 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 0x20651f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2169a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x230cef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x230a0b0>, '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 0x230afb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x230b440>, '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': 'eca2ab57546de7b41f256b19000001ef-1502852752.375122-25052663', '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 20:06:36 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 20:06:36 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 20:06:36 INFO - Using env: {'DISPLAY': ':0', 20:06:36 INFO - 'HOME': '/home/cltbld', 20:06:36 INFO - 'LANG': 'en_US.UTF-8', 20:06:36 INFO - 'LANGUAGE': 'en_US:en', 20:06:36 INFO - 'LOGNAME': 'cltbld', 20:06:36 INFO - 'MAIL': '/var/mail/cltbld', 20:06:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:06:36 INFO - 'MOZ_NO_REMOTE': '1', 20:06:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:06:36 INFO - 'NO_EM_RESTART': '1', 20:06:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:06:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:06:36 INFO - 'PWD': '/builds/slave/test', 20:06:36 INFO - 'SHELL': '/bin/bash', 20:06:36 INFO - 'SHLVL': '1', 20:06:36 INFO - 'TERM': 'linux', 20:06:36 INFO - 'TMOUT': '86400', 20:06:36 INFO - 'USER': 'cltbld', 20:06:36 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1502852752.375122-25052663', 20:06:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:06:36 INFO - '_': '/tools/buildbot/bin/python'} 20:06:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:06:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 20:06:36 INFO - Running setup.py (path:/tmp/pip-RFFxiK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 20:06:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 20:06:37 INFO - Running setup.py (path:/tmp/pip-iXVF1E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 20:06:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 20:06:37 INFO - Running setup.py (path:/tmp/pip-rgCzLk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 20:06:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 20:06:37 INFO - Running setup.py (path:/tmp/pip-C29e3R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 20:06:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 20:06:37 INFO - Running setup.py (path:/tmp/pip-qjlyKd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 20:06:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 20:06:37 INFO - Running setup.py (path:/tmp/pip-gyVokW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 20:06:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 20:06:37 INFO - Running setup.py (path:/tmp/pip-MU02_3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 20:06:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 20:06:37 INFO - Running setup.py (path:/tmp/pip-F7fVtl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 20:06:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 20:06:37 INFO - Running setup.py (path:/tmp/pip-1eI6WA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 20:06:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 20:06:37 INFO - Running setup.py (path:/tmp/pip-mDYwpu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 20:06:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 20:06:37 INFO - Running setup.py (path:/tmp/pip-5FyetU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 20:06:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 20:06:37 INFO - Running setup.py (path:/tmp/pip-YdnLui-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 20:06:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 20:06:37 INFO - Running setup.py (path:/tmp/pip-GtZTdu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 20:06:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 20:06:37 INFO - Running setup.py (path:/tmp/pip-Mn05PX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 20:06:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 20:06:37 INFO - Running setup.py (path:/tmp/pip-nkGfUW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 20:06:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 20:06:38 INFO - Running setup.py (path:/tmp/pip-q7nncg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 20:06:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 20:06:38 INFO - Running setup.py (path:/tmp/pip-TweG2u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 20:06:38 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 20:06:38 INFO - Running setup.py install for manifestparser 20:06:38 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 20:06:38 INFO - Running setup.py install for mozcrash 20:06:38 INFO - Running setup.py install for mozdebug 20:06:38 INFO - Running setup.py install for mozdevice 20:06:38 INFO - Installing dm script to /builds/slave/test/build/venv/bin 20:06:38 INFO - Running setup.py install for mozfile 20:06:38 INFO - Running setup.py install for mozhttpd 20:06:38 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 20:06:38 INFO - Running setup.py install for mozinfo 20:06:38 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 20:06:38 INFO - Running setup.py install for mozInstall 20:06:38 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 20:06:38 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 20:06:38 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 20:06:38 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 20:06:38 INFO - Running setup.py install for mozleak 20:06:39 INFO - Running setup.py install for mozlog 20:06:39 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 20:06:39 INFO - Running setup.py install for moznetwork 20:06:39 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 20:06:39 INFO - Running setup.py install for mozprocess 20:06:39 INFO - Running setup.py install for mozprofile 20:06:39 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 20:06:39 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 20:06:39 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 20:06:39 INFO - Running setup.py install for mozrunner 20:06:39 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 20:06:39 INFO - Running setup.py install for mozscreenshot 20:06:39 INFO - Running setup.py install for moztest 20:06:39 INFO - Running setup.py install for mozversion 20:06:39 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 20:06:39 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 20:06:39 INFO - Cleaning up... 20:06:39 INFO - Return code: 0 20:06:39 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:06:39 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')]} 20:06:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:06:39 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')]} 20:06:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:06:39 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 0x20651f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2169a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x230cef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x230a0b0>, '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 0x230afb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x230b440>, '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': 'eca2ab57546de7b41f256b19000001ef-1502852752.375122-25052663', '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 20:06:39 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 20:06:39 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 20:06:39 INFO - Using env: {'DISPLAY': ':0', 20:06:39 INFO - 'HOME': '/home/cltbld', 20:06:39 INFO - 'LANG': 'en_US.UTF-8', 20:06:39 INFO - 'LANGUAGE': 'en_US:en', 20:06:39 INFO - 'LOGNAME': 'cltbld', 20:06:39 INFO - 'MAIL': '/var/mail/cltbld', 20:06:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:06:39 INFO - 'MOZ_NO_REMOTE': '1', 20:06:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:06:39 INFO - 'NO_EM_RESTART': '1', 20:06:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:06:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:06:39 INFO - 'PWD': '/builds/slave/test', 20:06:39 INFO - 'SHELL': '/bin/bash', 20:06:39 INFO - 'SHLVL': '1', 20:06:39 INFO - 'TERM': 'linux', 20:06:39 INFO - 'TMOUT': '86400', 20:06:39 INFO - 'USER': 'cltbld', 20:06:39 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1502852752.375122-25052663', 20:06:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:06:39 INFO - '_': '/tools/buildbot/bin/python'} 20:06:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:06:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 20:06:40 INFO - Running setup.py (path:/tmp/pip-5kIIcE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 20:06:40 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)) 20:06:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 20:06:40 INFO - Running setup.py (path:/tmp/pip-vA207e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 20:06:40 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)) 20:06:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 20:06:40 INFO - Running setup.py (path:/tmp/pip-1VOM6O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 20:06:40 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)) 20:06:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 20:06:40 INFO - Running setup.py (path:/tmp/pip-XduH4U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 20:06:40 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)) 20:06:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 20:06:40 INFO - Running setup.py (path:/tmp/pip-eLPpAB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 20:06:40 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)) 20:06:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 20:06:40 INFO - Running setup.py (path:/tmp/pip-9BBdaZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 20:06:40 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)) 20:06:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 20:06:40 INFO - Running setup.py (path:/tmp/pip-ndbm5C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 20:06:40 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)) 20:06:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 20:06:40 INFO - Running setup.py (path:/tmp/pip-Bj_C9l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 20:06:40 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)) 20:06:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 20:06:40 INFO - Running setup.py (path:/tmp/pip-Q_hHo1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 20:06:40 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)) 20:06:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 20:06:40 INFO - Running setup.py (path:/tmp/pip-nj_JO6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 20:06:40 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)) 20:06:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 20:06:40 INFO - Running setup.py (path:/tmp/pip-ju_Ql4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 20:06:40 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)) 20:06:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 20:06:40 INFO - Running setup.py (path:/tmp/pip-OO1FW4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 20:06:41 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)) 20:06:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 20:06:41 INFO - Running setup.py (path:/tmp/pip-ZefePD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 20:06:41 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)) 20:06:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 20:06:41 INFO - Running setup.py (path:/tmp/pip-ERUgiY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 20:06:41 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)) 20:06:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 20:06:41 INFO - Running setup.py (path:/tmp/pip-c8uCbC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 20:06:41 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)) 20:06:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 20:06:41 INFO - Running setup.py (path:/tmp/pip-xqHuDr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 20:06:41 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)) 20:06:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 20:06:41 INFO - Running setup.py (path:/tmp/pip-2LCRKR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 20:06:41 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)) 20:06:41 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)) 20:06:41 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)) 20:06:41 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)) 20:06:41 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)) 20:06:41 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)) 20:06:41 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)) 20:06:41 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 20:06:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:06:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:06:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:06:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:06:42 INFO - Downloading blessings-1.6.tar.gz 20:06:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 20:06:42 INFO - Installing collected packages: blessings 20:06:42 INFO - Running setup.py install for blessings 20:06:42 INFO - Successfully installed blessings 20:06:42 INFO - Cleaning up... 20:06:42 INFO - Return code: 0 20:06:42 INFO - Done creating virtualenv /builds/slave/test/build/venv. 20:06:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 20:06:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 20:06:42 INFO - Reading from file tmpfile_stdout 20:06:42 INFO - Current package versions: 20:06:42 INFO - argparse == 1.2.1 20:06:42 INFO - blessings == 1.6 20:06:42 INFO - blobuploader == 1.2.4 20:06:42 INFO - docopt == 0.6.1 20:06:42 INFO - functools32 == 3.2.3-2 20:06:42 INFO - jsonschema == 2.5.1 20:06:42 INFO - manifestparser == 1.1 20:06:42 INFO - mozInstall == 1.13 20:06:42 INFO - mozcrash == 1.0 20:06:42 INFO - mozdebug == 0.1 20:06:42 INFO - mozdevice == 0.51 20:06:42 INFO - mozfile == 1.2 20:06:42 INFO - mozhttpd == 0.7 20:06:42 INFO - mozinfo == 0.10 20:06:42 INFO - mozleak == 0.1 20:06:42 INFO - mozlog == 3.5 20:06:42 INFO - moznetwork == 0.27 20:06:42 INFO - mozprocess == 0.25 20:06:42 INFO - mozprofile == 0.28 20:06:42 INFO - mozrunner == 6.13 20:06:42 INFO - mozscreenshot == 0.1 20:06:42 INFO - mozsystemmonitor == 0.3 20:06:42 INFO - moztest == 0.8 20:06:42 INFO - mozversion == 1.4 20:06:42 INFO - psutil == 3.1.1 20:06:42 INFO - requests == 1.2.3 20:06:42 INFO - wsgiref == 0.1.2 20:06:42 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:06:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:06:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:06:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:06:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:06:42 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 0x20651f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2169a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x230cef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x230a0b0>, '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 0x230afb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x230b440>, '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': 'eca2ab57546de7b41f256b19000001ef-1502852752.375122-25052663', '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 20:06:42 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 20:06:42 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 20:06:42 INFO - Using env: {'DISPLAY': ':0', 20:06:42 INFO - 'HOME': '/home/cltbld', 20:06:42 INFO - 'LANG': 'en_US.UTF-8', 20:06:42 INFO - 'LANGUAGE': 'en_US:en', 20:06:42 INFO - 'LOGNAME': 'cltbld', 20:06:42 INFO - 'MAIL': '/var/mail/cltbld', 20:06:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:06:42 INFO - 'MOZ_NO_REMOTE': '1', 20:06:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:06:42 INFO - 'NO_EM_RESTART': '1', 20:06:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:06:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:06:42 INFO - 'PWD': '/builds/slave/test', 20:06:42 INFO - 'SHELL': '/bin/bash', 20:06:42 INFO - 'SHLVL': '1', 20:06:42 INFO - 'TERM': 'linux', 20:06:42 INFO - 'TMOUT': '86400', 20:06:42 INFO - 'USER': 'cltbld', 20:06:42 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1502852752.375122-25052663', 20:06:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:06:42 INFO - '_': '/tools/buildbot/bin/python'} 20:06:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:06:43 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)) 20:06:43 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)) 20:06:43 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)) 20:06:43 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)) 20:06:43 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)) 20:06:43 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)) 20:06:43 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)) 20:06:43 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)) 20:06:43 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)) 20:06:43 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 20:06:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:06:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:06:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:06:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:06:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 20:06:44 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)) 20:06:44 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)) 20:06:44 INFO - Installing collected packages: simplejson 20:06:44 INFO - Running setup.py install for simplejson 20:06:44 INFO - building 'simplejson._speedups' extension 20:06:44 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 20:06:45 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 20:06:45 INFO - Successfully installed simplejson 20:06:45 INFO - Cleaning up... 20:06:45 INFO - Return code: 0 20:06:45 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 20:06:45 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')]} 20:06:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:06:45 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')]} 20:06:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:06:45 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 0x20651f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2169a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x230cef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x230a0b0>, '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 0x230afb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x230b440>, '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': 'eca2ab57546de7b41f256b19000001ef-1502852752.375122-25052663', '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 20:06:45 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 20:06:45 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 20:06:45 INFO - Using env: {'DISPLAY': ':0', 20:06:45 INFO - 'HOME': '/home/cltbld', 20:06:45 INFO - 'LANG': 'en_US.UTF-8', 20:06:45 INFO - 'LANGUAGE': 'en_US:en', 20:06:45 INFO - 'LOGNAME': 'cltbld', 20:06:45 INFO - 'MAIL': '/var/mail/cltbld', 20:06:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:06:45 INFO - 'MOZ_NO_REMOTE': '1', 20:06:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:06:45 INFO - 'NO_EM_RESTART': '1', 20:06:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:06:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:06:45 INFO - 'PWD': '/builds/slave/test', 20:06:45 INFO - 'SHELL': '/bin/bash', 20:06:45 INFO - 'SHLVL': '1', 20:06:45 INFO - 'TERM': 'linux', 20:06:45 INFO - 'TMOUT': '86400', 20:06:45 INFO - 'USER': 'cltbld', 20:06:45 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1502852752.375122-25052663', 20:06:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:06:45 INFO - '_': '/tools/buildbot/bin/python'} 20:06:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:06:45 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 20:06:45 INFO - Cleaning up... 20:06:45 INFO - Return code: 0 20:06:45 INFO - Running post-action listener: _resource_record_post_action 20:06:45 INFO - Running post-action listener: _start_resource_monitoring 20:06:45 INFO - Starting resource monitoring. 20:06:45 INFO - [mozharness: 2017-08-16 03:06:45.682257Z] Finished create-virtualenv step (success) 20:06:45 INFO - [mozharness: 2017-08-16 03:06:45.682720Z] Running install step. 20:06:45 INFO - Running pre-action listener: _resource_record_pre_action 20:06:45 INFO - Running main action method: install 20:06:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 20:06:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 20:06:45 INFO - Reading from file tmpfile_stdout 20:06:45 INFO - Detecting whether we're running mozinstall >=1.0... 20:06:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 20:06:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 20:06:46 INFO - Reading from file tmpfile_stdout 20:06:46 INFO - Output received: 20:06:46 INFO - Usage: mozinstall [options] installer 20:06:46 INFO - Options: 20:06:46 INFO - -h, --help show this help message and exit 20:06:46 INFO - -d DEST, --destination=DEST 20:06:46 INFO - Directory to install application into. [default: 20:06:46 INFO - "/builds/slave/test"] 20:06:46 INFO - --app=APP Application being installed. [default: firefox] 20:06:46 INFO - mkdir: /builds/slave/test/build/application 20:06:46 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'] 20:06:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 20:07:03 INFO - Reading from file tmpfile_stdout 20:07:03 INFO - Output received: 20:07:03 INFO - /builds/slave/test/build/application/firefox/firefox 20:07:03 INFO - Running post-action listener: _resource_record_post_action 20:07:03 INFO - [mozharness: 2017-08-16 03:07:03.992664Z] Finished install step (success) 20:07:03 INFO - [mozharness: 2017-08-16 03:07:03.992814Z] Running setup-mitmproxy step. 20:07:03 INFO - Running pre-action listener: _resource_record_pre_action 20:07:03 INFO - Running main action method: setup_mitmproxy 20:07:03 INFO - Skipping: mitmproxy is not required 20:07:03 INFO - Running post-action listener: _resource_record_post_action 20:07:03 INFO - [mozharness: 2017-08-16 03:07:03.993644Z] Finished setup-mitmproxy step (success) 20:07:03 INFO - [mozharness: 2017-08-16 03:07:03.993867Z] Running run-tests step. 20:07:03 INFO - Running pre-action listener: _resource_record_pre_action 20:07:03 INFO - Running pre-action listener: _set_gcov_prefix 20:07:03 INFO - Running main action method: run_tests 20:07:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 20:07:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 20:07:04 INFO - Python 2.7.3 20:07:04 INFO - Return code: 0 20:07:04 INFO - grabbing minidump binary from tooltool 20:07:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:07:04 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 0x230a0b0>, '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 0x230afb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x230b440>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 20:07:04 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 20:07:04 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 20:07:04 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 20:07:04 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 20:07:04 INFO - Return code: 0 20:07:04 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 20:07:04 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 20:07:04 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 20:07:04 INFO - ENV: RUST_BACKTRACE is now full 20:07:04 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 20:07:04 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 20:07:04 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/CfE8SazFTyCmvfD5YyBUnw/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-010', '--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 20:07:04 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/CfE8SazFTyCmvfD5YyBUnw/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-010 --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 20:07:04 INFO - Using env: {'DISPLAY': ':0', 20:07:04 INFO - 'HOME': '/home/cltbld', 20:07:04 INFO - 'LANG': 'en_US.UTF-8', 20:07:04 INFO - 'LANGUAGE': 'en_US:en', 20:07:04 INFO - 'LOGNAME': 'cltbld', 20:07:04 INFO - 'MAIL': '/var/mail/cltbld', 20:07:04 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 20:07:04 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 20:07:04 INFO - 'MOZ_ACCELERATED': '1', 20:07:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:07:04 INFO - 'MOZ_NO_REMOTE': '1', 20:07:04 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 20:07:04 INFO - 'MOZ_WEBRENDER': '1', 20:07:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:07:04 INFO - 'NO_EM_RESTART': '1', 20:07:04 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:07:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:07:04 INFO - 'PWD': '/builds/slave/test', 20:07:04 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 20:07:04 INFO - 'RUST_BACKTRACE': 'full', 20:07:04 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 20:07:04 INFO - 'SHELL': '/bin/bash', 20:07:04 INFO - 'SHLVL': '1', 20:07:04 INFO - 'TERM': 'linux', 20:07:04 INFO - 'TMOUT': '86400', 20:07:04 INFO - 'USER': 'cltbld', 20:07:04 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1502852752.375122-25052663', 20:07:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:07:04 INFO - '_': '/tools/buildbot/bin/python'} 20:07:04 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/CfE8SazFTyCmvfD5YyBUnw/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-010', '--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 20:07:04 INFO - mozversion application_buildid: 20170816020308 20:07:04 INFO - mozversion application_changeset: 4e93516e92e58d166ad37b8544c3230024afb587 20:07:04 INFO - mozversion application_display_name: Nightly 20:07:04 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 20:07:04 INFO - mozversion application_name: Firefox 20:07:04 INFO - mozversion application_remotingname: firefox 20:07:04 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 20:07:04 INFO - mozversion application_vendor: Mozilla 20:07:04 INFO - mozversion application_version: 57.0a1 20:07:04 INFO - mozversion platform_buildid: 20170816020308 20:07:04 INFO - mozversion platform_changeset: 4e93516e92e58d166ad37b8544c3230024afb587 20:07:04 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 20:07:04 INFO - mozversion platform_version: 57.0a1 20:07:04 INFO - using testdate: 1502852824 20:07:04 INFO - actual date: 1502852824 20:07:04 INFO - starting webserver on 'localhost:40103' 20:07:04 INFO - SUITE-START | Running 2 tests 20:07:04 INFO - TEST-START | dromaeo_css 20:07:04 INFO - Initialising browser for dromaeo_css test... 20:07:04 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:40103/getInfo.html -profile /tmp/tmpBkpIJ2/profile 20:07:04 INFO - TEST-INFO | started process 4178 (/builds/slave/test/build/application/firefox/firefox http://localhost:40103/getInfo.html) 20:07:11 INFO - TEST-INFO | 4178: exit 0 20:07:11 INFO - Browser initialized. 20:07:11 INFO - Running cycle 1/1 for dromaeo_css test... 20:07:11 INFO - TEST-INFO | started process 4359 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpBkpIJ2/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 20:07:12 INFO - PID 4359 | WebRender - OpenGL version new 3.2.0 NVIDIA 361.42 20:07:12 INFO - PID 4359 | WebRender - OpenGL version new 3.2.0 NVIDIA 361.42 20:07:13 INFO - PID 4359 | 20:07:13 INFO - PID 4359 | (/builds/slave/test/build/application/firefox/firefox:4416): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 20:07:13 INFO - PID 4359 | 20:07:23 INFO - PID 4359 | RSS: Main: 195420160 20:07:23 INFO - PID 4359 | 20:07:26 INFO - PID 4359 | WebRender - OpenGL version new 3.2.0 NVIDIA 361.42 20:10:23 INFO - PID 4359 | Cycle 1(1): loaded http://localhost:40103/tests/dromaeo/cssquery-dojo.html (next: http://localhost:40103/tests/dromaeo/cssquery-ext.html) 20:10:24 INFO - PID 4359 | RSS: Main: 226095104 20:10:24 INFO - PID 4359 | 20:13:26 INFO - PID 4359 | Cycle 1(1): loaded http://localhost:40103/tests/dromaeo/cssquery-ext.html (next: http://localhost:40103/tests/dromaeo/cssquery-jquery.html) 20:13:27 INFO - PID 4359 | RSS: Main: 224104448 20:13:27 INFO - PID 4359 | 20:16:29 INFO - PID 4359 | Cycle 1(1): loaded http://localhost:40103/tests/dromaeo/cssquery-jquery.html (next: http://localhost:40103/tests/dromaeo/cssquery-mootools.html) 20:16:29 INFO - PID 4359 | RSS: Main: 274939904 20:16:29 INFO - PID 4359 | 20:19:32 INFO - PID 4359 | Cycle 1(1): loaded http://localhost:40103/tests/dromaeo/cssquery-mootools.html (next: http://localhost:40103/tests/dromaeo/cssquery-prototype.html) 20:19:32 INFO - PID 4359 | RSS: Main: 276127744 20:19:32 INFO - PID 4359 | 20:22:36 INFO - PID 4359 | Cycle 1(1): loaded http://localhost:40103/tests/dromaeo/cssquery-prototype.html (next: http://localhost:40103/tests/dromaeo/cssquery-yui.html) 20:22:37 INFO - PID 4359 | RSS: Main: 279678976 20:22:37 INFO - PID 4359 | 20:25:39 INFO - PID 4359 | Cycle 1(1): loaded http://localhost:40103/tests/dromaeo/cssquery-yui.html (next: http://localhost:40103/tests/dromaeo/cssquery-dojo.html) 20:25:39 INFO - PID 4359 | RSS: Main: 280354816 20:25:39 INFO - PID 4359 | 20:25:39 INFO - PID 4359 | __start_tp_report 20:25:39 INFO - PID 4359 | _x_x_mozilla_page_load 20:25:39 INFO - PID 4359 | _x_x_mozilla_page_load_details 20:25:39 INFO - PID 4359 | |i|pagename|runs| 20:25:39 INFO - PID 4359 | |0;dojo.html;3122.734567561757;3125.7499400047986;3146.1348129264456;3149.3543823516184;3162.9367412651745;6173.660448675332;6206.534509911752;6210.9068363974575;6237.844053898655;6247.593906396087;6023.969880150604;6152.477039451652;6177.722002509887;6206.875862482759;6212.565120441571;5640.971795141018;5654.943450565483;5672.404397538261;5677.801276955307;5680.3467601225975;5700.258966334371;5702.344230413514;5703.344115426717;5706.115552089433;5707.514861236779;5674.460926212003;5689;5696.430356964291;5703.686297253649;5705.942940570603;5653.8586535336535;5657.2928383952;5666.858328541799;5685.175649530836;5687.744051517671;5560.582956278296;5628.746706398222;5642.097264437712;5709.514691251248;5791.739371728282;5969.61197522164;6017.638941663514;6032.215811944419;6084.39156084388;6107.63354198745;6588.077669126326;6602.1087153234175;6645.136132302818;6673.065770792093;6718.160229971254;6657.201135863727;6669.43309818666;6676.465882729419;6677.098591690108;6711.664416779142;6143.354947730513;6169.81490555284;6193.1020002099895;6196.969015154896;6217.720202590895;6748.358905903931;6750.628715420601;6838.111045564145;6852.177738671292;6866.073080134118;6323;6409.487241020707;6414.294427612959;6473.417392434703;6573.83565410859;6553.901691474632;6605.603663780189;6618.073469714244;6641.933580664131;6676.79969600903;6246.843828904313;6583.506237032146;6648.5678430901835;6690.698918548677;6729.966350168218;6650.434713049445;6653.73385064592;6731.932680673131;6751.189857217166;6756.898646520306;5322.414534401213;5421.783128674888;5423.376311724202;5483.2049352844415;5497.367802702661;4588.49526552079;4640.1879671058105;4662.860114196579;4665.86002419928;4709.952900470951;5690.459406356389;5701.942980570224;5704.71476426177;5775.451332123442;5795.0727883539275;6671.166104236971;6672.466202703772;6675.46596272297;6678;6702.664866756642;5745.798897038667;5787.160861675034;5823.330317013513;5833.82498525045;5838.474537291664;5813.505852002627;5821.214136091573;5833.912491312633;5904.439078287556;5929.258842644669;6409.359064093554;6415.647139407284;6423.261324947597;6427.871442571122;6432.099506069154;6555.3772391622715;6598.3401659833635;6610.074589557562;6613.10723052401;6635.933640663725;6315.5894866833505;6315.873682526416;6372.840678982877;6390.48876089921;6400.39196276353;5568.582356323211;6473.255575608865;6495.74017039332;6545.476361890942;6599.8020059398295;6583.670816459254;6681.432078273207;6721.227058888095;6728.226253980855;6729.596224226562;6344.524160688059;6403.519736019724;6423.389777971085;6465.062565928009;6482.254540727877;6495.837604059936;6498.155239818793;6507.251666058464;6513.576617519846;6514.9348506514325;6357.650329231937;6449.322821103717;6461.547691661539;6465.191851018622;6476.190476190476;6440.0983862260255;6489;6493.058506516623;6493.740250389931;6517.771877984248;6062.818115456544;6191.040388739752;6291.559590828781;6337.493000560036;6379.585326953733 20:25:39 INFO - PID 4359 | |1;ext.html;843.1694780641063;851.4380508864151;871.1419252036744;899.622158693349;901.2474583722591;40077.3988390174;41540;41719.374209386886;41751.582484175146;41878.37182442262;39585.60414395855;39587.80206098973;39741.80129099358;39781.40327895084;40010;6942.826429339269;7021.332973367547;7028.508004439691;7038.9296107039045;7041.471889608274;6928.688209030605;6992.091028166356;6992.230854605989;7015.088038554981;7064.717411303542;7024.4029257513175;7563.168051514329;7746.264104910025;7796.610169491531;7798.337141342992;7564.924350756477;7659.502132361378;7663.846723065535;7679.385649148083;7705.075390953121;7541.849163016709;7623.466357354987;7643.656035478417;7717.922820771777;7724.188960159158;39741;39999.60000400017;40054.198916021516;40070.39894401586;40207;3527.5414196154593;3580.9283814323826;3588.802615856127;3589.3718599245026;3589.4436362363876;32156;32177.1955701107;32369.838150809097;32371.514427283608;32521.6747832521;5010.3737032870895;5024.673396229234;5046.44489106198;5075.086484432801;5079;184739;225815;228668;228828;231602;51556.484435155915;51749.741251293504;51760.22359664608;51847.74076129595;52100.73949630303;55292;56685.14972275419;56696.14955775667;56806.715966419906;56813.43186568164;16158.838411615734;16292.34830606786;16326.918365408335;16352.427665031666;16374.099424531527;13325.66685832862;13403.530876419278;13407.061505694508;13420;13423.664408389868;15176.544703658908;15191.316390762222;15304.846951530564;15355.309011094527;15464.613384665474;5833.79581714638;6058.545609079337;6097.725602347905;6130.049842274455;6138.846528836725;964.6816550538306;991.9851202231972;997.3915911294105;1003.0922015575916;1024.5082360467018;22846.8857655714;22882.31353059411;23069.653955190686;23111.844407779543;23137.305880823267;1090.7327704712395;1090.9799337619193;1095.8246680531076;1105.5854054729477;1108.667399780079;11986.981106606036;12040.337781422106;12095.455704493319;12211.69470763238;12308.199967002116;234034;235769;235962;236087;238150;46087;47243;54174.187387189224;54236.18645720317;54430.455695442535;1434.5552878607666;1443.0620096936866;1445.551878917539;1450.572081236038;1463.297617143777;27288.59067113955;27407.725922740516;27577.86211069012;28040.57939130874;28125.71874281231;34364;34440.483392748625;34462.48306275458;34544.65455345515;34610.307793844484;185068;185981;186077.06961465106;186432;187516;35703.82148089243;35762.284754304244;35786.8210658945;35833;35885.820570898024;44752.55247447614;48473.51526484831;48920;49227.50772492372;49872.750636248034;34733.826330868185;35238.647613523535;35363.823180883934;35673.821630892715;35723.82138089293;34710.65289347074;35167.47248791321;35447.46828797622;35582.64417355897;36188;39085;39114.60885391109;39471.802640986614;39819.40270895881;39915.40126898157;33943.32113357769;34100.317993640485;34597.827010864785;34832.65167348294;35148.64851351556;22599.435014124778;23376.883115584315;23797.048118075083;23805.761942380355;23985.04059837587 20:25:39 INFO - PID 4359 | |2;jquery.html;551.509156850403;570.4096260370517;573.2919843992669;578.1558923971002;595.5384576952861;21766.782332176692;22428.8878555607;22604;22658.54682906343;22661.320160395193;24208.87895560524;26160.476790464178;26294.342641433974;26324.868375658094;26354.604680929802;7028.543144695604;7203.747868824592;7209.711611535558;7215.783526494213;7216.639168041604;6337.968310158442;7060.399866011395;7113.89329160063;7121.430285577141;7121.78634640959;6968.825779355506;6978.895316570255;6982.1621405431415;6989.056477375566;6992;6980.441564674839;6983;6989.475789315821;6996.755113571026;6998.475114366392;6737.898931516032;6790;6843.520953533254;6858.794236172923;6885;29211.269718257;31718.524222136686;31883.362332753448;32524.83737581297;32646.67353326484;1918.1272521002911;1965.9115339809744;1966.6165097805933;1973.5362189885366;1974.9111289991986;20898.164073437045;21061.262855799974;21084.156633734634;21106.26128085525;21207.68188477174;2491.451880586268;2523.4574566468295;2570.8586027768465;2595.4030572968322;2616.7775739062204;137446;140305;140755.29622351823;140816;140875.29562352225;20307.492312692004;21306.04122814477;21390.572188556143;21415.357539273846;22393.320500962494;22482.21312254096;23651.29046128619;23682.64476032861;23688.64467032996;43294.35058474125;9455.29085318604;9480.668176613786;9509.476978766234;9709.6116155353;9755.853662195073;8677.349198810114;8711.0417854036;8766.517841518778;8793.780155496035;8898.822023559493;8927.687530936517;9130;9250.444973301623;9393.248540116774;9477.431354118775;2646.4442467082126;2698.9325266868486;2723.917347314389;2755.1872197701728;2787.0663327785014;964.1659964131117;967.3373738988815;969.2343048991359;970.7767213540925;1009.5154325923597;19641.901790491243;19797.901010494854;20381.592368152553;22936.541269174522;24474.632880506808;984.5175863826817;1030.7062487191115;1035.2597892506894;1037.3516552154904;1044.5926088825365;11243.66269011931;11274;11377.2604780689;11399.829002564968;11461.713457163638;464536;467397;472176;480080;492623;115010.42494787472;115533;119468;119800.4009979962;120088.3995580034;1219.4634360881184;1237.900967922564;1275.7894947333587;1283.6149155253386;1289.9032572556907;20260.392188234375;20276.290329838386;20511.4872128198;20564.074616642585;20927;57547.71226143843;58707;58908;59484.405155949615;59550;72873;72917.6354118226;73291.63354183195;73451.26548734658;73590;14421.278936052946;14556.927215363856;14680.41278348854;14740.410383584536;14938.850611493746;22836;23020;23118.653220202046;23120.4219894504;23224.767752322936;18290.451286461426;18372.632547349247;18419.447416577525;18521.722174167127;18559.81440185581;15975.121368324853;16329.836701632832;16972.66054678924;17471.475855724348;17499.7375039372;18945.673802834222;19159.425217243504;19185.32851350196;19374;19387.61224775525;13923.23422211788;14490.130592164503;14607.19660418687;14719.92640036793;14793.852061479247;18111.45665630033;18143.546411339295;18255.817441825944;18343.908280458512;18531.629367412846 20:25:39 INFO - PID 4359 | |3;mootools.html;1354.9796753048704;1399.7270532246216;1415.851335609761;1416.815813944187;1427.9286035698215;13377.732445351086;13587.524436644719;13792.103513271642;13851.030427870053;13893.652658683537;13993.0904491208;14230.644233894158;14237.074590151633;14258.928705356484;14288.785668214985;2607.804414668898;2651.151631477928;2655.0972669292437;2656.402309480361;2658.8936442542276;2475.6905386826647;2527.4060595759984;2613.89544418223;2618.55484567623;2673.9197824065213;2607.7783388411913;2644.7487488688544;2664.853433061181;2665.3869609989715;2669.8665066746585;2530.72162062173;2570.2546261584116;2584.9224523264334;2594.9610755838676;2597.194869590433;2505.2233807519547;2532.1011041080337;2536.4546622476073;2542.008616639512;2550.477152183798;13255.801162982563;13644.795328070088;13679.794803077963;13826.032177747562;13845.16928984264;7345.55926644403;7585.734499292498;7615.390768738488;7672.3478504327195;7694.230576942261;4970.229614409773;5048.242763585455;5137.255098010804;5184.637075404723;5216.382921294411;1849.3989453427555;1858.3310008396966;1864.14249445254;1898.3355825461117;1900.2683966672791;21682.78317216839;21929.23247686323;21930.232441864457;21947.99999999984;21961.560768784693;6338.683065846689;6426.100345951477;6534.803955881332;6570.441512471493;6630.138082049302;15706.9214653926;15833;15889.126098064717;15912.124833134289;15922.840771592368;7398.260173982666;7528.757754970368;7544.509606875646;7554.622268886534;7555;6784.660766961632;6792.796216113525;6889.173299204128;6999.37005669482;7037.120359955005;4946.455889852114;5147.433782283946;5203.048856678745;5205.947940520622;5214.191800270964;1366.863313668645;1410.5274732964367;1502.3990403838552;1525.2450037231642;1558.1274486287716;711.654847399011;856.7515420527977;861.5950503263456;871.4858233642182;883.1565854608833;7903.960480197562;7925.682972681028;8141.22658347456;8153.633086511121;8203.917960820434;968.4334664221368;973.7078876337213;979.2410881566842;992.3500107429645;1005.0954141272913;4663.137319595886;4726.26742854858;4815.3258543803895;5007.098722230034;5156.252343410185;17970.371037013643;18433.723494147598;18750;18919;18969.81030189708;18453.446396608124;18517.722234166496;18537.073146342627;18607.16267767954;18608.44174674762;9976.850347244797;10833.67498975032;10860.891391085988;10863.293885897392;10897.509612067475;7602.6198690066385;7954.5624990626075;8081.272685458337;8183.83632327362;8327.333813294801;16343.59141021484;16950.66098677995;17013.404530841362;17062.06158661236;17092.145392730064;16741;16868.493945181664;16915.66168676595;17046.829531704523;17142.65714685674;11346.262492938264;11502.769944601228;11573.132015098732;11577;11599.304041757521;12630.810537841757;12773.744525109632;12867.935660321638;12958.028147889134;12963.092583519441;9967.50162491858;10300.948495257475;10491.108255798343;10509.842352364874;10653.680389588324;10576.735581610214;10596.417197054236;10601.840972385266;10611.787764244826;10617.575296988034;8845.734627961172;8924.464532127833;8969.820603587761;9009.459432434074;9010.369274150746;6909.30906909305;6913.274106218976;6920.792376228721;6932.341427564374;7010.649467526501;6557.344265573404;6777.830554236183;6825.726970921108;6860.108185935996;6945.20130185015 20:25:39 INFO - PID 4359 | |4;prototype.html;496.4985364781572;497.24910529152686;512.262342227193;519.9168133098702;525.7266221564787;6158.322584515705;6299.748010079597;6337.809865704025;6344.7462101515885;6400.455961243294;5927.436893495111;6084.574079814415;6160.876782464348;6167.105769663396;6180.629162250269;4919.72941488218;4987.875303117415;4991.1016017117;4991.627302491807;4993.850184494471;4811.353755434497;4978.825741099062;4987.802927297441;4991.72710958705;5012.8997420051755;4916.139675556763;4931.679440836352;4942.5304596063315;4975.502449755032;4980.800767969295;4938.259261110844;4952.232403977389;4969.900601987958;4998.2002879539095;5004.249362595603;4372.1255748850035;4429.9114017719785;4464.660601819473;4465.910681786346;4484.170428470743;5962.731677074542;6075.939240607626;6116.847078823021;6147.44672979434;6156.168917196211;5716.113362751784;5733.226014488033;5741.167530708066;5743.741531631086;5773.826785196451;6493.675316234217;6514.348565143495;6540.574862633961;6599.8020059398295;6631.1379520662;4735.715857048588;4794.137055330039;4827;4835.226363781778;4835.9032819343765;6798.388145066968;6839.529501157225;6909.654517274116;6951.16586009677;6955.930440695579;4956.430010548761;5018.924716129261;5039.672421292605;5045.470225626256;5089.262057001714;5013.273075404046;5040.983606557406;5048.3184770056305;5097.133487307166;5104.464031276662;5667.659940403589;5684.8863022739315;5691.68695721731;5742.655440673573;5764.510016648548;6495.921305182391;6597.373249541286;6601.603903765789;6664.400203981568;6695;1630.6657135287237;1669.6577201673629;1684.1831711619855;1737.5482374582448;1781.1628534588722;1195.623378635727;1218.713602303458;1223.427895154722;1232.8397308349856;1237.3543187560704;5631.7747290108755;5680.4319568042865;5751.309842818805;5759.178002778608;5778.624389414675;6594.9670251649395;6604.811133995927;6607.174103237096;6706.798796036127;6711.328867113347;5641.069223578063;5688.544916406678;5740.311162660508;5759.971200143972;5760.8271751847515;3529.7705649133236;3562.786232826039;3570.910727231788;3588.721162062109;3602.6937710294396;6484.448821850196;6510.25132109804;6546.0835483032415;6548.148740663683;6575.473962083021;6737.629430381278;6806.76176333826;6839.555428897106;6850.862982740317;6879.3120687931805;6422.357764223634;6470.579412338183;6494.220693516808;6511.2512061113575;6529.151210342625;6670.733170673313;6701.396874281338;6731.764388246388;6747.852865013057;6765.221999470124;6474.0866610026615;6595.208574971034;6617.172853393326;6645.867082658417;6655.767048153291;6494.675266236574;6495.967520162369;6551.672416379257;6553.279139294578;6570.277269500447;4912.8771780705765;4946.62900282473;4955.306257124078;4974.403071631283;5007.724575148256;6724.495662825406;6756.493263005196;6777.457803375817;6784.728610855511;6792.966035169792;6388.233411990405;6408.935910640834;6437.485001199986;6444.516661250331;6466.288708242184;6359.236891573041;6381.319845664739;6414.294427612866;6418.775342862978;6427.807165785034;5966.70166491665;6310.684465776784;6407.1488187756;6482.546221764431;6488.286288508166;6433.806985790434;6501.05734668461;6514.674266286762;6531.379518945692;6534.8366290843105;6225.750969961151;6346.01636746305;6374.6175229484525;6413.551051426355;6429.099926010455 20:25:39 INFO - PID 4359 | |5;yui.html;902.7743064233938;923.5243849417551;924.440713368412;926.2219735422244;939.4128669581513;17093.914530427344;17593.12034398278;17613;17709.82290177098;19059.714104288447;20915.37253882382;21367.14531418745;21612.56774864502;21654.0255688494;21656.35030949074;1035.823909935311;1054.7626783973622;1059.9470026498682;1063.2929102147064;1065.3022270412853;947.1002547579792;1048.8741351037886;1052.6789329254575;1058.3967138730927;1058.7141471802609;1093.2347356850196;1103.365564800239;1107.4352080438953;1107.6621630402724;1108.983365249522;1081.32957566309;1086.788076325117;1089.2320913755784;1094.7482079121808;1095.1512577752226;798.253632853284;803.5018288661009;807.7172989453703;808.0465051239535;808.6684459371629;19573;20227.797722022886;20415.591688166303;20437;20454.897725511277;20755.273565425137;21348.786512134837;21412.357629271148;21557;21818;16515.421960231335;16806.747898781527;17054.829451705573;17064.317427302893;17381.565460863454;3587.712982961357;3602.441621548664;3610.4584312353095;3622.040159357772;3623.836927338276;129097;130772;133730.33134834265;134437;135652;16974.745378819327;17120.74318885218;17141.228644711016;17582.120893955253;17607.559811004572;31371.843140784607;31587.21031974219;31715;31846.363072738877;32235.67764322327;7140.321669441395;7481.8877716834295;7554.924450755532;8781.69264075767;8969.461832289953;3774.2640185164178;4130.607592278729;4135.048938744106;4158.459400278005;4174.3947127666315;4957.330760347307;4992.775325110379;5018.648694591344;5076.18780995039;5121.615878809104;1093.6828319787173;1099.5381939585393;1106.856108705863;1113.0316624536704;1115.81031224692;678.35217367414;680.904673345732;697.5082566790502;700.5061431690646;703.3177817517001;11243.887561124448;11999;12192.512299508098;12655.873441265654;12974.935125324313;677.1873751498222;690.6684791300204;699.7236091743732;705.6013352455949;707.049019069351;5134.87162820925;5139.665921715076;5227.947720522746;5320.760565774472;5389.676619402849;105231.4738426303;108923.45538272258;111101.44449277702;111239.44380278209;113596.43201783938;95309.09381812325;97154;97684;98370;101681;81715.5914220425;84214;85974;86640;89458.55270723604;9894.20846332306;12120;13328.666783330495;13427.462901483832;13526.053176277566;37280.62719372771;39480.80259598799;39676.80161599174;40011.199776003734;40103.99480025929;69714.30285697078;71299;71953;73581.26418735745;74377.6281118591;19297.5175620605;19355.225790968205;19516.60966780685;19776;20136.59726805485;20775.168993240102;21262.362129136152;21523.354299371043;21956.560868782854;22088.44778880541;17074.2316595751;17377.39179128775;17673;18104.366347177787;18153.727694084864;17140.742888856927;17388.739168912223;18835.90582047136;18893.055347232308;18999.050047497294;17290.13549322554;17621.647567048843;17742.556436089202;17791.377301794375;18143.727844082612;13480.730385392433;14021.579352619437;14167.760932712717;14433.639159021108;14689.265536722907;13426.932865335611;13454.865451345362;13519.256440895846;13546.254955977516;13548.187108773505 20:25:39 INFO - PID 4359 | __end_tp_report 20:25:39 INFO - PID 4359 | __start_cc_report 20:25:39 INFO - PID 4359 | _x_x_mozilla_cycle_collect,389 20:25:39 INFO - PID 4359 | __end_cc_report 20:25:39 INFO - PID 4359 | __startTimestamp1502853939972__endTimestamp 20:25:39 INFO - PID 4359 | 20:25:39 INFO - PID 4359 | ------- Summary: start ------- 20:25:39 INFO - PID 4359 | Number of tests: 6 20:25:39 INFO - PID 4359 | 20:25:39 INFO - PID 4359 | [#0] dojo.html Cycles:165 Average:6100.05 Median:6323.00 stddev:710.82 (11.2%) stddev-sans-first:673.54 20:25:39 INFO - PID 4359 | Values: 3122.7 3125.7 3146.1 3149.4 3162.9 6173.7 6206.5 6210.9 6237.8 6247.6 6024.0 6152.5 6177.7 6206.9 6212.6 5641.0 5654.9 5672.4 5677.8 5680.3 5700.3 5702.3 5703.3 5706.1 5707.5 5674.5 5689.0 5696.4 5703.7 5705.9 5653.9 5657.3 5666.9 5685.2 5687.7 5560.6 5628.7 5642.1 5709.5 5791.7 5969.6 6017.6 6032.2 6084.4 6107.6 6588.1 6602.1 6645.1 6673.1 6718.2 6657.2 6669.4 6676.5 6677.1 6711.7 6143.4 6169.8 6193.1 6197.0 6217.7 6748.4 6750.6 6838.1 6852.2 6866.1 6323.0 6409.5 6414.3 6473.4 6573.8 6553.9 6605.6 6618.1 6641.9 6676.8 6246.8 6583.5 6648.6 6690.7 6730.0 6650.4 6653.7 6731.9 6751.2 6756.9 5322.4 5421.8 5423.4 5483.2 5497.4 4588.5 4640.2 4662.9 4665.9 4710.0 5690.5 5701.9 5704.7 5775.5 5795.1 6671.2 6672.5 6675.5 6678.0 6702.7 5745.8 5787.2 5823.3 5833.8 5838.5 5813.5 5821.2 5833.9 5904.4 5929.3 6409.4 6415.6 6423.3 6427.9 6432.1 6555.4 6598.3 6610.1 6613.1 6635.9 6315.6 6315.9 6372.8 6390.5 6400.4 5568.6 6473.3 6495.7 6545.5 6599.8 6583.7 6681.4 6721.2 6728.2 6729.6 6344.5 6403.5 6423.4 6465.1 6482.3 6495.8 6498.2 6507.3 6513.6 6514.9 6357.7 6449.3 6461.5 6465.2 6476.2 6440.1 6489.0 6493.1 6493.7 6517.8 6062.8 6191.0 6291.6 6337.5 6379.6 20:25:39 INFO - PID 4359 | 20:25:39 INFO - PID 4359 | [#1] ext.html Cycles:180 Average:39048.26 Median:19706.96 stddev:55858.02 (283.4%) stddev-sans-first:55941.05 20:25:39 INFO - PID 4359 | Values: 843.2 851.4 871.1 899.6 901.2 40077.4 41540.0 41719.4 41751.6 41878.4 39585.6 39587.8 39741.8 39781.4 40010.0 6942.8 7021.3 7028.5 7038.9 7041.5 6928.7 6992.1 6992.2 7015.1 7064.7 7024.4 7563.2 7746.3 7796.6 7798.3 7564.9 7659.5 7663.8 7679.4 7705.1 7541.8 7623.5 7643.7 7717.9 7724.2 39741.0 39999.6 40054.2 40070.4 40207.0 3527.5 3580.9 3588.8 3589.4 3589.4 32156.0 32177.2 32369.8 32371.5 32521.7 5010.4 5024.7 5046.4 5075.1 5079.0 184739.0 225815.0 228668.0 228828.0 231602.0 51556.5 51749.7 51760.2 51847.7 52100.7 55292.0 56685.1 56696.1 56806.7 56813.4 16158.8 16292.3 16326.9 16352.4 16374.1 13325.7 13403.5 13407.1 13420.0 13423.7 15176.5 15191.3 15304.8 15355.3 15464.6 5833.8 6058.5 6097.7 6130.0 6138.8 964.7 992.0 997.4 1003.1 1024.5 22846.9 22882.3 23069.7 23111.8 23137.3 1090.7 1091.0 1095.8 1105.6 1108.7 11987.0 12040.3 12095.5 12211.7 12308.2 234034.0 235769.0 235962.0 236087.0 238150.0 46087.0 47243.0 54174.2 54236.2 54430.5 1434.6 1443.1 1445.6 1450.6 1463.3 27288.6 27407.7 27577.9 28040.6 28125.7 34364.0 34440.5 34462.5 34544.7 34610.3 185068.0 185981.0 186077.1 186432.0 187516.0 35703.8 35762.3 35786.8 35833.0 35885.8 44752.6 48473.5 48920.0 49227.5 49872.8 34733.8 35238.6 35363.8 35673.8 35723.8 34710.7 35167.5 35447.5 35582.6 36188.0 39085.0 39114.6 39471.8 39819.4 39915.4 33943.3 34100.3 34597.8 34832.7 35148.6 22599.4 23376.9 23797.0 23805.8 23985.0 20:25:39 INFO - PID 4359 | 20:25:39 INFO - PID 4359 | [#2] jquery.html Cycles:180 Average:35195.32 Median:23666.97 stddev:80421.95 (339.8%) stddev-sans-first:80605.49 20:25:39 INFO - PID 4359 | Values: 551.5 570.4 573.3 578.2 595.5 21766.8 22428.9 22604.0 22658.5 22661.3 24208.9 26160.5 26294.3 26324.9 26354.6 7028.5 7203.7 7209.7 7215.8 7216.6 6338.0 7060.4 7113.9 7121.4 7121.8 6968.8 6978.9 6982.2 6989.1 6992.0 6980.4 6983.0 6989.5 6996.8 6998.5 6737.9 6790.0 6843.5 6858.8 6885.0 29211.3 31718.5 31883.4 32524.8 32646.7 1918.1 1965.9 1966.6 1973.5 1974.9 20898.2 21061.3 21084.2 21106.3 21207.7 2491.5 2523.5 2570.9 2595.4 2616.8 137446.0 140305.0 140755.3 140816.0 140875.3 20307.5 21306.0 21390.6 21415.4 22393.3 22482.2 23651.3 23682.6 23688.6 43294.4 9455.3 9480.7 9509.5 9709.6 9755.9 8677.3 8711.0 8766.5 8793.8 8898.8 8927.7 9130.0 9250.4 9393.2 9477.4 2646.4 2698.9 2723.9 2755.2 2787.1 964.2 967.3 969.2 970.8 1009.5 19641.9 19797.9 20381.6 22936.5 24474.6 984.5 1030.7 1035.3 1037.4 1044.6 11243.7 11274.0 11377.3 11399.8 11461.7 464536.0 467397.0 472176.0 480080.0 492623.0 115010.4 115533.0 119468.0 119800.4 120088.4 1219.5 1237.9 1275.8 1283.6 1289.9 20260.4 20276.3 20511.5 20564.1 20927.0 57547.7 58707.0 58908.0 59484.4 59550.0 72873.0 72917.6 73291.6 73451.3 73590.0 14421.3 14556.9 14680.4 14740.4 14938.9 22836.0 23020.0 23118.7 23120.4 23224.8 18290.5 18372.6 18419.4 18521.7 18559.8 15975.1 16329.8 16972.7 17471.5 17499.7 18945.7 19159.4 19185.3 19374.0 19387.6 13923.2 14490.1 14607.2 14719.9 14793.9 18111.5 18143.5 18255.8 18343.9 18531.6 20:25:39 INFO - PID 4359 | 20:25:39 INFO - PID 4359 | [#3] mootools.html Cycles:180 Average:8563.28 Median:2546.24 stddev:5762.69 (226.3%) stddev-sans-first:5753.40 20:25:39 INFO - PID 4359 | Values: 1355.0 1399.7 1415.9 1416.8 1427.9 13377.7 13587.5 13792.1 13851.0 13893.7 13993.1 14230.6 14237.1 14258.9 14288.8 2607.8 2651.2 2655.1 2656.4 2658.9 2475.7 2527.4 2613.9 2618.6 2673.9 2607.8 2644.7 2664.9 2665.4 2669.9 2530.7 2570.3 2584.9 2595.0 2597.2 2505.2 2532.1 2536.5 2542.0 2550.5 13255.8 13644.8 13679.8 13826.0 13845.2 7345.6 7585.7 7615.4 7672.3 7694.2 4970.2 5048.2 5137.3 5184.6 5216.4 1849.4 1858.3 1864.1 1898.3 1900.3 21682.8 21929.2 21930.2 21948.0 21961.6 6338.7 6426.1 6534.8 6570.4 6630.1 15706.9 15833.0 15889.1 15912.1 15922.8 7398.3 7528.8 7544.5 7554.6 7555.0 6784.7 6792.8 6889.2 6999.4 7037.1 4946.5 5147.4 5203.0 5205.9 5214.2 1366.9 1410.5 1502.4 1525.2 1558.1 711.7 856.8 861.6 871.5 883.2 7904.0 7925.7 8141.2 8153.6 8203.9 968.4 973.7 979.2 992.4 1005.1 4663.1 4726.3 4815.3 5007.1 5156.3 17970.4 18433.7 18750.0 18919.0 18969.8 18453.4 18517.7 18537.1 18607.2 18608.4 9976.9 10833.7 10860.9 10863.3 10897.5 7602.6 7954.6 8081.3 8183.8 8327.3 16343.6 16950.7 17013.4 17062.1 17092.1 16741.0 16868.5 16915.7 17046.8 17142.7 11346.3 11502.8 11573.1 11577.0 11599.3 12630.8 12773.7 12867.9 12958.0 12963.1 9967.5 10300.9 10491.1 10509.8 10653.7 10576.7 10596.4 10601.8 10611.8 10617.6 8845.7 8924.5 8969.8 9009.5 9010.4 6909.3 6913.3 6920.8 6932.3 7010.6 6557.3 6777.8 6825.7 6860.1 6945.2 20:25:39 INFO - PID 4359 | 20:25:39 INFO - PID 4359 | [#4] prototype.html Cycles:180 Average:5492.75 Median:6132.15 stddev:1544.13 (25.2%) stddev-sans-first:1502.23 20:25:39 INFO - PID 4359 | Values: 496.5 497.2 512.3 519.9 525.7 6158.3 6299.7 6337.8 6344.7 6400.5 5927.4 6084.6 6160.9 6167.1 6180.6 4919.7 4987.9 4991.1 4991.6 4993.9 4811.4 4978.8 4987.8 4991.7 5012.9 4916.1 4931.7 4942.5 4975.5 4980.8 4938.3 4952.2 4969.9 4998.2 5004.2 4372.1 4429.9 4464.7 4465.9 4484.2 5962.7 6075.9 6116.8 6147.4 6156.2 5716.1 5733.2 5741.2 5743.7 5773.8 6493.7 6514.3 6540.6 6599.8 6631.1 4735.7 4794.1 4827.0 4835.2 4835.9 6798.4 6839.5 6909.7 6951.2 6955.9 4956.4 5018.9 5039.7 5045.5 5089.3 5013.3 5041.0 5048.3 5097.1 5104.5 5667.7 5684.9 5691.7 5742.7 5764.5 6495.9 6597.4 6601.6 6664.4 6695.0 1630.7 1669.7 1684.2 1737.5 1781.2 1195.6 1218.7 1223.4 1232.8 1237.4 5631.8 5680.4 5751.3 5759.2 5778.6 6595.0 6604.8 6607.2 6706.8 6711.3 5641.1 5688.5 5740.3 5760.0 5760.8 3529.8 3562.8 3570.9 3588.7 3602.7 6484.4 6510.3 6546.1 6548.1 6575.5 6737.6 6806.8 6839.6 6850.9 6879.3 6422.4 6470.6 6494.2 6511.3 6529.2 6670.7 6701.4 6731.8 6747.9 6765.2 6474.1 6595.2 6617.2 6645.9 6655.8 6494.7 6496.0 6551.7 6553.3 6570.3 4912.9 4946.6 4955.3 4974.4 5007.7 6724.5 6756.5 6777.5 6784.7 6793.0 6388.2 6408.9 6437.5 6444.5 6466.3 6359.2 6381.3 6414.3 6418.8 6427.8 5966.7 6310.7 6407.1 6482.5 6488.3 6433.8 6501.1 6514.7 6531.4 6534.8 6225.8 6346.0 6374.6 6413.6 6429.1 20:25:39 INFO - PID 4359 | 20:25:39 INFO - PID 4359 | [#5] yui.html Cycles:180 Average:24064.22 Median:20321.69 stddev:32790.19 (161.4%) stddev-sans-first:32836.05 20:25:39 INFO - PID 4359 | Values: 902.8 923.5 924.4 926.2 939.4 17093.9 17593.1 17613.0 17709.8 19059.7 20915.4 21367.1 21612.6 21654.0 21656.4 1035.8 1054.8 1059.9 1063.3 1065.3 947.1 1048.9 1052.7 1058.4 1058.7 1093.2 1103.4 1107.4 1107.7 1109.0 1081.3 1086.8 1089.2 1094.7 1095.2 798.3 803.5 807.7 808.0 808.7 19573.0 20227.8 20415.6 20437.0 20454.9 20755.3 21348.8 21412.4 21557.0 21818.0 16515.4 16806.7 17054.8 17064.3 17381.6 3587.7 3602.4 3610.5 3622.0 3623.8 129097.0 130772.0 133730.3 134437.0 135652.0 16974.7 17120.7 17141.2 17582.1 17607.6 31371.8 31587.2 31715.0 31846.4 32235.7 7140.3 7481.9 7554.9 8781.7 8969.5 3774.3 4130.6 4135.0 4158.5 4174.4 4957.3 4992.8 5018.6 5076.2 5121.6 1093.7 1099.5 1106.9 1113.0 1115.8 678.4 680.9 697.5 700.5 703.3 11243.9 11999.0 12192.5 12655.9 12974.9 677.2 690.7 699.7 705.6 707.0 5134.9 5139.7 5227.9 5320.8 5389.7 105231.5 108923.5 111101.4 111239.4 113596.4 95309.1 97154.0 97684.0 98370.0 101681.0 81715.6 84214.0 85974.0 86640.0 89458.6 9894.2 12120.0 13328.7 13427.5 13526.1 37280.6 39480.8 39676.8 40011.2 40104.0 69714.3 71299.0 71953.0 73581.3 74377.6 19297.5 19355.2 19516.6 19776.0 20136.6 20775.2 21262.4 21523.4 21956.6 22088.4 17074.2 17377.4 17673.0 18104.4 18153.7 17140.7 17388.7 18835.9 18893.1 18999.1 17290.1 17621.6 17742.6 17791.4 18143.7 13480.7 14021.6 14167.8 14433.6 14689.3 13426.9 13454.9 13519.3 13546.3 13548.2 20:25:39 INFO - PID 4359 | -------- Summary: end -------- 20:25:39 INFO - PID 4359 | 20:25:40 INFO - TEST-INFO | 4359: exit 0 20:25:40 INFO - TEST-OK | dromaeo_css | took 1116634ms 20:25:40 INFO - TEST-START | kraken 20:25:40 INFO - Initialising browser for kraken test... 20:25:41 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:40103/getInfo.html -profile /tmp/tmpKhOyb7/profile 20:25:41 INFO - TEST-INFO | started process 4742 (/builds/slave/test/build/application/firefox/firefox http://localhost:40103/getInfo.html) 20:25:47 INFO - TEST-INFO | 4742: exit 0 20:25:47 INFO - Browser initialized. 20:25:47 INFO - Running cycle 1/1 for kraken test... 20:25:47 INFO - TEST-INFO | started process 4926 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpKhOyb7/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 20:25:48 INFO - PID 4926 | WebRender - OpenGL version new 3.2.0 NVIDIA 361.42 20:25:48 INFO - PID 4926 | WebRender - OpenGL version new 3.2.0 NVIDIA 361.42 20:25:48 INFO - PID 4926 | 20:25:48 INFO - PID 4926 | (/builds/slave/test/build/application/firefox/firefox:4983): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 20:25:48 INFO - PID 4926 | 20:25:59 INFO - PID 4926 | RSS: Main: 195100672 20:25:59 INFO - PID 4926 | 20:26:02 INFO - PID 4926 | Cycle 1(1): loaded http://localhost:40103/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:40103/tests/kraken/driver.html?testName=audio-beat-detection) 20:26:02 INFO - PID 4926 | RSS: Main: 205955072 20:26:02 INFO - PID 4926 | 20:26:03 INFO - PID 4926 | WebRender - OpenGL version new 3.2.0 NVIDIA 361.42 20:26:05 INFO - PID 4926 | Cycle 1(1): loaded http://localhost:40103/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:40103/tests/kraken/driver.html?testName=audio-dft) 20:26:06 INFO - PID 4926 | RSS: Main: 210792448 20:26:06 INFO - PID 4926 | 20:26:09 INFO - PID 4926 | Cycle 1(1): loaded http://localhost:40103/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:40103/tests/kraken/driver.html?testName=audio-fft) 20:26:10 INFO - PID 4926 | RSS: Main: 204488704 20:26:10 INFO - PID 4926 | 20:26:12 INFO - PID 4926 | Cycle 1(1): loaded http://localhost:40103/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:40103/tests/kraken/driver.html?testName=audio-oscillator) 20:26:12 INFO - PID 4926 | RSS: Main: 206073856 20:26:12 INFO - PID 4926 | 20:26:15 INFO - PID 4926 | Cycle 1(1): loaded http://localhost:40103/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:40103/tests/kraken/driver.html?testName=imaging-gaussian-blur) 20:26:15 INFO - PID 4926 | RSS: Main: 206417920 20:26:15 INFO - PID 4926 | 20:26:18 INFO - PID 4926 | Cycle 1(1): loaded http://localhost:40103/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:40103/tests/kraken/driver.html?testName=imaging-darkroom) 20:26:19 INFO - PID 4926 | RSS: Main: 219848704 20:26:19 INFO - PID 4926 | 20:26:22 INFO - PID 4926 | Cycle 1(1): loaded http://localhost:40103/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:40103/tests/kraken/driver.html?testName=imaging-desaturate) 20:26:23 INFO - PID 4926 | RSS: Main: 218431488 20:26:23 INFO - PID 4926 | 20:26:26 INFO - PID 4926 | Cycle 1(1): loaded http://localhost:40103/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:40103/tests/kraken/driver.html?testName=json-parse-financial) 20:26:27 INFO - PID 4926 | RSS: Main: 220692480 20:26:27 INFO - PID 4926 | 20:26:28 INFO - PID 4926 | Cycle 1(1): loaded http://localhost:40103/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:40103/tests/kraken/driver.html?testName=json-stringify-tinderbox) 20:26:29 INFO - PID 4926 | RSS: Main: 220286976 20:26:29 INFO - PID 4926 | 20:26:31 INFO - PID 4926 | Cycle 1(1): loaded http://localhost:40103/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:40103/tests/kraken/driver.html?testName=stanford-crypto-aes) 20:26:31 INFO - PID 4926 | RSS: Main: 220766208 20:26:31 INFO - PID 4926 | 20:26:34 INFO - PID 4926 | Cycle 1(1): loaded http://localhost:40103/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:40103/tests/kraken/driver.html?testName=stanford-crypto-ccm) 20:26:34 INFO - PID 4926 | RSS: Main: 220459008 20:26:34 INFO - PID 4926 | 20:26:37 INFO - PID 4926 | Cycle 1(1): loaded http://localhost:40103/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:40103/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 20:26:38 INFO - PID 4926 | RSS: Main: 220999680 20:26:38 INFO - PID 4926 | 20:26:41 INFO - PID 4926 | Cycle 1(1): loaded http://localhost:40103/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:40103/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 20:26:41 INFO - PID 4926 | RSS: Main: 220667904 20:26:42 INFO - PID 4926 | 20:26:43 INFO - PID 4926 | Cycle 1(1): loaded http://localhost:40103/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:40103/tests/kraken/driver.html?testName=ai-astar) 20:26:44 INFO - PID 4926 | RSS: Main: 221888512 20:26:44 INFO - PID 4926 | 20:26:44 INFO - PID 4926 | __start_tp_report 20:26:44 INFO - PID 4926 | _x_x_mozilla_page_load 20:26:44 INFO - PID 4926 | _x_x_mozilla_page_load_details 20:26:44 INFO - PID 4926 | |i|pagename|runs| 20:26:44 INFO - PID 4926 | |0;ai-astar;103;110;97;113;110;117;110;109;114;115 20:26:44 INFO - PID 4926 | |1;audio-beat-detection;150;133;144;175;126;145;146;119;178;134 20:26:44 INFO - PID 4926 | |2;audio-dft;170;172;163;168;176;170;162;165;173;165 20:26:44 INFO - PID 4926 | |3;audio-fft;79;76;82;168;75;78;74;95;106;78 20:26:44 INFO - PID 4926 | |4;audio-oscillator;83;80;145;82;79;85;146;86;79;129 20:26:44 INFO - PID 4926 | |5;imaging-gaussian-blur;119;117;114;115;115;115;114;118;115;116 20:26:44 INFO - PID 4926 | |6;imaging-darkroom;150;150;154;153;151;152;153;159;153;154 20:26:44 INFO - PID 4926 | |7;imaging-desaturate;95;95;100;95;95;97;96;95;95;95 20:26:44 INFO - PID 4926 | |8;json-parse-financial;54;60;55;53;53;64;53;54;55;55 20:26:44 INFO - PID 4926 | |9;json-stringify-tinderbox;57;57;55;60;62;55;56;60;55;62 20:26:44 INFO - PID 4926 | |10;stanford-crypto-aes;78;80;81;80;81;91;83;79;80;93 20:26:44 INFO - PID 4926 | |11;stanford-crypto-ccm;138;142;132;137;127;129;129;150;138;173 20:26:44 INFO - PID 4926 | |12;stanford-crypto-pbkdf2;187;185;179;177;181;186;189;176;178;183 20:26:44 INFO - PID 4926 | |13;stanford-crypto-sha256-iterative;76;69;76;66;71;70;70;70;68;69 20:26:44 INFO - PID 4926 | __end_tp_report 20:26:44 INFO - PID 4926 | __start_cc_report 20:26:44 INFO - PID 4926 | _x_x_mozilla_cycle_collect,986 20:26:44 INFO - PID 4926 | __end_cc_report 20:26:44 INFO - PID 4926 | __startTimestamp1502854004081__endTimestamp 20:26:44 INFO - PID 4926 | 20:26:44 INFO - PID 4926 | ------- Summary: start ------- 20:26:44 INFO - PID 4926 | Number of tests: 14 20:26:44 INFO - PID 4926 | 20:26:44 INFO - PID 4926 | [#0] ai-astar Cycles:10 Average:109.80 Median:113.50 stddev:5.94 (5.2%) stddev-sans-first:5.77 20:26:44 INFO - PID 4926 | Values: 103.0 110.0 97.0 113.0 110.0 117.0 110.0 109.0 114.0 115.0 20:26:44 INFO - PID 4926 | 20:26:44 INFO - PID 4926 | [#1] audio-beat-detection Cycles:10 Average:145.00 Median:145.50 stddev:19.20 (13.2%) stddev-sans-first:20.28 20:26:44 INFO - PID 4926 | Values: 150.0 133.0 144.0 175.0 126.0 145.0 146.0 119.0 178.0 134.0 20:26:44 INFO - PID 4926 | 20:26:44 INFO - PID 4926 | [#2] audio-dft Cycles:10 Average:168.40 Median:170.00 stddev:4.60 (2.7%) stddev-sans-first:4.84 20:26:44 INFO - PID 4926 | Values: 170.0 172.0 163.0 168.0 176.0 170.0 162.0 165.0 173.0 165.0 20:26:44 INFO - PID 4926 | 20:26:44 INFO - PID 4926 | [#3] audio-fft Cycles:10 Average:91.10 Median:78.00 stddev:28.87 (37.0%) stddev-sans-first:30.29 20:26:44 INFO - PID 4926 | Values: 79.0 76.0 82.0 168.0 75.0 78.0 74.0 95.0 106.0 78.0 20:26:44 INFO - PID 4926 | 20:26:44 INFO - PID 4926 | [#4] audio-oscillator Cycles:10 Average:99.40 Median:81.00 stddev:28.47 (35.1%) stddev-sans-first:29.57 20:26:44 INFO - PID 4926 | Values: 83.0 80.0 145.0 82.0 79.0 85.0 146.0 86.0 79.0 129.0 20:26:44 INFO - PID 4926 | 20:26:44 INFO - PID 4926 | [#5] imaging-gaussian-blur Cycles:10 Average:115.80 Median:115.50 stddev:1.69 (1.5%) stddev-sans-first:1.33 20:26:44 INFO - PID 4926 | Values: 119.0 117.0 114.0 115.0 115.0 115.0 114.0 118.0 115.0 116.0 20:26:44 INFO - PID 4926 | 20:26:44 INFO - PID 4926 | [#6] imaging-darkroom Cycles:10 Average:152.90 Median:153.00 stddev:2.60 (1.7%) stddev-sans-first:2.54 20:26:44 INFO - PID 4926 | Values: 150.0 150.0 154.0 153.0 151.0 152.0 153.0 159.0 153.0 154.0 20:26:44 INFO - PID 4926 | 20:26:44 INFO - PID 4926 | [#7] imaging-desaturate Cycles:10 Average:95.80 Median:95.00 stddev:1.62 (1.7%) stddev-sans-first:1.69 20:26:44 INFO - PID 4926 | Values: 95.0 95.0 100.0 95.0 95.0 97.0 96.0 95.0 95.0 95.0 20:26:44 INFO - PID 4926 | 20:26:44 INFO - PID 4926 | [#8] json-parse-financial Cycles:10 Average:55.60 Median:55.00 stddev:3.60 (6.5%) stddev-sans-first:3.77 20:26:44 INFO - PID 4926 | Values: 54.0 60.0 55.0 53.0 53.0 64.0 53.0 54.0 55.0 55.0 20:26:44 INFO - PID 4926 | 20:26:44 INFO - PID 4926 | [#9] json-stringify-tinderbox Cycles:10 Average:57.90 Median:58.50 stddev:2.85 (4.9%) stddev-sans-first:3.00 20:26:44 INFO - PID 4926 | Values: 57.0 57.0 55.0 60.0 62.0 55.0 56.0 60.0 55.0 62.0 20:26:44 INFO - PID 4926 | 20:26:44 INFO - PID 4926 | [#10] stanford-crypto-aes Cycles:10 Average:82.60 Median:81.00 stddev:5.15 (6.4%) stddev-sans-first:5.18 20:26:44 INFO - PID 4926 | Values: 78.0 80.0 81.0 80.0 81.0 91.0 83.0 79.0 80.0 93.0 20:26:44 INFO - PID 4926 | 20:26:44 INFO - PID 4926 | [#11] stanford-crypto-ccm Cycles:10 Average:139.50 Median:138.00 stddev:13.67 (9.9%) stddev-sans-first:14.49 20:26:44 INFO - PID 4926 | Values: 138.0 142.0 132.0 137.0 127.0 129.0 129.0 150.0 138.0 173.0 20:26:44 INFO - PID 4926 | 20:26:44 INFO - PID 4926 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:182.10 Median:184.00 stddev:4.56 (2.5%) stddev-sans-first:4.48 20:26:44 INFO - PID 4926 | Values: 187.0 185.0 179.0 177.0 181.0 186.0 189.0 176.0 178.0 183.0 20:26:44 INFO - PID 4926 | 20:26:44 INFO - PID 4926 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.50 Median:70.00 stddev:3.21 (4.6%) stddev-sans-first:2.71 20:26:44 INFO - PID 4926 | Values: 76.0 69.0 76.0 66.0 71.0 70.0 70.0 70.0 68.0 69.0 20:26:44 INFO - PID 4926 | -------- Summary: end -------- 20:26:44 INFO - PID 4926 | 20:26:44 INFO - PID 4926 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 20:26:45 INFO - TEST-INFO | 4926: exit 0 20:26:45 INFO - TEST-OK | kraken | took 64102ms 20:26:45 INFO - SUITE-END | took 1180s 20:26:45 INFO - Completed test suite (00:19:40) 20:26:45 INFO - javascript benchmark 20:26:45 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8535.47656550635, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3122.734567561757, 3125.7499400047986, 3146.1348129264456, 3149.3543823516184, 3162.9367412651745, 6173.660448675332, 6206.534509911752, 6210.9068363974575, 6237.844053898655, 6247.593906396087, 6023.969880150604, 6152.477039451652, 6177.722002509887, 6206.875862482759, 6212.565120441571, 5640.971795141018, 5654.943450565483, 5672.404397538261, 5677.801276955307, 5680.3467601225975, 5700.258966334371, 5702.344230413514, 5703.344115426717, 5706.115552089433, 5707.514861236779, 5674.460926212003, 5689.0, 5696.430356964291, 5703.686297253649, 5705.942940570603, 5653.8586535336535, 5657.2928383952, 5666.858328541799, 5685.175649530836, 5687.744051517671, 5560.582956278296, 5628.746706398222, 5642.097264437712, 5709.514691251248, 5791.739371728282, 5969.61197522164, 6017.638941663514, 6032.215811944419, 6084.39156084388, 6107.63354198745, 6588.077669126326, 6602.1087153234175, 6645.136132302818, 6673.065770792093, 6718.160229971254, 6657.201135863727, 6669.43309818666, 6676.465882729419, 6677.098591690108, 6711.664416779142, 6143.354947730513, 6169.81490555284, 6193.1020002099895, 6196.969015154896, 6217.720202590895, 6748.358905903931, 6750.628715420601, 6838.111045564145, 6852.177738671292, 6866.073080134118, 6323.0, 6409.487241020707, 6414.294427612959, 6473.417392434703, 6573.83565410859, 6553.901691474632, 6605.603663780189, 6618.073469714244, 6641.933580664131, 6676.79969600903, 6246.843828904313, 6583.506237032146, 6648.5678430901835, 6690.698918548677, 6729.966350168218, 6650.434713049445, 6653.73385064592, 6731.932680673131, 6751.189857217166, 6756.898646520306, 5322.414534401213, 5421.783128674888, 5423.376311724202, 5483.2049352844415, 5497.367802702661, 4588.49526552079, 4640.1879671058105, 4662.860114196579, 4665.86002419928, 4709.952900470951, 5690.459406356389, 5701.942980570224, 5704.71476426177, 5775.451332123442, 5795.0727883539275, 6671.166104236971, 6672.466202703772, 6675.46596272297, 6678.0, 6702.664866756642, 5745.798897038667, 5787.160861675034, 5823.330317013513, 5833.82498525045, 5838.474537291664, 5813.505852002627, 5821.214136091573, 5833.912491312633, 5904.439078287556, 5929.258842644669, 6409.359064093554, 6415.647139407284, 6423.261324947597, 6427.871442571122, 6432.099506069154, 6555.3772391622715, 6598.3401659833635, 6610.074589557562, 6613.10723052401, 6635.933640663725, 6315.5894866833505, 6315.873682526416, 6372.840678982877, 6390.48876089921, 6400.39196276353, 5568.582356323211, 6473.255575608865, 6495.74017039332, 6545.476361890942, 6599.8020059398295, 6583.670816459254, 6681.432078273207, 6721.227058888095, 6728.226253980855, 6729.596224226562, 6344.524160688059, 6403.519736019724, 6423.389777971085, 6465.062565928009, 6482.254540727877, 6495.837604059936, 6498.155239818793, 6507.251666058464, 6513.576617519846, 6514.9348506514325, 6357.650329231937, 6449.322821103717, 6461.547691661539, 6465.191851018622, 6476.190476190476, 6440.0983862260255, 6489.0, 6493.058506516623, 6493.740250389931, 6517.771877984248, 6062.818115456544, 6191.040388739752, 6291.559590828781, 6337.493000560036, 6379.585326953733], "value": 6047.748774382418, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [843.1694780641063, 851.4380508864151, 871.1419252036744, 899.622158693349, 901.2474583722591, 40077.3988390174, 41540.0, 41719.374209386886, 41751.582484175146, 41878.37182442262, 39585.60414395855, 39587.80206098973, 39741.80129099358, 39781.40327895084, 40010.0, 6942.826429339269, 7021.332973367547, 7028.508004439691, 7038.9296107039045, 7041.471889608274, 6928.688209030605, 6992.091028166356, 6992.230854605989, 7015.088038554981, 7064.717411303542, 7024.4029257513175, 7563.168051514329, 7746.264104910025, 7796.610169491531, 7798.337141342992, 7564.924350756477, 7659.502132361378, 7663.846723065535, 7679.385649148083, 7705.075390953121, 7541.849163016709, 7623.466357354987, 7643.656035478417, 7717.922820771777, 7724.188960159158, 39741.0, 39999.60000400017, 40054.198916021516, 40070.39894401586, 40207.0, 3527.5414196154593, 3580.9283814323826, 3588.802615856127, 3589.3718599245026, 3589.4436362363876, 32156.0, 32177.1955701107, 32369.838150809097, 32371.514427283608, 32521.6747832521, 5010.3737032870895, 5024.673396229234, 5046.44489106198, 5075.086484432801, 5079.0, 184739.0, 225815.0, 228668.0, 228828.0, 231602.0, 51556.484435155915, 51749.741251293504, 51760.22359664608, 51847.74076129595, 52100.73949630303, 55292.0, 56685.14972275419, 56696.14955775667, 56806.715966419906, 56813.43186568164, 16158.838411615734, 16292.34830606786, 16326.918365408335, 16352.427665031666, 16374.099424531527, 13325.66685832862, 13403.530876419278, 13407.061505694508, 13420.0, 13423.664408389868, 15176.544703658908, 15191.316390762222, 15304.846951530564, 15355.309011094527, 15464.613384665474, 5833.79581714638, 6058.545609079337, 6097.725602347905, 6130.049842274455, 6138.846528836725, 964.6816550538306, 991.9851202231972, 997.3915911294105, 1003.0922015575916, 1024.5082360467018, 22846.8857655714, 22882.31353059411, 23069.653955190686, 23111.844407779543, 23137.305880823267, 1090.7327704712395, 1090.9799337619193, 1095.8246680531076, 1105.5854054729477, 1108.667399780079, 11986.981106606036, 12040.337781422106, 12095.455704493319, 12211.69470763238, 12308.199967002116, 234034.0, 235769.0, 235962.0, 236087.0, 238150.0, 46087.0, 47243.0, 54174.187387189224, 54236.18645720317, 54430.455695442535, 1434.5552878607666, 1443.0620096936866, 1445.551878917539, 1450.572081236038, 1463.297617143777, 27288.59067113955, 27407.725922740516, 27577.86211069012, 28040.57939130874, 28125.71874281231, 34364.0, 34440.483392748625, 34462.48306275458, 34544.65455345515, 34610.307793844484, 185068.0, 185981.0, 186077.06961465106, 186432.0, 187516.0, 35703.82148089243, 35762.284754304244, 35786.8210658945, 35833.0, 35885.820570898024, 44752.55247447614, 48473.51526484831, 48920.0, 49227.50772492372, 49872.750636248034, 34733.826330868185, 35238.647613523535, 35363.823180883934, 35673.821630892715, 35723.82138089293, 34710.65289347074, 35167.47248791321, 35447.46828797622, 35582.64417355897, 36188.0, 39085.0, 39114.60885391109, 39471.802640986614, 39819.40270895881, 39915.40126898157, 33943.32113357769, 34100.317993640485, 34597.827010864785, 34832.65167348294, 35148.64851351556, 22599.435014124778, 23376.883115584315, 23797.048118075083, 23805.761942380355, 23985.04059837587], "value": 17554.84334328738, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [551.509156850403, 570.4096260370517, 573.2919843992669, 578.1558923971002, 595.5384576952861, 21766.782332176692, 22428.8878555607, 22604.0, 22658.54682906343, 22661.320160395193, 24208.87895560524, 26160.476790464178, 26294.342641433974, 26324.868375658094, 26354.604680929802, 7028.543144695604, 7203.747868824592, 7209.711611535558, 7215.783526494213, 7216.639168041604, 6337.968310158442, 7060.399866011395, 7113.89329160063, 7121.430285577141, 7121.78634640959, 6968.825779355506, 6978.895316570255, 6982.1621405431415, 6989.056477375566, 6992.0, 6980.441564674839, 6983.0, 6989.475789315821, 6996.755113571026, 6998.475114366392, 6737.898931516032, 6790.0, 6843.520953533254, 6858.794236172923, 6885.0, 29211.269718257, 31718.524222136686, 31883.362332753448, 32524.83737581297, 32646.67353326484, 1918.1272521002911, 1965.9115339809744, 1966.6165097805933, 1973.5362189885366, 1974.9111289991986, 20898.164073437045, 21061.262855799974, 21084.156633734634, 21106.26128085525, 21207.68188477174, 2491.451880586268, 2523.4574566468295, 2570.8586027768465, 2595.4030572968322, 2616.7775739062204, 137446.0, 140305.0, 140755.29622351823, 140816.0, 140875.29562352225, 20307.492312692004, 21306.04122814477, 21390.572188556143, 21415.357539273846, 22393.320500962494, 22482.21312254096, 23651.29046128619, 23682.64476032861, 23688.64467032996, 43294.35058474125, 9455.29085318604, 9480.668176613786, 9509.476978766234, 9709.6116155353, 9755.853662195073, 8677.349198810114, 8711.0417854036, 8766.517841518778, 8793.780155496035, 8898.822023559493, 8927.687530936517, 9130.0, 9250.444973301623, 9393.248540116774, 9477.431354118775, 2646.4442467082126, 2698.9325266868486, 2723.917347314389, 2755.1872197701728, 2787.0663327785014, 964.1659964131117, 967.3373738988815, 969.2343048991359, 970.7767213540925, 1009.5154325923597, 19641.901790491243, 19797.901010494854, 20381.592368152553, 22936.541269174522, 24474.632880506808, 984.5175863826817, 1030.7062487191115, 1035.2597892506894, 1037.3516552154904, 1044.5926088825365, 11243.66269011931, 11274.0, 11377.2604780689, 11399.829002564968, 11461.713457163638, 464536.0, 467397.0, 472176.0, 480080.0, 492623.0, 115010.42494787472, 115533.0, 119468.0, 119800.4009979962, 120088.3995580034, 1219.4634360881184, 1237.900967922564, 1275.7894947333587, 1283.6149155253386, 1289.9032572556907, 20260.392188234375, 20276.290329838386, 20511.4872128198, 20564.074616642585, 20927.0, 57547.71226143843, 58707.0, 58908.0, 59484.405155949615, 59550.0, 72873.0, 72917.6354118226, 73291.63354183195, 73451.26548734658, 73590.0, 14421.278936052946, 14556.927215363856, 14680.41278348854, 14740.410383584536, 14938.850611493746, 22836.0, 23020.0, 23118.653220202046, 23120.4219894504, 23224.767752322936, 18290.451286461426, 18372.632547349247, 18419.447416577525, 18521.722174167127, 18559.81440185581, 15975.121368324853, 16329.836701632832, 16972.66054678924, 17471.475855724348, 17499.7375039372, 18945.673802834222, 19159.425217243504, 19185.32851350196, 19374.0, 19387.61224775525, 13923.23422211788, 14490.130592164503, 14607.19660418687, 14719.92640036793, 14793.852061479247, 18111.45665630033, 18143.546411339295, 18255.817441825944, 18343.908280458512, 18531.629367412846], "value": 12443.489822983192, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1354.9796753048704, 1399.7270532246216, 1415.851335609761, 1416.815813944187, 1427.9286035698215, 13377.732445351086, 13587.524436644719, 13792.103513271642, 13851.030427870053, 13893.652658683537, 13993.0904491208, 14230.644233894158, 14237.074590151633, 14258.928705356484, 14288.785668214985, 2607.804414668898, 2651.151631477928, 2655.0972669292437, 2656.402309480361, 2658.8936442542276, 2475.6905386826647, 2527.4060595759984, 2613.89544418223, 2618.55484567623, 2673.9197824065213, 2607.7783388411913, 2644.7487488688544, 2664.853433061181, 2665.3869609989715, 2669.8665066746585, 2530.72162062173, 2570.2546261584116, 2584.9224523264334, 2594.9610755838676, 2597.194869590433, 2505.2233807519547, 2532.1011041080337, 2536.4546622476073, 2542.008616639512, 2550.477152183798, 13255.801162982563, 13644.795328070088, 13679.794803077963, 13826.032177747562, 13845.16928984264, 7345.55926644403, 7585.734499292498, 7615.390768738488, 7672.3478504327195, 7694.230576942261, 4970.229614409773, 5048.242763585455, 5137.255098010804, 5184.637075404723, 5216.382921294411, 1849.3989453427555, 1858.3310008396966, 1864.14249445254, 1898.3355825461117, 1900.2683966672791, 21682.78317216839, 21929.23247686323, 21930.232441864457, 21947.99999999984, 21961.560768784693, 6338.683065846689, 6426.100345951477, 6534.803955881332, 6570.441512471493, 6630.138082049302, 15706.9214653926, 15833.0, 15889.126098064717, 15912.124833134289, 15922.840771592368, 7398.260173982666, 7528.757754970368, 7544.509606875646, 7554.622268886534, 7555.0, 6784.660766961632, 6792.796216113525, 6889.173299204128, 6999.37005669482, 7037.120359955005, 4946.455889852114, 5147.433782283946, 5203.048856678745, 5205.947940520622, 5214.191800270964, 1366.863313668645, 1410.5274732964367, 1502.3990403838552, 1525.2450037231642, 1558.1274486287716, 711.654847399011, 856.7515420527977, 861.5950503263456, 871.4858233642182, 883.1565854608833, 7903.960480197562, 7925.682972681028, 8141.22658347456, 8153.633086511121, 8203.917960820434, 968.4334664221368, 973.7078876337213, 979.2410881566842, 992.3500107429645, 1005.0954141272913, 4663.137319595886, 4726.26742854858, 4815.3258543803895, 5007.098722230034, 5156.252343410185, 17970.371037013643, 18433.723494147598, 18750.0, 18919.0, 18969.81030189708, 18453.446396608124, 18517.722234166496, 18537.073146342627, 18607.16267767954, 18608.44174674762, 9976.850347244797, 10833.67498975032, 10860.891391085988, 10863.293885897392, 10897.509612067475, 7602.6198690066385, 7954.5624990626075, 8081.272685458337, 8183.83632327362, 8327.333813294801, 16343.59141021484, 16950.66098677995, 17013.404530841362, 17062.06158661236, 17092.145392730064, 16741.0, 16868.493945181664, 16915.66168676595, 17046.829531704523, 17142.65714685674, 11346.262492938264, 11502.769944601228, 11573.132015098732, 11577.0, 11599.304041757521, 12630.810537841757, 12773.744525109632, 12867.935660321638, 12958.028147889134, 12963.092583519441, 9967.50162491858, 10300.948495257475, 10491.108255798343, 10509.842352364874, 10653.680389588324, 10576.735581610214, 10596.417197054236, 10601.840972385266, 10611.787764244826, 10617.575296988034, 8845.734627961172, 8924.464532127833, 8969.820603587761, 9009.459432434074, 9010.369274150746, 6909.30906909305, 6913.274106218976, 6920.792376228721, 6932.341427564374, 7010.649467526501, 6557.344265573404, 6777.830554236183, 6825.726970921108, 6860.108185935996, 6945.20130185015], "value": 6280.913911979757, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [496.4985364781572, 497.24910529152686, 512.262342227193, 519.9168133098702, 525.7266221564787, 6158.322584515705, 6299.748010079597, 6337.809865704025, 6344.7462101515885, 6400.455961243294, 5927.436893495111, 6084.574079814415, 6160.876782464348, 6167.105769663396, 6180.629162250269, 4919.72941488218, 4987.875303117415, 4991.1016017117, 4991.627302491807, 4993.850184494471, 4811.353755434497, 4978.825741099062, 4987.802927297441, 4991.72710958705, 5012.8997420051755, 4916.139675556763, 4931.679440836352, 4942.5304596063315, 4975.502449755032, 4980.800767969295, 4938.259261110844, 4952.232403977389, 4969.900601987958, 4998.2002879539095, 5004.249362595603, 4372.1255748850035, 4429.9114017719785, 4464.660601819473, 4465.910681786346, 4484.170428470743, 5962.731677074542, 6075.939240607626, 6116.847078823021, 6147.44672979434, 6156.168917196211, 5716.113362751784, 5733.226014488033, 5741.167530708066, 5743.741531631086, 5773.826785196451, 6493.675316234217, 6514.348565143495, 6540.574862633961, 6599.8020059398295, 6631.1379520662, 4735.715857048588, 4794.137055330039, 4827.0, 4835.226363781778, 4835.9032819343765, 6798.388145066968, 6839.529501157225, 6909.654517274116, 6951.16586009677, 6955.930440695579, 4956.430010548761, 5018.924716129261, 5039.672421292605, 5045.470225626256, 5089.262057001714, 5013.273075404046, 5040.983606557406, 5048.3184770056305, 5097.133487307166, 5104.464031276662, 5667.659940403589, 5684.8863022739315, 5691.68695721731, 5742.655440673573, 5764.510016648548, 6495.921305182391, 6597.373249541286, 6601.603903765789, 6664.400203981568, 6695.0, 1630.6657135287237, 1669.6577201673629, 1684.1831711619855, 1737.5482374582448, 1781.1628534588722, 1195.623378635727, 1218.713602303458, 1223.427895154722, 1232.8397308349856, 1237.3543187560704, 5631.7747290108755, 5680.4319568042865, 5751.309842818805, 5759.178002778608, 5778.624389414675, 6594.9670251649395, 6604.811133995927, 6607.174103237096, 6706.798796036127, 6711.328867113347, 5641.069223578063, 5688.544916406678, 5740.311162660508, 5759.971200143972, 5760.8271751847515, 3529.7705649133236, 3562.786232826039, 3570.910727231788, 3588.721162062109, 3602.6937710294396, 6484.448821850196, 6510.25132109804, 6546.0835483032415, 6548.148740663683, 6575.473962083021, 6737.629430381278, 6806.76176333826, 6839.555428897106, 6850.862982740317, 6879.3120687931805, 6422.357764223634, 6470.579412338183, 6494.220693516808, 6511.2512061113575, 6529.151210342625, 6670.733170673313, 6701.396874281338, 6731.764388246388, 6747.852865013057, 6765.221999470124, 6474.0866610026615, 6595.208574971034, 6617.172853393326, 6645.867082658417, 6655.767048153291, 6494.675266236574, 6495.967520162369, 6551.672416379257, 6553.279139294578, 6570.277269500447, 4912.8771780705765, 4946.62900282473, 4955.306257124078, 4974.403071631283, 5007.724575148256, 6724.495662825406, 6756.493263005196, 6777.457803375817, 6784.728610855511, 6792.966035169792, 6388.233411990405, 6408.935910640834, 6437.485001199986, 6444.516661250331, 6466.288708242184, 6359.236891573041, 6381.319845664739, 6414.294427612866, 6418.775342862978, 6427.807165785034, 5966.70166491665, 6310.684465776784, 6407.1488187756, 6482.546221764431, 6488.286288508166, 6433.806985790434, 6501.05734668461, 6514.674266286762, 6531.379518945692, 6534.8366290843105, 6225.750969961151, 6346.01636746305, 6374.6175229484525, 6413.551051426355, 6429.099926010455], "value": 5036.630606208466, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [902.7743064233938, 923.5243849417551, 924.440713368412, 926.2219735422244, 939.4128669581513, 17093.914530427344, 17593.12034398278, 17613.0, 17709.82290177098, 19059.714104288447, 20915.37253882382, 21367.14531418745, 21612.56774864502, 21654.0255688494, 21656.35030949074, 1035.823909935311, 1054.7626783973622, 1059.9470026498682, 1063.2929102147064, 1065.3022270412853, 947.1002547579792, 1048.8741351037886, 1052.6789329254575, 1058.3967138730927, 1058.7141471802609, 1093.2347356850196, 1103.365564800239, 1107.4352080438953, 1107.6621630402724, 1108.983365249522, 1081.32957566309, 1086.788076325117, 1089.2320913755784, 1094.7482079121808, 1095.1512577752226, 798.253632853284, 803.5018288661009, 807.7172989453703, 808.0465051239535, 808.6684459371629, 19573.0, 20227.797722022886, 20415.591688166303, 20437.0, 20454.897725511277, 20755.273565425137, 21348.786512134837, 21412.357629271148, 21557.0, 21818.0, 16515.421960231335, 16806.747898781527, 17054.829451705573, 17064.317427302893, 17381.565460863454, 3587.712982961357, 3602.441621548664, 3610.4584312353095, 3622.040159357772, 3623.836927338276, 129097.0, 130772.0, 133730.33134834265, 134437.0, 135652.0, 16974.745378819327, 17120.74318885218, 17141.228644711016, 17582.120893955253, 17607.559811004572, 31371.843140784607, 31587.21031974219, 31715.0, 31846.363072738877, 32235.67764322327, 7140.321669441395, 7481.8877716834295, 7554.924450755532, 8781.69264075767, 8969.461832289953, 3774.2640185164178, 4130.607592278729, 4135.048938744106, 4158.459400278005, 4174.3947127666315, 4957.330760347307, 4992.775325110379, 5018.648694591344, 5076.18780995039, 5121.615878809104, 1093.6828319787173, 1099.5381939585393, 1106.856108705863, 1113.0316624536704, 1115.81031224692, 678.35217367414, 680.904673345732, 697.5082566790502, 700.5061431690646, 703.3177817517001, 11243.887561124448, 11999.0, 12192.512299508098, 12655.873441265654, 12974.935125324313, 677.1873751498222, 690.6684791300204, 699.7236091743732, 705.6013352455949, 707.049019069351, 5134.87162820925, 5139.665921715076, 5227.947720522746, 5320.760565774472, 5389.676619402849, 105231.4738426303, 108923.45538272258, 111101.44449277702, 111239.44380278209, 113596.43201783938, 95309.09381812325, 97154.0, 97684.0, 98370.0, 101681.0, 81715.5914220425, 84214.0, 85974.0, 86640.0, 89458.55270723604, 9894.20846332306, 12120.0, 13328.666783330495, 13427.462901483832, 13526.053176277566, 37280.62719372771, 39480.80259598799, 39676.80161599174, 40011.199776003734, 40103.99480025929, 69714.30285697078, 71299.0, 71953.0, 73581.26418735745, 74377.6281118591, 19297.5175620605, 19355.225790968205, 19516.60966780685, 19776.0, 20136.59726805485, 20775.168993240102, 21262.362129136152, 21523.354299371043, 21956.560868782854, 22088.44778880541, 17074.2316595751, 17377.39179128775, 17673.0, 18104.366347177787, 18153.727694084864, 17140.742888856927, 17388.739168912223, 18835.90582047136, 18893.055347232308, 18999.050047497294, 17290.13549322554, 17621.647567048843, 17742.556436089202, 17791.377301794375, 18143.727844082612, 13480.730385392433, 14021.579352619437, 14167.760932712717, 14433.639159021108, 14689.265536722907, 13426.932865335611, 13454.865451345362, 13519.256440895846, 13546.254955977516, 13548.187108773505], "value": 9252.143010995678, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1566.3999999999999, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [103.0, 110.0, 97.0, 113.0, 110.0, 117.0, 110.0, 109.0, 114.0, 115.0], "value": 109.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 133.0, 144.0, 175.0, 126.0, 145.0, 146.0, 119.0, 178.0, 134.0], "value": 145.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [170.0, 172.0, 163.0, 168.0, 176.0, 170.0, 162.0, 165.0, 173.0, 165.0], "value": 168.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 76.0, 82.0, 168.0, 75.0, 78.0, 74.0, 95.0, 106.0, 78.0], "value": 91.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 80.0, 145.0, 82.0, 79.0, 85.0, 146.0, 86.0, 79.0, 129.0], "value": 99.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [119.0, 117.0, 114.0, 115.0, 115.0, 115.0, 114.0, 118.0, 115.0, 116.0], "value": 115.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 150.0, 154.0, 153.0, 151.0, 152.0, 153.0, 159.0, 153.0, 154.0], "value": 152.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 100.0, 95.0, 95.0, 97.0, 96.0, 95.0, 95.0, 95.0], "value": 95.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 60.0, 55.0, 53.0, 53.0, 64.0, 53.0, 54.0, 55.0, 55.0], "value": 55.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 57.0, 55.0, 60.0, 62.0, 55.0, 56.0, 60.0, 55.0, 62.0], "value": 57.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 80.0, 81.0, 80.0, 81.0, 91.0, 83.0, 79.0, 80.0, 93.0], "value": 82.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [138.0, 142.0, 132.0, 137.0, 127.0, 129.0, 129.0, 150.0, 138.0, 173.0], "value": 139.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [187.0, 185.0, 179.0, 177.0, 181.0, 186.0, 189.0, 176.0, 178.0, 183.0], "value": 182.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 69.0, 76.0, 66.0, 71.0, 70.0, 70.0, 70.0, 68.0, 69.0], "value": 70.5, "unit": "score"}]}]} 20:26:45 INFO - Return code: 0 20:26:45 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 20:26:45 INFO - # TBPL SUCCESS # 20:26:45 INFO - Running post-action listener: _package_coverage_data 20:26:45 INFO - Running post-action listener: _resource_record_post_action 20:26:45 INFO - [mozharness: 2017-08-16 03:26:45.360393Z] Finished run-tests step (success) 20:26:45 INFO - Running post-run listener: _resource_record_post_run 20:26:45 INFO - Total resource usage - Wall time: 1199s; CPU: 13.0%; Read bytes: 4055040; Write bytes: 443359232; Read time: 1172; Write time: 349008 20:26:45 INFO - TinderboxPrint: CPU usage
13.3% 20:26:45 INFO - TinderboxPrint: I/O read bytes / time
4,055,040 / 1,172 20:26:45 INFO - TinderboxPrint: I/O write bytes / time
443,359,232 / 349,008 20:26:45 INFO - TinderboxPrint: CPU idle
8,283.9 (86.7%) 20:26:45 INFO - TinderboxPrint: CPU user
1,207.8 (12.6%) 20:26:45 INFO - TinderboxPrint: Swap in / out
0 / 0 20:26:45 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 119762944; Read time: 0; Write time: 87940 20:26:45 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 20:26:45 INFO - run-tests - Wall time: 1181s; CPU: 13.0%; Read bytes: 4050944; Write bytes: 323153920; Read time: 1164; Write time: 261020 20:26:45 INFO - Running post-run listener: _upload_blobber_files 20:26:45 INFO - Blob upload gear active. 20:26:45 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 20:26:45 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:26:45 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:26:45 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:26:46 INFO - (blobuploader) - INFO - Open directory for files ... 20:26:46 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 20:26:46 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:26:46 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:26:53 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 20:26:53 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:26:53 INFO - (blobuploader) - INFO - Done attempting. 20:26:53 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 20:26:53 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:26:53 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:26:54 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 20:26:54 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:26:54 INFO - (blobuploader) - INFO - Done attempting. 20:26:54 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 20:26:54 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:26:54 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:26:55 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 20:26:55 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:26:55 INFO - (blobuploader) - INFO - Done attempting. 20:26:55 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 20:26:55 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:26:55 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:26:55 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 20:26:55 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:26:55 INFO - (blobuploader) - INFO - Done attempting. 20:26:55 INFO - (blobuploader) - INFO - Iteration through files over. 20:26:55 INFO - Return code: 0 20:26:55 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 20:26:55 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 20:26:55 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e7969619468ea3eb6bbafa5de0849c714012f9050917dffd139d82378e193cee6d7d0229c526d34421dc9f75acd5687ddd8ed98921b6ec5c2d929e37ba6dc842", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5d1ea81bca9f47e3802d9aaf9fa2713d1fb8d8fae6d4d9df7292db2c4a38230e1c6d347284432d84cf547800640b1d790e8543a6a625a20efa0013f18ca9b31b", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/107eff77a443ba97c2d959ab77041e033849e21f48e0c36636575aecbd2ad2b546e63dd793a7dd18c18c45d22543b5198b3f235471e7c6d5006f7d7abcf30ab9", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/81342ac0ba8ef589533c0c47fa864e7c42e7a725dc4f9f2e0c611b5618a76ae9607b5878e57a6f8bb01ad356d7d9bf4e8d4206bbdc28751cba02d067e51cdced"} 20:26:55 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 20:26:55 INFO - Writing to file /builds/slave/test/properties/blobber_files 20:26:55 INFO - Contents: 20:26:55 INFO - blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e7969619468ea3eb6bbafa5de0849c714012f9050917dffd139d82378e193cee6d7d0229c526d34421dc9f75acd5687ddd8ed98921b6ec5c2d929e37ba6dc842", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5d1ea81bca9f47e3802d9aaf9fa2713d1fb8d8fae6d4d9df7292db2c4a38230e1c6d347284432d84cf547800640b1d790e8543a6a625a20efa0013f18ca9b31b", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/107eff77a443ba97c2d959ab77041e033849e21f48e0c36636575aecbd2ad2b546e63dd793a7dd18c18c45d22543b5198b3f235471e7c6d5006f7d7abcf30ab9", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/81342ac0ba8ef589533c0c47fa864e7c42e7a725dc4f9f2e0c611b5618a76ae9607b5878e57a6f8bb01ad356d7d9bf4e8d4206bbdc28751cba02d067e51cdced"} 20:26:55 INFO - Running post-run listener: copy_logs_to_upload_dir 20:26:55 INFO - Copying logs to upload dir... 20:26:55 INFO - mkdir: /builds/slave/test/build/upload/logs 20:26:55 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1261.674419 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 1 secs) (at 2017-08-15 20:26:56.033781) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-08-15 20:26:56.041692) ========= 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=eca2ab57546de7b41f256b19000001ef-1502852752.375122-25052663 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/e7969619468ea3eb6bbafa5de0849c714012f9050917dffd139d82378e193cee6d7d0229c526d34421dc9f75acd5687ddd8ed98921b6ec5c2d929e37ba6dc842", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5d1ea81bca9f47e3802d9aaf9fa2713d1fb8d8fae6d4d9df7292db2c4a38230e1c6d347284432d84cf547800640b1d790e8543a6a625a20efa0013f18ca9b31b", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/107eff77a443ba97c2d959ab77041e033849e21f48e0c36636575aecbd2ad2b546e63dd793a7dd18c18c45d22543b5198b3f235471e7c6d5006f7d7abcf30ab9", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/81342ac0ba8ef589533c0c47fa864e7c42e7a725dc4f9f2e0c611b5618a76ae9607b5878e57a6f8bb01ad356d7d9bf4e8d4206bbdc28751cba02d067e51cdced"} build_url:https://queue.taskcluster.net/v1/task/CfE8SazFTyCmvfD5YyBUnw/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011280 build_url: 'https://queue.taskcluster.net/v1/task/CfE8SazFTyCmvfD5YyBUnw/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e7969619468ea3eb6bbafa5de0849c714012f9050917dffd139d82378e193cee6d7d0229c526d34421dc9f75acd5687ddd8ed98921b6ec5c2d929e37ba6dc842", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5d1ea81bca9f47e3802d9aaf9fa2713d1fb8d8fae6d4d9df7292db2c4a38230e1c6d347284432d84cf547800640b1d790e8543a6a625a20efa0013f18ca9b31b", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/107eff77a443ba97c2d959ab77041e033849e21f48e0c36636575aecbd2ad2b546e63dd793a7dd18c18c45d22543b5198b3f235471e7c6d5006f7d7abcf30ab9", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/81342ac0ba8ef589533c0c47fa864e7c42e7a725dc4f9f2e0c611b5618a76ae9607b5878e57a6f8bb01ad356d7d9bf4e8d4206bbdc28751cba02d067e51cdced"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-08-15 20:26:56.070968) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-08-15 20:26:56.071329) ========= 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=eca2ab57546de7b41f256b19000001ef-1502852752.375122-25052663 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004524 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-08-15 20:26:56.154302) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-08-15 20:26:56.154623) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-08-15 20:26:56.154926) ========= ========= Total master_lag: 0.20 =========