builder: mozilla-central_ubuntu64_hw_stylo_test-dromaeojs-e10s slave: talos-linux64-ix-085 starttime: 1502925678.95 results: success (0) revision: 1d38626ba9686d119e489db538ce84f8f9854217 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-08-16 16:21:18.951336) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-08-16 16:21:18.951768) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-08-16 16:21:18.952043) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-08-16 16:21:19.046538) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-16 16:21:19.046873) ========= 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=5c37b704b588aaa989324530000001d0-1502925633.748835-531335602 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-08-16 16:21:19-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 46.3M=0s 2017-08-16 16:21:19 (46.3 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.093039 ========= master_lag: 0.04 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-16 16:21:19.184147) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-08-16 16:21:19.184423) ========= 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=5c37b704b588aaa989324530000001d0-1502925633.748835-531335602 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019923 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-08-16 16:21:19.258114) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 59 secs) (at 2017-08-16 16:21:19.258408) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 1d38626ba9686d119e489db538ce84f8f9854217 --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 1d38626ba9686d119e489db538ce84f8f9854217 --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=5c37b704b588aaa989324530000001d0-1502925633.748835-531335602 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-08-16 16:21:20,117 truncating revision to first 12 chars 2017-08-16 16:21:20,117 Setting DEBUG logging. 2017-08-16 16:21:20,117 attempt 1/10 2017-08-16 16:21:20,117 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/1d38626ba968?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-08-16 16:21:21,513 attempt 1/10 2017-08-16 16:21:22,860 current task status: no status available at this point. state: PENDING 2017-08-16 16:21:22,860 sleeping for 11.00s (attempt 1/10) 2017-08-16 16:21:33,871 attempt 2/10 2017-08-16 16:21:34,390 current task status: no status available at this point. state: PENDING 2017-08-16 16:21:34,390 sleeping for 17.50s (attempt 2/10) 2017-08-16 16:21:51,908 attempt 3/10 2017-08-16 16:21:52,452 current task status: no status available at this point. state: PENDING 2017-08-16 16:21:52,452 sleeping for 26.25s (attempt 3/10) 2017-08-16 16:22:18,729 attempt 4/10 2017-08-16 16:22:19,036 current task status: Task completed! Check 's3_urls' for upload locations. state: SUCCESS 2017-08-16 16:22:19,291 unpacking tar archive at: mozilla-central-1d38626ba968/testing/mozharness/ program finished with exit code 0 elapsedTime=59.479934 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 59 secs) (at 2017-08-16 16:22:18.767831) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-08-16 16:22:18.771165) ========= script_repo_revision: 1d38626ba9686d119e489db538ce84f8f9854217 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-08-16 16:22:18.771568) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-08-16 16:22:18.771837) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-08-16 16:22:18.783176) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 54 secs) (at 2017-08-16 16:22:18.783461) ========= /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=5c37b704b588aaa989324530000001d0-1502925633.748835-531335602 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 16:22:19 INFO - MultiFileLogger online at 20170816 16:22:19 in /builds/slave/test 16:22:19 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 16:22:19 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 16:22:19 INFO - {'append_to_log': False, 16:22:19 INFO - 'base_work_dir': '/builds/slave/test', 16:22:19 INFO - 'blob_upload_branch': 'Firefox', 16:22:19 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 16:22:19 INFO - 'branch': 'Firefox', 16:22:19 INFO - 'buildbot_json_path': 'buildprops.json', 16:22:19 INFO - 'code_coverage': False, 16:22:19 INFO - 'config_files': ('talos/linux_config.py',), 16:22:19 INFO - 'default_actions': ('clobber', 16:22:19 INFO - 'read-buildbot-config', 16:22:19 INFO - 'download-and-extract', 16:22:19 INFO - 'populate-webroot', 16:22:19 INFO - 'create-virtualenv', 16:22:19 INFO - 'install', 16:22:19 INFO - 'setup-mitmproxy', 16:22:19 INFO - 'run-tests'), 16:22:19 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 16:22:19 INFO - 'disable_ccov_upload': False, 16:22:19 INFO - 'download_minidump_stackwalk': True, 16:22:19 INFO - 'download_symbols': 'ondemand', 16:22:19 INFO - 'enable_stylo': False, 16:22:19 INFO - 'enable_webrender': False, 16:22:19 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 16:22:19 INFO - 'tooltool.py': '/tools/tooltool.py', 16:22:19 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 16:22:19 INFO - '/tools/misc-python/virtualenv.py')}, 16:22:19 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 16:22:19 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 16:22:19 INFO - 'gecko_profile': False, 16:22:19 INFO - 'gecko_profile_interval': 0, 16:22:19 INFO - 'installer_path': 'installer.exe', 16:22:19 INFO - 'log_level': 'info', 16:22:19 INFO - 'log_name': 'talos', 16:22:19 INFO - 'log_to_console': True, 16:22:19 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 16:22:19 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 16:22:19 INFO - 'opt_config_files': (), 16:22:19 INFO - 'pip_index': False, 16:22:19 INFO - 'suite': 'dromaeojs-e10s', 16:22:19 INFO - 'system_bits': '32', 16:22:19 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 16:22:19 INFO - 'title': 'talos-linux64-ix-085', 16:22:19 INFO - 'tooltool_cache': '/builds/tooltool_cache', 16:22:19 INFO - 'use_talos_json': True, 16:22:19 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 16:22:19 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 16:22:19 INFO - 'work_dir': 'build'} 16:22:19 INFO - [mozharness: 2017-08-16 23:22:19.735311Z] Running clobber step. 16:22:19 INFO - Running pre-action listener: _resource_record_pre_action 16:22:19 INFO - Running main action method: clobber 16:22:19 INFO - rmtree: /builds/slave/test/build 16:22:19 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 16:22:20 INFO - Running post-action listener: _resource_record_post_action 16:22:20 INFO - [mozharness: 2017-08-16 23:22:20.754449Z] Finished clobber step (success) 16:22:20 INFO - [mozharness: 2017-08-16 23:22:20.754551Z] Running read-buildbot-config step. 16:22:20 INFO - Running pre-action listener: _resource_record_pre_action 16:22:20 INFO - Running main action method: read_buildbot_config 16:22:20 INFO - Using buildbot properties: 16:22:20 INFO - { 16:22:20 INFO - "project": "", 16:22:20 INFO - "product": "firefox", 16:22:20 INFO - "who": "kwierso@gmail.com", 16:22:20 INFO - "installer_path": "public/build/target.tar.bz2", 16:22:20 INFO - "builddir": "mozilla-central_ubuntu64_hw_stylo_test-dromaeojs-e10s", 16:22:20 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 16:22:20 INFO - "buildername": "Ubuntu HW 12.04 x64 stylo mozilla-central talos dromaeojs-e10s", 16:22:20 INFO - "stage_platform": "linux64-stylo", 16:22:20 INFO - "basedir": "/builds/slave/test", 16:22:20 INFO - "buildnumber": 90, 16:22:20 INFO - "platform": "ubuntu64_hw_stylo", 16:22:20 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 16:22:20 INFO - "slavebuilddir": "test", 16:22:20 INFO - "taskId": "Wtt8lcz-SIeTIXEA84HaWg", 16:22:20 INFO - "branch": "mozilla-central", 16:22:20 INFO - "script_repo_revision": "production", 16:22:20 INFO - "revision": "1d38626ba9686d119e489db538ce84f8f9854217", 16:22:20 INFO - "slavename": "talos-linux64-ix-085", 16:22:20 INFO - "repo_path": "mozilla-central" 16:22:20 INFO - } 16:22:20 INFO - Finding installer, test and symbols from parent task. 16:22:20 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Wtt8lcz-SIeTIXEA84HaWg'}, attempt #1 16:22:21 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Wtt8lcz-SIeTIXEA84HaWg'}, attempt #1 16:22:21 INFO - Task dependencies: MwNIxikqQeW7ZnNry6c34A 16:22:21 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/MwNIxikqQeW7ZnNry6c34A'}, attempt #1 16:22:22 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/MwNIxikqQeW7ZnNry6c34A/artifacts/public/build/target.tar.bz2 16:22:22 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/MwNIxikqQeW7ZnNry6c34A/artifacts/public/build/target.test_packages.json 16:22:22 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/MwNIxikqQeW7ZnNry6c34A/artifacts/public/build/target.crashreporter-symbols.zip 16:22:22 INFO - Running post-action listener: _resource_record_post_action 16:22:22 INFO - [mozharness: 2017-08-16 23:22:22.114397Z] Finished read-buildbot-config step (success) 16:22:22 INFO - [mozharness: 2017-08-16 23:22:22.114618Z] Running download-and-extract step. 16:22:22 INFO - Running pre-action listener: _resource_record_pre_action 16:22:22 INFO - Running main action method: download_and_extract 16:22:22 INFO - mkdir: /builds/slave/test/build/tests 16:22:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:22:22 INFO - trying https://queue.taskcluster.net/v1/task/MwNIxikqQeW7ZnNry6c34A/artifacts/public/build/target.test_packages.json 16:22:22 INFO - Downloading https://queue.taskcluster.net/v1/task/MwNIxikqQeW7ZnNry6c34A/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 16:22:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/MwNIxikqQeW7ZnNry6c34A/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 16:22:22 INFO - Downloaded 989 bytes. 16:22:22 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 16:22:22 INFO - Using the following test package requirements: 16:22:22 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 16:22:22 INFO - u'common': [u'target.common.tests.zip'], 16:22:22 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 16:22:22 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 16:22:22 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 16:22:22 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 16:22:22 INFO - u'mozbase': [u'target.common.tests.zip'], 16:22:22 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 16:22:22 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 16:22:22 INFO - u'web-platform': [u'target.common.tests.zip', 16:22:22 INFO - u'target.web-platform.tests.tar.gz'], 16:22:22 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 16:22:22 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 16:22:22 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/MwNIxikqQeW7ZnNry6c34A/artifacts/public/build/target.common.tests.zip 16:22:22 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/MwNIxikqQeW7ZnNry6c34A/artifacts/public/build/target.common.tests.zip'}, attempt #1 16:22:22 INFO - Fetch https://queue.taskcluster.net/v1/task/MwNIxikqQeW7ZnNry6c34A/artifacts/public/build/target.common.tests.zip into memory 16:22:23 INFO - Content-Length response header: 54004033 16:22:23 INFO - Bytes received: 54004033 16:22:34 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 16:22:34 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/MwNIxikqQeW7ZnNry6c34A/artifacts/public/build/target.common.tests.zip 16:22:34 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/MwNIxikqQeW7ZnNry6c34A/artifacts/public/build/target.common.tests.zip'}, attempt #1 16:22:34 INFO - Fetch https://queue.taskcluster.net/v1/task/MwNIxikqQeW7ZnNry6c34A/artifacts/public/build/target.common.tests.zip into memory 16:22:36 INFO - Content-Length response header: 54004033 16:22:36 INFO - Bytes received: 54004033 16:22:47 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/MwNIxikqQeW7ZnNry6c34A/artifacts/public/build/target.talos.tests.zip 16:22:47 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/MwNIxikqQeW7ZnNry6c34A/artifacts/public/build/target.talos.tests.zip'}, attempt #1 16:22:47 INFO - Fetch https://queue.taskcluster.net/v1/task/MwNIxikqQeW7ZnNry6c34A/artifacts/public/build/target.talos.tests.zip into memory 16:22:48 INFO - Content-Length response header: 14496050 16:22:48 INFO - Bytes received: 14496050 16:22:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:22:48 INFO - trying https://queue.taskcluster.net/v1/task/MwNIxikqQeW7ZnNry6c34A/artifacts/public/build/target.tar.bz2 16:22:48 INFO - Downloading https://queue.taskcluster.net/v1/task/MwNIxikqQeW7ZnNry6c34A/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 16:22:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/MwNIxikqQeW7ZnNry6c34A/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 16:22:49 INFO - Downloaded 61751858 bytes. 16:22:49 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/MwNIxikqQeW7ZnNry6c34A/artifacts/public/build/target.tar.bz2 16:22:49 INFO - mkdir: /builds/slave/test/properties 16:22:49 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 16:22:49 INFO - Writing to file /builds/slave/test/properties/build_url 16:22:49 INFO - Contents: 16:22:49 INFO - build_url:https://queue.taskcluster.net/v1/task/MwNIxikqQeW7ZnNry6c34A/artifacts/public/build/target.tar.bz2 16:22:49 INFO - Running post-action listener: _resource_record_post_action 16:22:49 INFO - Running post-action listener: set_extra_try_arguments 16:22:49 INFO - [mozharness: 2017-08-16 23:22:49.986228Z] Finished download-and-extract step (success) 16:22:49 INFO - [mozharness: 2017-08-16 23:22:49.986326Z] Running populate-webroot step. 16:22:49 INFO - Running pre-action listener: _resource_record_pre_action 16:22:49 INFO - Running main action method: populate_webroot 16:22:49 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 16:22:49 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 16:22:49 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 16:22:49 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:22:49 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 16:22:49 INFO - 'tests': ['damp', 'tps']}, 16:22:49 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 16:22:49 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 16:22:49 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 16:22:49 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 16:22:49 INFO - 'other-e10s': {'tests': ['a11yr', 16:22:49 INFO - 'ts_paint', 16:22:49 INFO - 'tpaint', 16:22:49 INFO - 'sessionrestore', 16:22:49 INFO - 'sessionrestore_many_windows', 16:22:49 INFO - 'sessionrestore_no_auto_restore', 16:22:49 INFO - 'tabpaint']}, 16:22:49 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 16:22:49 INFO - 'perf-reftest-singletons-e10s': {'tests': ['bloom_basic_singleton']}, 16:22:49 INFO - 'svgr-e10s': {'tests': ['tsvgx', 16:22:49 INFO - 'tsvgr_opacity', 16:22:49 INFO - 'tart', 16:22:49 INFO - 'tscrollx', 16:22:49 INFO - 'tsvg_static']}, 16:22:49 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 16:22:49 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 16:22:49 INFO - 'talos_options': ['--mitmproxy', 16:22:49 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 16:22:49 INFO - '--firstNonBlankPaint'], 16:22:49 INFO - 'tests': ['tp6_google', 16:22:49 INFO - 'tp6_youtube', 16:22:49 INFO - 'tp6_amazon', 16:22:49 INFO - 'tp6_facebook']}, 16:22:49 INFO - 'tp6-stylo-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 16:22:49 INFO - 'talos_options': ['--stylo', 16:22:49 INFO - '--mitmproxy', 16:22:49 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 16:22:49 INFO - '--firstNonBlankPaint'], 16:22:49 INFO - 'tests': ['tp6_google', 16:22:49 INFO - 'tp6_youtube', 16:22:49 INFO - 'tp6_amazon', 16:22:49 INFO - 'tp6_facebook']}, 16:22:49 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 16:22:49 INFO - 'talos_options': ['--stylo', 16:22:49 INFO - '--stylo-threads=1', 16:22:49 INFO - '--mitmproxy', 16:22:49 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 16:22:49 INFO - '--firstNonBlankPaint'], 16:22:49 INFO - 'tests': ['tp6_google', 16:22:49 INFO - 'tp6_youtube', 16:22:49 INFO - 'tp6_amazon', 16:22:49 INFO - 'tp6_facebook']}, 16:22:49 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 16:22:49 INFO - 'talos_options': ['--xperf_path', 16:22:49 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:22:49 INFO - 'tests': ['tp5n']}}} 16:22:49 INFO - Running post-action listener: _resource_record_post_action 16:22:49 INFO - [mozharness: 2017-08-16 23:22:49.994828Z] Finished populate-webroot step (success) 16:22:49 INFO - [mozharness: 2017-08-16 23:22:49.994919Z] Running create-virtualenv step. 16:22:49 INFO - Running pre-action listener: _resource_record_pre_action 16:22:49 INFO - Running main action method: create_virtualenv 16:22:49 INFO - Creating virtualenv /builds/slave/test/build/venv 16:22:49 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 16:22:49 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 16:22:49 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 16:22:50 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 16:22:50 INFO - Using real prefix '/usr' 16:22:50 INFO - New python executable in /builds/slave/test/build/venv/bin/python 16:22:50 INFO - Installing distribute.............................................................................................................................................................................................done. 16:22:52 INFO - Installing pip.................done. 16:22:52 INFO - Return code: 0 16:22:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 16:22:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 16:22:52 INFO - Reading from file tmpfile_stdout 16:22:52 INFO - Output received: 16:22:52 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) 16:22:52 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 16:22:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:22:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:22:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:22:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:22:52 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29d81f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2adca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c7fc30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c7ccc0>, '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 0x2c7dcd0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c7e160>, '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': '5c37b704b588aaa989324530000001d0-1502925633.748835-531335602', '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 16:22:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 16:22:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 16:22:52 INFO - Using env: {'DISPLAY': ':0', 16:22:52 INFO - 'HOME': '/home/cltbld', 16:22:52 INFO - 'LANG': 'en_US.UTF-8', 16:22:52 INFO - 'LANGUAGE': 'en_US:en', 16:22:52 INFO - 'LOGNAME': 'cltbld', 16:22:52 INFO - 'MAIL': '/var/mail/cltbld', 16:22:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:22:52 INFO - 'MOZ_NO_REMOTE': '1', 16:22:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:22:52 INFO - 'NO_EM_RESTART': '1', 16:22:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:22:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:22:52 INFO - 'PWD': '/builds/slave/test', 16:22:52 INFO - 'SHELL': '/bin/bash', 16:22:52 INFO - 'SHLVL': '1', 16:22:52 INFO - 'TERM': 'linux', 16:22:52 INFO - 'TMOUT': '86400', 16:22:52 INFO - 'USER': 'cltbld', 16:22:52 INFO - 'XDG_SESSION_COOKIE': '5c37b704b588aaa989324530000001d0-1502925633.748835-531335602', 16:22:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:22:52 INFO - '_': '/tools/buildbot/bin/python'} 16:22:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:22:52 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 16:22:52 INFO - Cleaning up... 16:22:52 INFO - Return code: 0 16:22:52 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 16:22:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:22:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:22:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:22:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:22:53 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x29d81f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2adca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c7fc30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c7ccc0>, '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 0x2c7dcd0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c7e160>, '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': '5c37b704b588aaa989324530000001d0-1502925633.748835-531335602', '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 16:22:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 16:22:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 16:22:53 INFO - Using env: {'DISPLAY': ':0', 16:22:53 INFO - 'HOME': '/home/cltbld', 16:22:53 INFO - 'LANG': 'en_US.UTF-8', 16:22:53 INFO - 'LANGUAGE': 'en_US:en', 16:22:53 INFO - 'LOGNAME': 'cltbld', 16:22:53 INFO - 'MAIL': '/var/mail/cltbld', 16:22:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:22:53 INFO - 'MOZ_NO_REMOTE': '1', 16:22:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:22:53 INFO - 'NO_EM_RESTART': '1', 16:22:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:22:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:22:53 INFO - 'PWD': '/builds/slave/test', 16:22:53 INFO - 'SHELL': '/bin/bash', 16:22:53 INFO - 'SHLVL': '1', 16:22:53 INFO - 'TERM': 'linux', 16:22:53 INFO - 'TMOUT': '86400', 16:22:53 INFO - 'USER': 'cltbld', 16:22:53 INFO - 'XDG_SESSION_COOKIE': '5c37b704b588aaa989324530000001d0-1502925633.748835-531335602', 16:22:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:22:53 INFO - '_': '/tools/buildbot/bin/python'} 16:22:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:22:53 INFO - Downloading/unpacking psutil>=3.1.1 16:22:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:22:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:22:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:22:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:22:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 16:22:54 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:22:54 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:22:54 INFO - Installing collected packages: psutil 16:22:54 INFO - Running setup.py install for psutil 16:22:54 INFO - building 'psutil._psutil_linux' extension 16:22:54 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 16:22:55 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 16:22:55 INFO - building 'psutil._psutil_posix' extension 16:22:55 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 16:22:55 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 16:22:55 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:22:55 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:22:55 INFO - Successfully installed psutil 16:22:55 INFO - Cleaning up... 16:22:55 INFO - Return code: 0 16:22:55 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 16:22:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:22:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:22:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:22:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:22:55 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 0x29d81f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2adca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c7fc30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c7ccc0>, '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 0x2c7dcd0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c7e160>, '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': '5c37b704b588aaa989324530000001d0-1502925633.748835-531335602', '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 16:22:55 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 16:22:55 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 16:22:55 INFO - Using env: {'DISPLAY': ':0', 16:22:55 INFO - 'HOME': '/home/cltbld', 16:22:55 INFO - 'LANG': 'en_US.UTF-8', 16:22:55 INFO - 'LANGUAGE': 'en_US:en', 16:22:55 INFO - 'LOGNAME': 'cltbld', 16:22:55 INFO - 'MAIL': '/var/mail/cltbld', 16:22:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:22:55 INFO - 'MOZ_NO_REMOTE': '1', 16:22:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:22:55 INFO - 'NO_EM_RESTART': '1', 16:22:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:22:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:22:55 INFO - 'PWD': '/builds/slave/test', 16:22:55 INFO - 'SHELL': '/bin/bash', 16:22:55 INFO - 'SHLVL': '1', 16:22:55 INFO - 'TERM': 'linux', 16:22:55 INFO - 'TMOUT': '86400', 16:22:55 INFO - 'USER': 'cltbld', 16:22:55 INFO - 'XDG_SESSION_COOKIE': '5c37b704b588aaa989324530000001d0-1502925633.748835-531335602', 16:22:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:22:55 INFO - '_': '/tools/buildbot/bin/python'} 16:22:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:22:55 INFO - Downloading/unpacking mozsystemmonitor==0.3 16:22:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:22:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:22:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:22:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:22:56 INFO - Downloading mozsystemmonitor-0.3.tar.gz 16:22:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 16:22:56 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 16:22:56 INFO - Installing collected packages: mozsystemmonitor 16:22:56 INFO - Running setup.py install for mozsystemmonitor 16:22:56 INFO - Successfully installed mozsystemmonitor 16:22:56 INFO - Cleaning up... 16:22:56 INFO - Return code: 0 16:22:56 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 16:22:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:22:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:22:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:22:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:22:56 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 0x29d81f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2adca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c7fc30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c7ccc0>, '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 0x2c7dcd0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c7e160>, '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': '5c37b704b588aaa989324530000001d0-1502925633.748835-531335602', '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 16:22:56 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 16:22:56 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 16:22:56 INFO - Using env: {'DISPLAY': ':0', 16:22:56 INFO - 'HOME': '/home/cltbld', 16:22:56 INFO - 'LANG': 'en_US.UTF-8', 16:22:56 INFO - 'LANGUAGE': 'en_US:en', 16:22:56 INFO - 'LOGNAME': 'cltbld', 16:22:56 INFO - 'MAIL': '/var/mail/cltbld', 16:22:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:22:56 INFO - 'MOZ_NO_REMOTE': '1', 16:22:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:22:56 INFO - 'NO_EM_RESTART': '1', 16:22:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:22:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:22:56 INFO - 'PWD': '/builds/slave/test', 16:22:56 INFO - 'SHELL': '/bin/bash', 16:22:56 INFO - 'SHLVL': '1', 16:22:56 INFO - 'TERM': 'linux', 16:22:56 INFO - 'TMOUT': '86400', 16:22:56 INFO - 'USER': 'cltbld', 16:22:56 INFO - 'XDG_SESSION_COOKIE': '5c37b704b588aaa989324530000001d0-1502925633.748835-531335602', 16:22:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:22:56 INFO - '_': '/tools/buildbot/bin/python'} 16:22:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:22:57 INFO - Downloading/unpacking jsonschema==2.5.1 16:22:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:22:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:22:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:22:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:22:58 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 16:22:58 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 16:22:58 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 16:22:58 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 16:22:58 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 16:22:58 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 16:22:58 INFO - Downloading functools32-3.2.3-2.tar.gz 16:22:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 16:22:58 INFO - warning: no files found matching '*.txt' 16:22:58 INFO - no previously-included directories found matching 'build' 16:22:58 INFO - no previously-included directories found matching 'dist' 16:22:58 INFO - no previously-included directories found matching '.git*' 16:22:58 INFO - Installing collected packages: jsonschema, functools32 16:22:58 INFO - Running setup.py install for functools32 16:22:58 INFO - warning: no files found matching '*.txt' 16:22:58 INFO - no previously-included directories found matching 'build' 16:22:58 INFO - no previously-included directories found matching 'dist' 16:22:58 INFO - no previously-included directories found matching '.git*' 16:22:58 INFO - Successfully installed jsonschema functools32 16:22:58 INFO - Cleaning up... 16:22:58 INFO - Return code: 0 16:22:58 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 16:22:58 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')]} 16:22:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:22:58 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')]} 16:22:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:22:58 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 0x29d81f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2adca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c7fc30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c7ccc0>, '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 0x2c7dcd0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c7e160>, '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': '5c37b704b588aaa989324530000001d0-1502925633.748835-531335602', '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 16:22:58 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 16:22:58 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 16:22:58 INFO - Using env: {'DISPLAY': ':0', 16:22:58 INFO - 'HOME': '/home/cltbld', 16:22:58 INFO - 'LANG': 'en_US.UTF-8', 16:22:58 INFO - 'LANGUAGE': 'en_US:en', 16:22:58 INFO - 'LOGNAME': 'cltbld', 16:22:58 INFO - 'MAIL': '/var/mail/cltbld', 16:22:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:22:58 INFO - 'MOZ_NO_REMOTE': '1', 16:22:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:22:58 INFO - 'NO_EM_RESTART': '1', 16:22:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:22:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:22:58 INFO - 'PWD': '/builds/slave/test', 16:22:58 INFO - 'SHELL': '/bin/bash', 16:22:58 INFO - 'SHLVL': '1', 16:22:58 INFO - 'TERM': 'linux', 16:22:58 INFO - 'TMOUT': '86400', 16:22:58 INFO - 'USER': 'cltbld', 16:22:58 INFO - 'XDG_SESSION_COOKIE': '5c37b704b588aaa989324530000001d0-1502925633.748835-531335602', 16:22:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:22:58 INFO - '_': '/tools/buildbot/bin/python'} 16:22:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:22:58 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 16:22:58 INFO - Cleaning up... 16:22:58 INFO - Return code: 0 16:22:58 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 16:22:58 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')]} 16:22:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:22:58 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')]} 16:22:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:22:58 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 0x29d81f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2adca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c7fc30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c7ccc0>, '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 0x2c7dcd0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c7e160>, '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': '5c37b704b588aaa989324530000001d0-1502925633.748835-531335602', '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 16:22:58 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 16:22:58 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 16:22:58 INFO - Using env: {'DISPLAY': ':0', 16:22:58 INFO - 'HOME': '/home/cltbld', 16:22:58 INFO - 'LANG': 'en_US.UTF-8', 16:22:58 INFO - 'LANGUAGE': 'en_US:en', 16:22:58 INFO - 'LOGNAME': 'cltbld', 16:22:58 INFO - 'MAIL': '/var/mail/cltbld', 16:22:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:22:58 INFO - 'MOZ_NO_REMOTE': '1', 16:22:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:22:58 INFO - 'NO_EM_RESTART': '1', 16:22:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:22:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:22:58 INFO - 'PWD': '/builds/slave/test', 16:22:58 INFO - 'SHELL': '/bin/bash', 16:22:58 INFO - 'SHLVL': '1', 16:22:58 INFO - 'TERM': 'linux', 16:22:58 INFO - 'TMOUT': '86400', 16:22:58 INFO - 'USER': 'cltbld', 16:22:58 INFO - 'XDG_SESSION_COOKIE': '5c37b704b588aaa989324530000001d0-1502925633.748835-531335602', 16:22:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:22:58 INFO - '_': '/tools/buildbot/bin/python'} 16:22:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:22:58 INFO - Downloading/unpacking blobuploader==1.2.4 16:22:58 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 16:22:58 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 16:22:58 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 16:22:58 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 16:23:00 INFO - Downloading blobuploader-1.2.4.tar.gz 16:23:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 16:23:00 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 16:23:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:23:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:23:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:23:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:23:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 16:23:00 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 16:23:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:23:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:23:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:23:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:23:00 INFO - Downloading docopt-0.6.1.tar.gz 16:23:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 16:23:00 INFO - Installing collected packages: blobuploader, requests, docopt 16:23:00 INFO - Running setup.py install for blobuploader 16:23:00 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 16:23:00 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 16:23:00 INFO - Running setup.py install for requests 16:23:01 INFO - Running setup.py install for docopt 16:23:01 INFO - Successfully installed blobuploader requests docopt 16:23:01 INFO - Cleaning up... 16:23:01 INFO - Return code: 0 16:23:01 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:23:01 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')]} 16:23:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:23:01 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')]} 16:23:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:23:01 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 0x29d81f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2adca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c7fc30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c7ccc0>, '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 0x2c7dcd0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c7e160>, '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': '5c37b704b588aaa989324530000001d0-1502925633.748835-531335602', '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 16:23:01 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 16:23:01 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 16:23:01 INFO - Using env: {'DISPLAY': ':0', 16:23:01 INFO - 'HOME': '/home/cltbld', 16:23:01 INFO - 'LANG': 'en_US.UTF-8', 16:23:01 INFO - 'LANGUAGE': 'en_US:en', 16:23:01 INFO - 'LOGNAME': 'cltbld', 16:23:01 INFO - 'MAIL': '/var/mail/cltbld', 16:23:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:23:01 INFO - 'MOZ_NO_REMOTE': '1', 16:23:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:23:01 INFO - 'NO_EM_RESTART': '1', 16:23:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:23:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:23:01 INFO - 'PWD': '/builds/slave/test', 16:23:01 INFO - 'SHELL': '/bin/bash', 16:23:01 INFO - 'SHLVL': '1', 16:23:01 INFO - 'TERM': 'linux', 16:23:01 INFO - 'TMOUT': '86400', 16:23:01 INFO - 'USER': 'cltbld', 16:23:01 INFO - 'XDG_SESSION_COOKIE': '5c37b704b588aaa989324530000001d0-1502925633.748835-531335602', 16:23:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:23:01 INFO - '_': '/tools/buildbot/bin/python'} 16:23:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:23:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:23:01 INFO - Running setup.py (path:/tmp/pip-Oh3pvC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:23:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:23:01 INFO - Running setup.py (path:/tmp/pip-qzW1DJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:23:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:23:01 INFO - Running setup.py (path:/tmp/pip-Qyai32-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:23:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:23:01 INFO - Running setup.py (path:/tmp/pip-XscD_V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:23:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:23:01 INFO - Running setup.py (path:/tmp/pip-wvku12-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:23:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:23:01 INFO - Running setup.py (path:/tmp/pip-wLc4RH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:23:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:23:01 INFO - Running setup.py (path:/tmp/pip-joGA_G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:23:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:23:01 INFO - Running setup.py (path:/tmp/pip-UpU6jq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:23:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:23:02 INFO - Running setup.py (path:/tmp/pip-etBhJm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:23:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:23:02 INFO - Running setup.py (path:/tmp/pip-bxGvcn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:23:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:23:02 INFO - Running setup.py (path:/tmp/pip-uuiAdJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:23:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:23:02 INFO - Running setup.py (path:/tmp/pip-Ayf_7S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:23:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:23:02 INFO - Running setup.py (path:/tmp/pip-SWe5EZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:23:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:23:02 INFO - Running setup.py (path:/tmp/pip-3fRi5x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:23:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:23:02 INFO - Running setup.py (path:/tmp/pip-ei5s7m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:23:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:23:02 INFO - Running setup.py (path:/tmp/pip-LsZj1u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:23:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:23:02 INFO - Running setup.py (path:/tmp/pip-HMnwtQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:23:02 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 16:23:02 INFO - Running setup.py install for manifestparser 16:23:02 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 16:23:02 INFO - Running setup.py install for mozcrash 16:23:02 INFO - Running setup.py install for mozdebug 16:23:02 INFO - Running setup.py install for mozdevice 16:23:03 INFO - Installing dm script to /builds/slave/test/build/venv/bin 16:23:03 INFO - Running setup.py install for mozfile 16:23:03 INFO - Running setup.py install for mozhttpd 16:23:03 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 16:23:03 INFO - Running setup.py install for mozinfo 16:23:03 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 16:23:03 INFO - Running setup.py install for mozInstall 16:23:03 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 16:23:03 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 16:23:03 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 16:23:03 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 16:23:03 INFO - Running setup.py install for mozleak 16:23:03 INFO - Running setup.py install for mozlog 16:23:03 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 16:23:03 INFO - Running setup.py install for moznetwork 16:23:03 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 16:23:03 INFO - Running setup.py install for mozprocess 16:23:03 INFO - Running setup.py install for mozprofile 16:23:03 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 16:23:03 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 16:23:03 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 16:23:04 INFO - Running setup.py install for mozrunner 16:23:04 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 16:23:04 INFO - Running setup.py install for mozscreenshot 16:23:04 INFO - Running setup.py install for moztest 16:23:04 INFO - Running setup.py install for mozversion 16:23:04 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 16:23:04 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 16:23:04 INFO - Cleaning up... 16:23:04 INFO - Return code: 0 16:23:04 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:23: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')]} 16:23:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:23: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')]} 16:23:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:23:04 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 0x29d81f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2adca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c7fc30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c7ccc0>, '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 0x2c7dcd0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c7e160>, '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': '5c37b704b588aaa989324530000001d0-1502925633.748835-531335602', '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 16:23:04 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 16:23:04 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 16:23:04 INFO - Using env: {'DISPLAY': ':0', 16:23:04 INFO - 'HOME': '/home/cltbld', 16:23:04 INFO - 'LANG': 'en_US.UTF-8', 16:23:04 INFO - 'LANGUAGE': 'en_US:en', 16:23:04 INFO - 'LOGNAME': 'cltbld', 16:23:04 INFO - 'MAIL': '/var/mail/cltbld', 16:23:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:23:04 INFO - 'MOZ_NO_REMOTE': '1', 16:23:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:23:04 INFO - 'NO_EM_RESTART': '1', 16:23:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:23:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:23:04 INFO - 'PWD': '/builds/slave/test', 16:23:04 INFO - 'SHELL': '/bin/bash', 16:23:04 INFO - 'SHLVL': '1', 16:23:04 INFO - 'TERM': 'linux', 16:23:04 INFO - 'TMOUT': '86400', 16:23:04 INFO - 'USER': 'cltbld', 16:23:04 INFO - 'XDG_SESSION_COOKIE': '5c37b704b588aaa989324530000001d0-1502925633.748835-531335602', 16:23:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:23:04 INFO - '_': '/tools/buildbot/bin/python'} 16:23:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:23:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:23:04 INFO - Running setup.py (path:/tmp/pip-T2p1xg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:23:04 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)) 16:23:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:23:04 INFO - Running setup.py (path:/tmp/pip-05QaMO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:23:04 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)) 16:23:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:23:04 INFO - Running setup.py (path:/tmp/pip-PGzFpj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:23:04 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)) 16:23:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:23:04 INFO - Running setup.py (path:/tmp/pip-S6y1P0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:23:04 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)) 16:23:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:23:04 INFO - Running setup.py (path:/tmp/pip-1vuqrR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:23:05 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)) 16:23:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:23:05 INFO - Running setup.py (path:/tmp/pip-8gV01N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:23:05 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)) 16:23:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:23:05 INFO - Running setup.py (path:/tmp/pip-IbclWN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:23:05 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)) 16:23:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:23:05 INFO - Running setup.py (path:/tmp/pip-qJNP99-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:23:05 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)) 16:23:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:23:05 INFO - Running setup.py (path:/tmp/pip-kE2VSN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:23:05 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)) 16:23:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:23:05 INFO - Running setup.py (path:/tmp/pip-xuNvxb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:23:05 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)) 16:23:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:23:05 INFO - Running setup.py (path:/tmp/pip-b1znCy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:23:05 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)) 16:23:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:23:05 INFO - Running setup.py (path:/tmp/pip-8dj_gM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:23:05 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)) 16:23:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:23:05 INFO - Running setup.py (path:/tmp/pip-cMnVNB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:23:05 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)) 16:23:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:23:05 INFO - Running setup.py (path:/tmp/pip-r8WXbL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:23:05 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)) 16:23:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:23:05 INFO - Running setup.py (path:/tmp/pip-nNA1CM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:23:05 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)) 16:23:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:23:05 INFO - Running setup.py (path:/tmp/pip-Y9fEc6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:23:05 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)) 16:23:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:23:05 INFO - Running setup.py (path:/tmp/pip-B5OWC0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:23:05 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)) 16:23:05 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)) 16:23:05 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)) 16:23:05 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)) 16:23:05 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)) 16:23:05 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)) 16:23:05 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)) 16:23:05 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 16:23:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:23:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:23:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:23:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:23:06 INFO - Downloading blessings-1.6.tar.gz 16:23:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 16:23:07 INFO - Installing collected packages: blessings 16:23:07 INFO - Running setup.py install for blessings 16:23:07 INFO - Successfully installed blessings 16:23:07 INFO - Cleaning up... 16:23:07 INFO - Return code: 0 16:23:07 INFO - Done creating virtualenv /builds/slave/test/build/venv. 16:23:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:23:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:23:07 INFO - Reading from file tmpfile_stdout 16:23:07 INFO - Current package versions: 16:23:07 INFO - argparse == 1.2.1 16:23:07 INFO - blessings == 1.6 16:23:07 INFO - blobuploader == 1.2.4 16:23:07 INFO - docopt == 0.6.1 16:23:07 INFO - functools32 == 3.2.3-2 16:23:07 INFO - jsonschema == 2.5.1 16:23:07 INFO - manifestparser == 1.1 16:23:07 INFO - mozInstall == 1.13 16:23:07 INFO - mozcrash == 1.0 16:23:07 INFO - mozdebug == 0.1 16:23:07 INFO - mozdevice == 0.51 16:23:07 INFO - mozfile == 1.2 16:23:07 INFO - mozhttpd == 0.7 16:23:07 INFO - mozinfo == 0.10 16:23:07 INFO - mozleak == 0.1 16:23:07 INFO - mozlog == 3.5 16:23:07 INFO - moznetwork == 0.27 16:23:07 INFO - mozprocess == 0.25 16:23:07 INFO - mozprofile == 0.28 16:23:07 INFO - mozrunner == 6.13 16:23:07 INFO - mozscreenshot == 0.1 16:23:07 INFO - mozsystemmonitor == 0.3 16:23:07 INFO - moztest == 0.8 16:23:07 INFO - mozversion == 1.4 16:23:07 INFO - psutil == 3.1.1 16:23:07 INFO - requests == 1.2.3 16:23:07 INFO - wsgiref == 0.1.2 16:23:07 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:23:07 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')]} 16:23:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:23:07 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')]} 16:23:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:23:07 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 0x29d81f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2adca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c7fc30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c7ccc0>, '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 0x2c7dcd0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c7e160>, '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': '5c37b704b588aaa989324530000001d0-1502925633.748835-531335602', '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 16:23:07 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 16:23:07 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 16:23:07 INFO - Using env: {'DISPLAY': ':0', 16:23:07 INFO - 'HOME': '/home/cltbld', 16:23:07 INFO - 'LANG': 'en_US.UTF-8', 16:23:07 INFO - 'LANGUAGE': 'en_US:en', 16:23:07 INFO - 'LOGNAME': 'cltbld', 16:23:07 INFO - 'MAIL': '/var/mail/cltbld', 16:23:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:23:07 INFO - 'MOZ_NO_REMOTE': '1', 16:23:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:23:07 INFO - 'NO_EM_RESTART': '1', 16:23:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:23:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:23:07 INFO - 'PWD': '/builds/slave/test', 16:23:07 INFO - 'SHELL': '/bin/bash', 16:23:07 INFO - 'SHLVL': '1', 16:23:07 INFO - 'TERM': 'linux', 16:23:07 INFO - 'TMOUT': '86400', 16:23:07 INFO - 'USER': 'cltbld', 16:23:07 INFO - 'XDG_SESSION_COOKIE': '5c37b704b588aaa989324530000001d0-1502925633.748835-531335602', 16:23:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:23:07 INFO - '_': '/tools/buildbot/bin/python'} 16:23:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:23:07 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)) 16:23:07 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)) 16:23:07 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)) 16:23:07 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)) 16:23:07 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)) 16:23:07 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)) 16:23:07 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)) 16:23:07 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)) 16:23:07 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)) 16:23:07 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 16:23:07 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 16:23:07 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 16:23:07 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 16:23:07 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 16:23:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 16:23:08 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)) 16:23:08 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)) 16:23:08 INFO - Installing collected packages: simplejson 16:23:08 INFO - Running setup.py install for simplejson 16:23:09 INFO - building 'simplejson._speedups' extension 16:23:09 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 16:23:09 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 16:23:09 INFO - Successfully installed simplejson 16:23:09 INFO - Cleaning up... 16:23:09 INFO - Return code: 0 16:23:09 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 16:23:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:23:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:23:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:23:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:23:09 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 0x29d81f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2adca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c7fc30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c7ccc0>, '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 0x2c7dcd0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c7e160>, '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': '5c37b704b588aaa989324530000001d0-1502925633.748835-531335602', '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 16:23:09 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 16:23:09 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 16:23:09 INFO - Using env: {'DISPLAY': ':0', 16:23:09 INFO - 'HOME': '/home/cltbld', 16:23:09 INFO - 'LANG': 'en_US.UTF-8', 16:23:09 INFO - 'LANGUAGE': 'en_US:en', 16:23:09 INFO - 'LOGNAME': 'cltbld', 16:23:09 INFO - 'MAIL': '/var/mail/cltbld', 16:23:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:23:09 INFO - 'MOZ_NO_REMOTE': '1', 16:23:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:23:09 INFO - 'NO_EM_RESTART': '1', 16:23:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:23:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:23:09 INFO - 'PWD': '/builds/slave/test', 16:23:09 INFO - 'SHELL': '/bin/bash', 16:23:09 INFO - 'SHLVL': '1', 16:23:09 INFO - 'TERM': 'linux', 16:23:09 INFO - 'TMOUT': '86400', 16:23:09 INFO - 'USER': 'cltbld', 16:23:09 INFO - 'XDG_SESSION_COOKIE': '5c37b704b588aaa989324530000001d0-1502925633.748835-531335602', 16:23:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:23:09 INFO - '_': '/tools/buildbot/bin/python'} 16:23:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:23:10 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 16:23:10 INFO - Cleaning up... 16:23:10 INFO - Return code: 0 16:23:10 INFO - Running post-action listener: _resource_record_post_action 16:23:10 INFO - Running post-action listener: _start_resource_monitoring 16:23:10 INFO - Starting resource monitoring. 16:23:10 INFO - [mozharness: 2017-08-16 23:23:10.229922Z] Finished create-virtualenv step (success) 16:23:10 INFO - [mozharness: 2017-08-16 23:23:10.230391Z] Running install step. 16:23:10 INFO - Running pre-action listener: _resource_record_pre_action 16:23:10 INFO - Running main action method: install 16:23:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:23:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:23:10 INFO - Reading from file tmpfile_stdout 16:23:10 INFO - Detecting whether we're running mozinstall >=1.0... 16:23:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 16:23:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 16:23:10 INFO - Reading from file tmpfile_stdout 16:23:10 INFO - Output received: 16:23:10 INFO - Usage: mozinstall [options] installer 16:23:10 INFO - Options: 16:23:10 INFO - -h, --help show this help message and exit 16:23:10 INFO - -d DEST, --destination=DEST 16:23:10 INFO - Directory to install application into. [default: 16:23:10 INFO - "/builds/slave/test"] 16:23:10 INFO - --app=APP Application being installed. [default: firefox] 16:23:10 INFO - mkdir: /builds/slave/test/build/application 16:23:10 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'] 16:23:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 16:23:28 INFO - Reading from file tmpfile_stdout 16:23:28 INFO - Output received: 16:23:28 INFO - /builds/slave/test/build/application/firefox/firefox 16:23:28 INFO - Running post-action listener: _resource_record_post_action 16:23:28 INFO - [mozharness: 2017-08-16 23:23:28.495431Z] Finished install step (success) 16:23:28 INFO - [mozharness: 2017-08-16 23:23:28.495720Z] Running setup-mitmproxy step. 16:23:28 INFO - Running pre-action listener: _resource_record_pre_action 16:23:28 INFO - Running main action method: setup_mitmproxy 16:23:28 INFO - Skipping: mitmproxy is not required 16:23:28 INFO - Running post-action listener: _resource_record_post_action 16:23:28 INFO - [mozharness: 2017-08-16 23:23:28.496864Z] Finished setup-mitmproxy step (success) 16:23:28 INFO - [mozharness: 2017-08-16 23:23:28.497084Z] Running run-tests step. 16:23:28 INFO - Running pre-action listener: _resource_record_pre_action 16:23:28 INFO - Running pre-action listener: _set_gcov_prefix 16:23:28 INFO - Running main action method: run_tests 16:23:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 16:23:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 16:23:28 INFO - Python 2.7.3 16:23:28 INFO - Return code: 0 16:23:28 INFO - grabbing minidump binary from tooltool 16:23: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')]} 16:23:28 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 0x2c7ccc0>, '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 0x2c7dcd0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c7e160>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 16:23:28 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 16:23:28 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 16:23:28 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 16:23:28 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 16:23:28 INFO - Return code: 0 16:23:28 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 16:23:28 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 16:23:28 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 16:23:28 INFO - ENV: RUST_BACKTRACE is now full 16:23:28 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 16:23:28 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 16:23:28 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/MwNIxikqQeW7ZnNry6c34A/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-085', '--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 16:23:28 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/MwNIxikqQeW7ZnNry6c34A/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-085 --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 16:23:28 INFO - Using env: {'DISPLAY': ':0', 16:23:28 INFO - 'HOME': '/home/cltbld', 16:23:28 INFO - 'LANG': 'en_US.UTF-8', 16:23:28 INFO - 'LANGUAGE': 'en_US:en', 16:23:28 INFO - 'LOGNAME': 'cltbld', 16:23:28 INFO - 'MAIL': '/var/mail/cltbld', 16:23:28 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 16:23:28 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 16:23:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:23:28 INFO - 'MOZ_NO_REMOTE': '1', 16:23:28 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 16:23:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:23:28 INFO - 'NO_EM_RESTART': '1', 16:23:28 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:23:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:23:28 INFO - 'PWD': '/builds/slave/test', 16:23:28 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 16:23:28 INFO - 'RUST_BACKTRACE': 'full', 16:23:28 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 16:23:28 INFO - 'SHELL': '/bin/bash', 16:23:28 INFO - 'SHLVL': '1', 16:23:28 INFO - 'STYLO_FORCE_ENABLED': '1', 16:23:28 INFO - 'TERM': 'linux', 16:23:28 INFO - 'TMOUT': '86400', 16:23:28 INFO - 'USER': 'cltbld', 16:23:28 INFO - 'XDG_SESSION_COOKIE': '5c37b704b588aaa989324530000001d0-1502925633.748835-531335602', 16:23:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:23:28 INFO - '_': '/tools/buildbot/bin/python'} 16:23:28 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/MwNIxikqQeW7ZnNry6c34A/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-085', '--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 16:23:28 INFO - mozversion application_buildid: 20170816223054 16:23:28 INFO - mozversion application_changeset: 1d38626ba9686d119e489db538ce84f8f9854217 16:23:28 INFO - mozversion application_display_name: Nightly 16:23:28 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 16:23:28 INFO - mozversion application_name: Firefox 16:23:28 INFO - mozversion application_remotingname: firefox 16:23:28 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 16:23:28 INFO - mozversion application_vendor: Mozilla 16:23:28 INFO - mozversion application_version: 57.0a1 16:23:28 INFO - mozversion platform_buildid: 20170816223054 16:23:28 INFO - mozversion platform_changeset: 1d38626ba9686d119e489db538ce84f8f9854217 16:23:28 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 16:23:28 INFO - mozversion platform_version: 57.0a1 16:23:28 INFO - using testdate: 1502925808 16:23:28 INFO - actual date: 1502925808 16:23:28 INFO - starting webserver on 'localhost:55738' 16:23:28 INFO - SUITE-START | Running 2 tests 16:23:28 INFO - TEST-START | dromaeo_css 16:23:28 INFO - Initialising browser for dromaeo_css test... 16:23:28 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:55738/getInfo.html -profile /tmp/tmpOdnnfF/profile 16:23:28 INFO - TEST-INFO | started process 5121 (/builds/slave/test/build/application/firefox/firefox http://localhost:55738/getInfo.html) 16:23:34 INFO - TEST-INFO | 5121: exit 0 16:23:35 INFO - Browser initialized. 16:23:35 INFO - Running cycle 1/1 for dromaeo_css test... 16:23:35 INFO - TEST-INFO | started process 5355 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpOdnnfF/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 16:23:35 INFO - PID 5355 | 16:23:35 INFO - PID 5355 | (/builds/slave/test/build/application/firefox/firefox:5410): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 16:23:35 INFO - PID 5355 | 16:23:46 INFO - PID 5355 | RSS: Main: 167059456 16:23:46 INFO - PID 5355 | 16:26:44 INFO - PID 5355 | Cycle 1(1): loaded http://localhost:55738/tests/dromaeo/cssquery-dojo.html (next: http://localhost:55738/tests/dromaeo/cssquery-ext.html) 16:26:45 INFO - PID 5355 | RSS: Main: 174620672 16:26:45 INFO - PID 5355 | 16:29:47 INFO - PID 5355 | Cycle 1(1): loaded http://localhost:55738/tests/dromaeo/cssquery-ext.html (next: http://localhost:55738/tests/dromaeo/cssquery-jquery.html) 16:29:48 INFO - PID 5355 | RSS: Main: 171749376 16:29:48 INFO - PID 5355 | 16:32:49 INFO - PID 5355 | Cycle 1(1): loaded http://localhost:55738/tests/dromaeo/cssquery-jquery.html (next: http://localhost:55738/tests/dromaeo/cssquery-mootools.html) 16:32:50 INFO - PID 5355 | RSS: Main: 173793280 16:32:50 INFO - PID 5355 | 16:35:52 INFO - PID 5355 | Cycle 1(1): loaded http://localhost:55738/tests/dromaeo/cssquery-mootools.html (next: http://localhost:55738/tests/dromaeo/cssquery-prototype.html) 16:35:53 INFO - PID 5355 | RSS: Main: 172220416 16:35:53 INFO - PID 5355 | 16:38:57 INFO - PID 5355 | Cycle 1(1): loaded http://localhost:55738/tests/dromaeo/cssquery-prototype.html (next: http://localhost:55738/tests/dromaeo/cssquery-yui.html) 16:38:57 INFO - PID 5355 | RSS: Main: 175390720 16:38:57 INFO - PID 5355 | 16:41:59 INFO - PID 5355 | Cycle 1(1): loaded http://localhost:55738/tests/dromaeo/cssquery-yui.html (next: http://localhost:55738/tests/dromaeo/cssquery-dojo.html) 16:41:59 INFO - PID 5355 | RSS: Main: 175923200 16:41:59 INFO - PID 5355 | 16:41:59 INFO - PID 5355 | __start_tp_report 16:41:59 INFO - PID 5355 | _x_x_mozilla_page_load 16:41:59 INFO - PID 5355 | _x_x_mozilla_page_load_details 16:41:59 INFO - PID 5355 | |i|pagename|runs| 16:41:59 INFO - PID 5355 | |0;dojo.html;3119.8752049918003;3168.461361568533;3204.8237346945916;3222.2427729483566;3235.449973504504;6129.908051379233;6188.907166392502;6288.151099601552;6319.494440444771;6323.367663233686;6106.297775755789;6231.189945307115;6235.314115447309;6245.56281060326;6259.311475737665;5686.744096515657;5694.515966142862;5697.658140511562;5708.429157084279;5766.365699773021;5721.284839395075;5746.936816688905;5783.942160578383;5791.189233507313;5842.503387212092;101.05607455006908;5682.261306030189;5702.914456283138;5838.4453476919625;5839.970800146015;5694.743736531866;5721.199032135504;5728.312602487728;5818.44724751148;5819.970900145515;5667.263255776764;5674.347450043257;5746.425357464262;5750.827475175752;5759.107338362561;6129.2032035835055;6140.907886381708;6155.045967874987;6218.347073557302;6255.155554000197;6697.631630260334;6701.463882889406;6771.525993180479;6793.4225590824835;6812.420944219747;6577.539572229945;6678.799636010927;6707.195136583592;6782.559133656297;6879.793606191823;6290.025046117905;6304.085907543426;6306.400891915261;6319.178506794087;6351.079093531458;6871.244163142051;6906.067680863019;6984.511084224056;6987.1266091738535;6989.42737883972;6561.179852518435;6585;6603.108580341688;6701.32986701326;6707.396334329934;6542;6606.504512161511;6647.368499992493;6754.121964144728;6766.594004359754;6737.326267373322;6746.0892779475125;6748.628825414649;6754.864902701918;6775.22084960226;6735.090762747064;6743.629100399525;6807.863842723118;6835.58986460814;6839.760608378683;5409.377921539073;5446.2375267462585;5450.781968721207;5533.114701647717;5544.085225937756;4649.930251046237;4685.01614660925;4694.108119457293;4699.224627936421;4712.410948631421;5800.100984347433;5800.854978625483;5823.912641310384;5830.591858569859;5837.562182836305;6750.932490675129;6759.2226893906845;6816.62508562024;6834.6582670866255;6856.142982127234;5742.54059675225;5784.595078344475;5788.88422231553;5836.620619659793;5847.210626565359;5876.9118463223085;5946.791862284799;5976.402359763989;5979.6412215266355;5982.4017598239825;6525.119108920235;6525.347465253437;6529.249136349285;6529.902051469232;6547.345265473415;6699.631520266432;6704.061431399706;6765.695543700447;6781.457483401217;6795.116634837439;6548.705308261235;6557.377049180321;6567.047778072249;6576.309487503743;6617.702203400762;6604.042413850061;6627.966860165669;6634.137562116894;6704.094947182263;6711.798646040626;6659.101021362054;6762.594244345355;6778.017187507882;6852.760153394607;6853.520253582401;6501.902471463027;6582.210134783665;6583.63789991555;6590.275069742421;6610.008498725229;6571.507136964651;6575.309592492719;6577.440917522064;6579.17760279965;6597.868042639025;6180.505559555135;6462.903056454251;6476.352364763486;6492.480601551959;6541.901871472027;6554.14796076507;6575.736970521126;6580.638064906476;6657.567258128206;6669.46644268467;6296.716647750954;6365.681715914093;6413.551051426542;6460.127882735958;6461.676916154268 16:41:59 INFO - PID 5355 | |1;ext.html;732.5641243460143;809.651849704627;835.1690068381959;838.3628442383787;1149.8447709559207;30098.849505752467;30610;40851.591484085184;41703.79148104263;41829;41531.79234103825;42050.789746051225;42068.15863682725;42180.57819421805;42280.36579451303;7470.178280389153;7548.92451075489;7665.1951545087795;7668.578228197447;7693.692252309901;7455.515391499563;7555.886661700079;7557.130929943072;7558.168601453835;7558.735444259452;7518.360939320137;7526.5484070955645;7529.171791102975;7533.28433798791;7568.848623027564;7529;7559.697612095537;7566.243375662445;7567.3189412952825;7572.469927105105;7490.101187857492;7514.173440921549;7519.962400187964;7546.09446866374;7550.244975502461;37824;37878.24243515114;37906;38058;38149.427758583646;3472.322897035079;3507.053095664182;3515.8769443069627;3516.208853008078;3519.260955199411;30471.542926856117;30689.846550767328;30693;30706.84646576775;30722.69277307243;4966.2054071348775;4996.950030499721;4999.4250661174065;5004.724740139291;5023.522765337324;186754;188069;188915;189693;189711;46643.53356466392;46777.29834052492;46917;46922;46968;49753.50246497489;50015;50092;50190;50219.24671129936;14345.569632911029;16314.531692147764;16546;16557.08936008507;16567.751483727752;11955.462004209832;13334.599962001155;13420.46318147263;13439.798403023962;13450;14176.220307883166;14243.216623085622;14246.857531424761;14254.287285635677;14360.138391696531;5672.8865422691315;5881.206426947166;5883.352831188566;5912;5967.40417918207;961.2214106573698;993.3940296419179;1007.3250921882357;1019.179560453827;1022.7187523431116;22959.540809184058;23040.65439018416;23163;23235.419114522272;23358.299251022498;1112.093643680398;1118.3848883114254;1126.5887950897863;1129.1418521923397;1130.3048625095507;12274;12296.20074695142;12324.260544367367;12354.567590134482;12360;228368;228644;228770;229693;230042;52162.739186304585;52357;52395.73802130965;52432.47567524352;52528;1442.783582462639;1461.13062727679;1479.7040591881666;1480.2006916265095;1495.3121564080427;22444.663330049734;22641.886790565943;22759.88620056889;22794.772052279266;22966.311010669706;35731.285374291845;35827.82086089657;35889.82055089708;35928.8203558991;35998.4600231002;188910;189026;189078;189246;189308;33197.66802331946;34041;34530.82734586411;34548.30903381868;34575.82712086423;42967.785161073996;44826.10347793091;44840.32739508845;45088.323675145555;45242.86892827574;33279.66720332862;33289.500657489676;33360.33279334448;33398.49902251517;33767.15582110467;32811.671883281815;33200.33599328048;33224;33301.16747081342;33958;36541;36628.08429789277;37138.44292335563;37883.81058094692;37903.62096379001;33177.50233746544;33277.334453310315;33322.00033998984;33380.666193337755;33566.328673426884;23902.880485598158;24629.261122166365;24632;24715;24903.128390506245 16:41:59 INFO - PID 5355 | |2;jquery.html;559.941206173352;562.9014922388584;577.9046457334542;579.261441661881;582.7610679621355;21981.120755169795;22758;22778;22826.88586557065;22831;25975;26850.597241041352;28221.576676349872;28279.434411311762;28335.85832070842;6853.588784672923;7028.086348774652;7028.367446929776;7029.683664235122;7030.964845175767;6379.489640828722;6708.027336036272;6712.9328706712795;6909.930900691004;6971.965140174318;6649;6707.966460167692;6709.966450167743;6710.228323742784;6722.462203023746;6686.732530698766;6691.230508491537;6692.297308782557;6696.732130714766;6714.227863795677;6585.736570537173;6587.505937054692;6589.505787065989;6591.835204119888;6596.538242323039;30485.390292194254;31356.843215784003;31843;31921.042368728977;32047;1902.7526421565108;1934.1973081171298;1934.8839069655726;1934.9032548372666;1935.235581945138;19941.900290498455;20611.278605248743;20678.483037924172;20690.586188276302;20748.481287967923;2413.855168689884;2507.0723832182025;2564.307636938035;2573.6396904433395;2589.8705064746878;136693;139136;139599.99999999898;139680;139851;20586.691199632016;22342.329730108122;22575;22623.773762262495;23282.65076023861;22849.428764281027;23808.04767809303;42589.36115958201;42783;43082;10133.442660653734;10388.168946484264;10483.266171367932;10498.895011049945;10517.316374435637;9617.903820961841;9706.95146524277;9739.805203896025;9873.901260987443;9892.307538472382;9201.631934722536;9201.63193472267;9309.860352094724;9310;9542.952285238669;2554.2847753673163;2560.567460912104;2633.749793769627;2680.423708902595;2757.2968892932577;947.8957314695378;953.2040745977187;969.5927710361665;973.9286784536953;986.9062439068277;20143.798562014486;20201.292954746514;20649.69025464589;20741.79258207429;20778.896105519376;1046.984295235572;1049.7795462952713;1052.231870734353;1052.4316868890712;1055.8152323343384;10996.670099897015;11393.430328483542;13751.174929504261;14146.504872329419;14174;534099;540905;559165;566002;567082;127356;132373;132501;133011;134697;1261.829652996852;1286.8327117474669;1295.6436979830432;1297.5847728726906;1310.6395741171254;21806.34580962574;22710.64467766117;22746;22814.65778013298;22836.543269134858;60757.392426075174;61698;61879.6906015467;61966.69016654888;63464.048039278525;79815.20184798077;80126;80351.19648803437;80420;80553;20685.793142068385;21122.366329010154;21226.469338266048;21537.784622154206;21574.89212553927;23675.40811479727;23996.160134395213;24096.63855042141;24217.39456513601;24239.515209695353;18808.529786754894;18945.242190312234;19073.523161921064;19283.807161928762;19292.517687057934;16733.74899376486;17043.31826726917;17321;17769.911150444164;18425.17086731127;18316.81683183151;19228.230870765572;19325.226990920204;19416.126274317972;19479.90260048691;20509;20637;20725.27461538839;20764.896175519025;20799.584008320053;18795;18868.150933207766;19639.509012274237;19667.606647867247;19891.403257902286 16:41:59 INFO - PID 5355 | |3;mootools.html;1333.8199343088684;1379.2827729580617;1397.0639671420147;1404.2838152542213;1415.8371787244464;13966.301684915752;14622.56132316031;14647.121172729643;14678.853211467882;14681.926590367046;13577;13978.231197284145;14506.202158881284;14558.636034099127;14586.927065364685;2644.854533000684;2715.592661100831;2721.9319517012136;2723.414465889833;2726.5501192303345;2565.679290088739;2612.399148195916;2680.8123431359813;2681.6379788728564;2712.050782226215;2651.9337016574646;2654.16393835942;2681.678198616159;2683.1011611110303;2683.221865658966;2605.986970065147;2639.432522007768;2644.735526447359;2663.400734834666;2664.427148163154;2504.561701702213;2533.40464990727;2533.9239822805343;2550.566403711355;2569.4732579821093;14278.143311401349;14402.639934001629;14413.495527656587;14415;14415.423383064664;7228;7498.47510674253;7513.060867391576;7531.887021694679;7540.057492813398;4881.658283920127;5009.574186194178;5154.793808247703;5167.612429067797;5169.53474187325;1820.8816426932208;1838.7333836593752;1857.2942281932915;1897.3928342930267;1910.6178764247206;21869.781302187093;22592.548149036927;22762.77237227623;22764.203252886236;22790.54418911629;6676.9332306676315;6829.692663830139;6862.279460656659;7019.754308599175;7113.288671132948;19153.425397238105;19174;19176.8082319175;19184.424467266006;19220.231190752493;7863.135055144044;8008.159143289987;8011.038675358995;8017.518948863087;8018.398620103399;6770.187577490733;6958.512904096766;6969.686364113627;7036.788896333118;7175.067241258707;5466.644668096561;5608.635438696553;5614.466625670555;5636.2391077204875;5648.491635752802;1639.753787121796;1651.4137481194243;1672.8996260224426;1699.498647898848;1701.1154199816274;867.8524650809252;881.7046289493092;891.4517571693492;891.8840550728364;896.2068569316071;7936.3254123399;8167.509949403055;8196.508209507449;8249.752507424786;8384.700371442435;681.4241965539112;954.513198268874;967.970960871175;972.5429048347265;980.07872599756;4886.926696099561;5119.6160287978555;5161.045206636784;5302.628815982845;5445.910817836449;18031.72952405715;18138;18729;18739.437816865517;18748.718769218474;19710.507237319183;19981.100850461473;20124.798752012586;20143.39569812908;20154.093065812074;9100.180983711498;9585.760355991157;9926.255530835217;10880.510377032893;11157.832632510519;7856.332211761835;8183.468074575134;8309.83380332378;8392.496450213006;8416.4108512406;16950.83049169542;17345.49441786314;17488.125593720517;17602.559936001704;17907.910460447616;17752.3786667466;17818.376356827448;17869.195886185415;17885.28458861631;18047.729284060486;11088.279261847954;11472.483738231967;11476.254043487146;11479.139064570023;11485.942570287096;12469.064820138707;12525.123241373016;12665.620031399072;12687.175333603287;12690.555830545887;10243.334183278062;10251.179905607385;10359.912209218224;10466.895331046591;10483.895161048293;9830.311878168746;9880.814302283772;9979.550920208463;10066.49667516636;10265.84601230997;9178.67874624385;9555.23558115363;9808.117269445784;9810.901890980998;9862.408255504693;6891.345322194384;6917.93082069193;6954.130733658293;7003;7045.11936007999;6826.317368263134;6852.760153394806;6922.480813938874;6997.860042799217;7036 16:41:59 INFO - PID 5355 | |4;prototype.html;495.0765728373951;502.9974850125749;525.928999585056;529.9364076310843;531.3915566676156;6261.937380626192;6302.369763023696;6330;6343;6353.618782873031;5970.761169553212;6086.72609732562;6121.326654068049;6144.969275153618;6152;4930.679505832128;4931.408231012284;4935.284383764352;4942.357493525837;4953.752312384393;4923.975380123113;4966.553010229079;4985.451600323961;4991.875203119915;4992.8281197679125;4702.952970470303;4922;4935.101269996699;4940.382452193476;4945.950540494585;4899.412070551521;4905.460399356068;4914.11545921734;4919.926201106986;4922.483139270379;4410.7794610269675;4429.269170586849;4443.800028998703;4449.731826429452;4457.420535330419;6040.546958978094;6073.51411887048;6093.69531523422;6095.019118786412;6130.111133885606;5701;5727.312722473288;5773.624714393593;5776.364599894008;5778.508826749731;6447.6131432114225;6483.351664833526;6501.934980650228;6506.7722629708205;6560;4821.156297647897;4897.020595880803;4902.3872015998;4909.926351104737;4912.312276281324;6880.862382752367;6959.8956015659805;6972.825679358057;6981.89527157093;7015.789526314168;4943.579795717333;4946.35697359341;4947.851564453073;4966.081274964144;5026.195808670595;5046.394432668103;5068;5079.898402032012;5098.872528186825;5126.128558145049;5707.914381284284;5726.198332233491;5743.93737158627;5750.837039628188;5765.616252099466;6496.740130394731;6501.707423165969;6560.770373036921;6598.911179655399;6605.537612367184;1683.09113078936;1715.9313627455012;1716.5880188754609;1737.6785294720517;1780.617167309009;1208.5649166300125;1226.1539537719123;1227.6378468351857;1239.7210627608715;1246.7942789439642;5646.560127167546;5648.6893220872425;5666.15007748841;5709.371969083398;5809.14107485609;6584.275729669733;6587.604743715392;6596.472282217411;6600.438962688226;6653;5669.262995810518;5698.686572238566;5705.429457054344;5715.142728590745;5788.652680839163;3565.1104914395414;3574.428091505347;3580.480830279595;3604.801735904498;3621.3843646580144;6473.579217350857;6510.121133646991;6517.706703198368;6561.179852518435;6629.303923088103;6844.93155068443;6868.313168683092;6875.5874647521305;6993.790186294419;7035.92964070363;6432.260290066515;6460.353964603502;6496.285408604956;6563.442107420923;6588.8352791180605;6655.633940133339;6720.932790672031;6793.830154246183;6798.184217893884;6810.046593477016;6566.8358291041195;6689.799306020827;6756.932430675631;6784.864302714017;6815.114035175396;6618.602883826986;6621.5364924454825;6628.950682685826;6632.867342653023;6656.36764507371;4957.454679985271;4972.726500042532;5008.799648014185;5026.874328141826;5033.6476446648385;6628.668566571749;6689.565178263398;6751.358620931003;6787.287334829969;6799.93200067993;6548.279689234276;6564.5076619252795;6611.570247933869;6624.238212605419;6645.60126392418;6171.6297022178815;6426.196725409324;6433.5496515243485;6540.182477190351;6587;5915.467607915309;6389.2971773105855;6427.228732551936;6459.515536334699;6527;6511.381418765399;6557.606543607399;6599.5050371223315;6625.768098116543;6642.701078451385;6344.524160688059;6356.2054743157105;6366.363363663597;6411.198600174978;6447.742090316335 16:41:59 INFO - PID 5355 | |5;yui.html;869.356676059716;879.8064425826318;893.2005854759994;896.896856861461;897.2732087009523;18490.722639160405;19254;19279.710804337945;19284.228630854785;19304.806951930477;17062.317507299726;18836.811631883676;21343.57312853742;21529.354119376403;21550.784492155075;1031.1802117316752;1058.2327812336034;1060.4061725433744;1062.1661995333664;1063.3301020357164;966.5602151021303;1014.9596663420017;1063.0432610650398;1063.7181146996052;1063.8404239364118;1117.5418078587782;1120.882307357728;1130.7908037013178;1131.3947038334493;1131.5869707556724;1108.578740078765;1111.9110471162287;1116.1684545013936;1117.2402766119035;1121.1031175059961;820.2699597358355;823.6417158536055;826.4958375391006;827.0447632983913;827.7971896885301;19629;19666.606667866563;19928.80071199284;20004.199832006703;20089.095990680453;22120.89395530233;22431.775682243133;22518.66222006671;22619.208327708453;22712.65931011036;17135.48593542196;17322.653546929116;17327.802652530525;17335.913320433316;17565.56086097845;3576.910577235564;3576.946345804815;3604.1530240393486;3606.1886075633033;3609.2601016791496;121761;125903.37048314791;126311;127196.36401817932;128641.35679321544;17381;17769.7334539982;18078.276868925095;18368.816311836712;18404.907975460304;32071;32828.835855821046;32862.671373285964;33353.66646333506;33599.49600755991;8727.738167854848;8966;8979.191872731486;8991.685291014783;8994.685186018458;4082.244784714778;4155.771432571177;4163.208990291835;4177.958220417757;4179.435776170239;5221.843344699665;5299.39057008449;5384;5396.568274538106;5400.83797486076;977.745786095606;1046.4506134279563;1054.1092776603757;1054.7626783973544;1056.99471502642;632.8417895526119;642.2036674523557;643.1606753187135;651.0754728285846;663.9236487803868;11869.694333623294;12446.31545265001;12762.10665253442;12982.221066736027;13289.867101328862;700.457145712067;702.596007295807;706.5901776969346;706.8586282743472;715.896195051725;5625.493705566519;5633.254858146111;5693.459121383462;5757.510611597977;5829.067349224104;101644.49177754064;108652.45673771738;111294;113176.43411783053;113449.43275283571;93117;93180.53409732907;94779.52610237042;95640;95692;83966;86463;87040.69438958421;89428;89490;12937.547185848827;13126.803097953729;13301.66745831362;13313.400896959467;13415.731685366432;38765;39522;39612.207755845295;39981.60018399779;40194.59805401909;48315;48993.75503122462;48998;49647.751761240965;51042.74478627732;19638.410847674593;19743.506412339808;20138.496537586678;20150.39548813538;20193.798062019192;22055.22806701758;22197.778022219572;22258.88870555637;22459.663105053765;22620.773792262524;17779.11104444747;18044.188011539776;18855.90572047131;19256.518587035436;19456.319028833925;19610.8038919609;20195.192192312144;20420;20905.790942090993;20993.58012839704;18445.524358051593;18593.2562697496;18999.335023274118;19264.807351926862;19597.31409400664;13769.931150344584;13997.5100871469;14078.718425631634;14080.647983800487;14140.50508232207;14268.64328391757;14490.203038832544;14562.41750329975;14592.854071459149;14597.342139816077 16:41:59 INFO - PID 5355 | __end_tp_report 16:41:59 INFO - PID 5355 | __start_cc_report 16:41:59 INFO - PID 5355 | _x_x_mozilla_cycle_collect,384 16:41:59 INFO - PID 5355 | __end_cc_report 16:41:59 INFO - PID 5355 | __startTimestamp1502926919717__endTimestamp 16:41:59 INFO - PID 5355 | 16:41:59 INFO - PID 5355 | ------- Summary: start ------- 16:41:59 INFO - PID 5355 | Number of tests: 6 16:41:59 INFO - PID 5355 | 16:41:59 INFO - PID 5355 | [#0] dojo.html Cycles:165 Average:6164.76 Median:6476.35 stddev:872.08 (13.5%) stddev-sans-first:841.40 16:41:59 INFO - PID 5355 | Values: 3119.9 3168.5 3204.8 3222.2 3235.4 6129.9 6188.9 6288.2 6319.5 6323.4 6106.3 6231.2 6235.3 6245.6 6259.3 5686.7 5694.5 5697.7 5708.4 5766.4 5721.3 5746.9 5783.9 5791.2 5842.5 101.1 5682.3 5702.9 5838.4 5840.0 5694.7 5721.2 5728.3 5818.4 5820.0 5667.3 5674.3 5746.4 5750.8 5759.1 6129.2 6140.9 6155.0 6218.3 6255.2 6697.6 6701.5 6771.5 6793.4 6812.4 6577.5 6678.8 6707.2 6782.6 6879.8 6290.0 6304.1 6306.4 6319.2 6351.1 6871.2 6906.1 6984.5 6987.1 6989.4 6561.2 6585.0 6603.1 6701.3 6707.4 6542.0 6606.5 6647.4 6754.1 6766.6 6737.3 6746.1 6748.6 6754.9 6775.2 6735.1 6743.6 6807.9 6835.6 6839.8 5409.4 5446.2 5450.8 5533.1 5544.1 4649.9 4685.0 4694.1 4699.2 4712.4 5800.1 5800.9 5823.9 5830.6 5837.6 6750.9 6759.2 6816.6 6834.7 6856.1 5742.5 5784.6 5788.9 5836.6 5847.2 5876.9 5946.8 5976.4 5979.6 5982.4 6525.1 6525.3 6529.2 6529.9 6547.3 6699.6 6704.1 6765.7 6781.5 6795.1 6548.7 6557.4 6567.0 6576.3 6617.7 6604.0 6628.0 6634.1 6704.1 6711.8 6659.1 6762.6 6778.0 6852.8 6853.5 6501.9 6582.2 6583.6 6590.3 6610.0 6571.5 6575.3 6577.4 6579.2 6597.9 6180.5 6462.9 6476.4 6492.5 6541.9 6554.1 6575.7 6580.6 6657.6 6669.5 6296.7 6365.7 6413.6 6460.1 6461.7 16:41:59 INFO - PID 5355 | 16:41:59 INFO - PID 5355 | [#1] ext.html Cycles:180 Average:37180.69 Median:19024.08 stddev:52594.80 (276.5%) stddev-sans-first:52671.14 16:41:59 INFO - PID 5355 | Values: 732.6 809.7 835.2 838.4 1149.8 30098.8 30610.0 40851.6 41703.8 41829.0 41531.8 42050.8 42068.2 42180.6 42280.4 7470.2 7548.9 7665.2 7668.6 7693.7 7455.5 7555.9 7557.1 7558.2 7558.7 7518.4 7526.5 7529.2 7533.3 7568.8 7529.0 7559.7 7566.2 7567.3 7572.5 7490.1 7514.2 7520.0 7546.1 7550.2 37824.0 37878.2 37906.0 38058.0 38149.4 3472.3 3507.1 3515.9 3516.2 3519.3 30471.5 30689.8 30693.0 30706.8 30722.7 4966.2 4997.0 4999.4 5004.7 5023.5 186754.0 188069.0 188915.0 189693.0 189711.0 46643.5 46777.3 46917.0 46922.0 46968.0 49753.5 50015.0 50092.0 50190.0 50219.2 14345.6 16314.5 16546.0 16557.1 16567.8 11955.5 13334.6 13420.5 13439.8 13450.0 14176.2 14243.2 14246.9 14254.3 14360.1 5672.9 5881.2 5883.4 5912.0 5967.4 961.2 993.4 1007.3 1019.2 1022.7 22959.5 23040.7 23163.0 23235.4 23358.3 1112.1 1118.4 1126.6 1129.1 1130.3 12274.0 12296.2 12324.3 12354.6 12360.0 228368.0 228644.0 228770.0 229693.0 230042.0 52162.7 52357.0 52395.7 52432.5 52528.0 1442.8 1461.1 1479.7 1480.2 1495.3 22444.7 22641.9 22759.9 22794.8 22966.3 35731.3 35827.8 35889.8 35928.8 35998.5 188910.0 189026.0 189078.0 189246.0 189308.0 33197.7 34041.0 34530.8 34548.3 34575.8 42967.8 44826.1 44840.3 45088.3 45242.9 33279.7 33289.5 33360.3 33398.5 33767.2 32811.7 33200.3 33224.0 33301.2 33958.0 36541.0 36628.1 37138.4 37883.8 37903.6 33177.5 33277.3 33322.0 33380.7 33566.3 23902.9 24629.3 24632.0 24715.0 24903.1 16:41:59 INFO - PID 5355 | 16:41:59 INFO - PID 5355 | [#2] jquery.html Cycles:180 Average:38815.41 Median:23479.03 stddev:92797.32 (395.2%) stddev-sans-first:93013.19 16:41:59 INFO - PID 5355 | Values: 559.9 562.9 577.9 579.3 582.8 21981.1 22758.0 22778.0 22826.9 22831.0 25975.0 26850.6 28221.6 28279.4 28335.9 6853.6 7028.1 7028.4 7029.7 7031.0 6379.5 6708.0 6712.9 6909.9 6972.0 6649.0 6708.0 6710.0 6710.2 6722.5 6686.7 6691.2 6692.3 6696.7 6714.2 6585.7 6587.5 6589.5 6591.8 6596.5 30485.4 31356.8 31843.0 31921.0 32047.0 1902.8 1934.2 1934.9 1934.9 1935.2 19941.9 20611.3 20678.5 20690.6 20748.5 2413.9 2507.1 2564.3 2573.6 2589.9 136693.0 139136.0 139600.0 139680.0 139851.0 20586.7 22342.3 22575.0 22623.8 23282.7 22849.4 23808.0 42589.4 42783.0 43082.0 10133.4 10388.2 10483.3 10498.9 10517.3 9617.9 9707.0 9739.8 9873.9 9892.3 9201.6 9201.6 9309.9 9310.0 9543.0 2554.3 2560.6 2633.7 2680.4 2757.3 947.9 953.2 969.6 973.9 986.9 20143.8 20201.3 20649.7 20741.8 20778.9 1047.0 1049.8 1052.2 1052.4 1055.8 10996.7 11393.4 13751.2 14146.5 14174.0 534099.0 540905.0 559165.0 566002.0 567082.0 127356.0 132373.0 132501.0 133011.0 134697.0 1261.8 1286.8 1295.6 1297.6 1310.6 21806.3 22710.6 22746.0 22814.7 22836.5 60757.4 61698.0 61879.7 61966.7 63464.0 79815.2 80126.0 80351.2 80420.0 80553.0 20685.8 21122.4 21226.5 21537.8 21574.9 23675.4 23996.2 24096.6 24217.4 24239.5 18808.5 18945.2 19073.5 19283.8 19292.5 16733.7 17043.3 17321.0 17769.9 18425.2 18316.8 19228.2 19325.2 19416.1 19479.9 20509.0 20637.0 20725.3 20764.9 20799.6 18795.0 18868.2 19639.5 19667.6 19891.4 16:41:59 INFO - PID 5355 | 16:41:59 INFO - PID 5355 | [#3] mootools.html Cycles:180 Average:8841.28 Median:2653.05 stddev:6070.06 (228.8%) stddev-sans-first:6060.87 16:41:59 INFO - PID 5355 | Values: 1333.8 1379.3 1397.1 1404.3 1415.8 13966.3 14622.6 14647.1 14678.9 14681.9 13577.0 13978.2 14506.2 14558.6 14586.9 2644.9 2715.6 2721.9 2723.4 2726.6 2565.7 2612.4 2680.8 2681.6 2712.1 2651.9 2654.2 2681.7 2683.1 2683.2 2606.0 2639.4 2644.7 2663.4 2664.4 2504.6 2533.4 2533.9 2550.6 2569.5 14278.1 14402.6 14413.5 14415.0 14415.4 7228.0 7498.5 7513.1 7531.9 7540.1 4881.7 5009.6 5154.8 5167.6 5169.5 1820.9 1838.7 1857.3 1897.4 1910.6 21869.8 22592.5 22762.8 22764.2 22790.5 6676.9 6829.7 6862.3 7019.8 7113.3 19153.4 19174.0 19176.8 19184.4 19220.2 7863.1 8008.2 8011.0 8017.5 8018.4 6770.2 6958.5 6969.7 7036.8 7175.1 5466.6 5608.6 5614.5 5636.2 5648.5 1639.8 1651.4 1672.9 1699.5 1701.1 867.9 881.7 891.5 891.9 896.2 7936.3 8167.5 8196.5 8249.8 8384.7 681.4 954.5 968.0 972.5 980.1 4886.9 5119.6 5161.0 5302.6 5445.9 18031.7 18138.0 18729.0 18739.4 18748.7 19710.5 19981.1 20124.8 20143.4 20154.1 9100.2 9585.8 9926.3 10880.5 11157.8 7856.3 8183.5 8309.8 8392.5 8416.4 16950.8 17345.5 17488.1 17602.6 17907.9 17752.4 17818.4 17869.2 17885.3 18047.7 11088.3 11472.5 11476.3 11479.1 11485.9 12469.1 12525.1 12665.6 12687.2 12690.6 10243.3 10251.2 10359.9 10466.9 10483.9 9830.3 9880.8 9979.6 10066.5 10265.8 9178.7 9555.2 9808.1 9810.9 9862.4 6891.3 6917.9 6954.1 7003.0 7045.1 6826.3 6852.8 6922.5 6997.9 7036.0 16:41:59 INFO - PID 5355 | 16:41:59 INFO - PID 5355 | [#4] prototype.html Cycles:180 Average:5509.20 Median:6094.36 stddev:1553.42 (25.5%) stddev-sans-first:1511.51 16:41:59 INFO - PID 5355 | Values: 495.1 503.0 525.9 529.9 531.4 6261.9 6302.4 6330.0 6343.0 6353.6 5970.8 6086.7 6121.3 6145.0 6152.0 4930.7 4931.4 4935.3 4942.4 4953.8 4924.0 4966.6 4985.5 4991.9 4992.8 4703.0 4922.0 4935.1 4940.4 4946.0 4899.4 4905.5 4914.1 4919.9 4922.5 4410.8 4429.3 4443.8 4449.7 4457.4 6040.5 6073.5 6093.7 6095.0 6130.1 5701.0 5727.3 5773.6 5776.4 5778.5 6447.6 6483.4 6501.9 6506.8 6560.0 4821.2 4897.0 4902.4 4909.9 4912.3 6880.9 6959.9 6972.8 6981.9 7015.8 4943.6 4946.4 4947.9 4966.1 5026.2 5046.4 5068.0 5079.9 5098.9 5126.1 5707.9 5726.2 5743.9 5750.8 5765.6 6496.7 6501.7 6560.8 6598.9 6605.5 1683.1 1715.9 1716.6 1737.7 1780.6 1208.6 1226.2 1227.6 1239.7 1246.8 5646.6 5648.7 5666.2 5709.4 5809.1 6584.3 6587.6 6596.5 6600.4 6653.0 5669.3 5698.7 5705.4 5715.1 5788.7 3565.1 3574.4 3580.5 3604.8 3621.4 6473.6 6510.1 6517.7 6561.2 6629.3 6844.9 6868.3 6875.6 6993.8 7035.9 6432.3 6460.4 6496.3 6563.4 6588.8 6655.6 6720.9 6793.8 6798.2 6810.0 6566.8 6689.8 6756.9 6784.9 6815.1 6618.6 6621.5 6629.0 6632.9 6656.4 4957.5 4972.7 5008.8 5026.9 5033.6 6628.7 6689.6 6751.4 6787.3 6799.9 6548.3 6564.5 6611.6 6624.2 6645.6 6171.6 6426.2 6433.5 6540.2 6587.0 5915.5 6389.3 6427.2 6459.5 6527.0 6511.4 6557.6 6599.5 6625.8 6642.7 6344.5 6356.2 6366.4 6411.2 6447.7 16:41:59 INFO - PID 5355 | 16:41:59 INFO - PID 5355 | [#5] yui.html Cycles:180 Average:23531.48 Median:20194.50 stddev:31207.73 (154.5%) stddev-sans-first:31248.88 16:41:59 INFO - PID 5355 | Values: 869.4 879.8 893.2 896.9 897.3 18490.7 19254.0 19279.7 19284.2 19304.8 17062.3 18836.8 21343.6 21529.4 21550.8 1031.2 1058.2 1060.4 1062.2 1063.3 966.6 1015.0 1063.0 1063.7 1063.8 1117.5 1120.9 1130.8 1131.4 1131.6 1108.6 1111.9 1116.2 1117.2 1121.1 820.3 823.6 826.5 827.0 827.8 19629.0 19666.6 19928.8 20004.2 20089.1 22120.9 22431.8 22518.7 22619.2 22712.7 17135.5 17322.7 17327.8 17335.9 17565.6 3576.9 3576.9 3604.2 3606.2 3609.3 121761.0 125903.4 126311.0 127196.4 128641.4 17381.0 17769.7 18078.3 18368.8 18404.9 32071.0 32828.8 32862.7 33353.7 33599.5 8727.7 8966.0 8979.2 8991.7 8994.7 4082.2 4155.8 4163.2 4178.0 4179.4 5221.8 5299.4 5384.0 5396.6 5400.8 977.7 1046.5 1054.1 1054.8 1057.0 632.8 642.2 643.2 651.1 663.9 11869.7 12446.3 12762.1 12982.2 13289.9 700.5 702.6 706.6 706.9 715.9 5625.5 5633.3 5693.5 5757.5 5829.1 101644.5 108652.5 111294.0 113176.4 113449.4 93117.0 93180.5 94779.5 95640.0 95692.0 83966.0 86463.0 87040.7 89428.0 89490.0 12937.5 13126.8 13301.7 13313.4 13415.7 38765.0 39522.0 39612.2 39981.6 40194.6 48315.0 48993.8 48998.0 49647.8 51042.7 19638.4 19743.5 20138.5 20150.4 20193.8 22055.2 22197.8 22258.9 22459.7 22620.8 17779.1 18044.2 18855.9 19256.5 19456.3 19610.8 20195.2 20420.0 20905.8 20993.6 18445.5 18593.3 18999.3 19264.8 19597.3 13769.9 13997.5 14078.7 14080.6 14140.5 14268.6 14490.2 14562.4 14592.9 14597.3 16:41:59 INFO - PID 5355 | -------- Summary: end -------- 16:41:59 INFO - PID 5355 | 16:42:00 INFO - TEST-INFO | 5355: exit 0 16:42:00 INFO - TEST-OK | dromaeo_css | took 1111640ms 16:42:00 INFO - TEST-START | kraken 16:42:00 INFO - Initialising browser for kraken test... 16:42:00 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:55738/getInfo.html -profile /tmp/tmpsyI1wx/profile 16:42:00 INFO - TEST-INFO | started process 5723 (/builds/slave/test/build/application/firefox/firefox http://localhost:55738/getInfo.html) 16:42:06 INFO - TEST-INFO | 5723: exit 0 16:42:06 INFO - Browser initialized. 16:42:06 INFO - Running cycle 1/1 for kraken test... 16:42:06 INFO - TEST-INFO | started process 5959 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpsyI1wx/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 16:42:07 INFO - PID 5959 | 16:42:07 INFO - PID 5959 | (/builds/slave/test/build/application/firefox/firefox:6013): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 16:42:07 INFO - PID 5959 | 16:42:17 INFO - PID 5959 | RSS: Main: 167333888 16:42:17 INFO - PID 5959 | 16:42:20 INFO - PID 5959 | Cycle 1(1): loaded http://localhost:55738/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:55738/tests/kraken/driver.html?testName=audio-beat-detection) 16:42:21 INFO - PID 5959 | RSS: Main: 174084096 16:42:21 INFO - PID 5959 | 16:42:24 INFO - PID 5959 | Cycle 1(1): loaded http://localhost:55738/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:55738/tests/kraken/driver.html?testName=audio-dft) 16:42:24 INFO - PID 5959 | RSS: Main: 176443392 16:42:24 INFO - PID 5959 | 16:42:27 INFO - PID 5959 | Cycle 1(1): loaded http://localhost:55738/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:55738/tests/kraken/driver.html?testName=audio-fft) 16:42:28 INFO - PID 5959 | RSS: Main: 171180032 16:42:28 INFO - PID 5959 | 16:42:30 INFO - PID 5959 | Cycle 1(1): loaded http://localhost:55738/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:55738/tests/kraken/driver.html?testName=audio-oscillator) 16:42:31 INFO - PID 5959 | RSS: Main: 171839488 16:42:31 INFO - PID 5959 | 16:42:33 INFO - PID 5959 | Cycle 1(1): loaded http://localhost:55738/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:55738/tests/kraken/driver.html?testName=imaging-gaussian-blur) 16:42:34 INFO - PID 5959 | RSS: Main: 171806720 16:42:34 INFO - PID 5959 | 16:42:37 INFO - PID 5959 | Cycle 1(1): loaded http://localhost:55738/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:55738/tests/kraken/driver.html?testName=imaging-darkroom) 16:42:37 INFO - PID 5959 | RSS: Main: 173359104 16:42:37 INFO - PID 5959 | 16:42:41 INFO - PID 5959 | Cycle 1(1): loaded http://localhost:55738/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:55738/tests/kraken/driver.html?testName=imaging-desaturate) 16:42:42 INFO - PID 5959 | RSS: Main: 172560384 16:42:42 INFO - PID 5959 | 16:42:44 INFO - PID 5959 | Cycle 1(1): loaded http://localhost:55738/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:55738/tests/kraken/driver.html?testName=json-parse-financial) 16:42:45 INFO - PID 5959 | RSS: Main: 173449216 16:42:45 INFO - PID 5959 | 16:42:47 INFO - PID 5959 | Cycle 1(1): loaded http://localhost:55738/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:55738/tests/kraken/driver.html?testName=json-stringify-tinderbox) 16:42:47 INFO - PID 5959 | RSS: Main: 173580288 16:42:47 INFO - PID 5959 | 16:42:49 INFO - PID 5959 | Cycle 1(1): loaded http://localhost:55738/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:55738/tests/kraken/driver.html?testName=stanford-crypto-aes) 16:42:50 INFO - PID 5959 | RSS: Main: 173371392 16:42:50 INFO - PID 5959 | 16:42:52 INFO - PID 5959 | Cycle 1(1): loaded http://localhost:55738/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:55738/tests/kraken/driver.html?testName=stanford-crypto-ccm) 16:42:53 INFO - PID 5959 | RSS: Main: 173236224 16:42:53 INFO - PID 5959 | 16:42:55 INFO - PID 5959 | Cycle 1(1): loaded http://localhost:55738/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:55738/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 16:42:56 INFO - PID 5959 | RSS: Main: 173682688 16:42:56 INFO - PID 5959 | 16:42:59 INFO - PID 5959 | Cycle 1(1): loaded http://localhost:55738/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:55738/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 16:43:00 INFO - PID 5959 | RSS: Main: 173850624 16:43:00 INFO - PID 5959 | 16:43:02 INFO - PID 5959 | Cycle 1(1): loaded http://localhost:55738/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:55738/tests/kraken/driver.html?testName=ai-astar) 16:43:02 INFO - PID 5959 | RSS: Main: 175001600 16:43:02 INFO - PID 5959 | 16:43:02 INFO - PID 5959 | __start_tp_report 16:43:02 INFO - PID 5959 | _x_x_mozilla_page_load 16:43:02 INFO - PID 5959 | _x_x_mozilla_page_load_details 16:43:02 INFO - PID 5959 | |i|pagename|runs| 16:43:02 INFO - PID 5959 | |0;ai-astar;102;107;101;107;114;113;111;100;106;107 16:43:02 INFO - PID 5959 | |1;audio-beat-detection;149;130;156;188;117;153;148;120;169;117 16:43:02 INFO - PID 5959 | |2;audio-dft;163;180;162;163;164;166;171;166;164;163 16:43:02 INFO - PID 5959 | |3;audio-fft;78;78;76;173;75;74;74;74;157;77 16:43:02 INFO - PID 5959 | |4;audio-oscillator;79;79;139;78;78;78;131;82;82;128 16:43:02 INFO - PID 5959 | |5;imaging-gaussian-blur;114;121;114;114;124;115;115;124;116;118 16:43:02 INFO - PID 5959 | |6;imaging-darkroom;156;151;150;151;150;150;150;151;151;151 16:43:02 INFO - PID 5959 | |7;imaging-desaturate;102;103;94;93;94;94;96;99;94;94 16:43:02 INFO - PID 5959 | |8;json-parse-financial;52;53;53;54;58;56;56;55;57;53 16:43:02 INFO - PID 5959 | |9;json-stringify-tinderbox;58;60;58;57;59;58;55;54;53;54 16:43:02 INFO - PID 5959 | |10;stanford-crypto-aes;77;76;74;81;77;78;82;75;75;74 16:43:02 INFO - PID 5959 | |11;stanford-crypto-ccm;134;127;127;122;124;138;131;123;120;152 16:43:02 INFO - PID 5959 | |12;stanford-crypto-pbkdf2;185;173;176;178;181;183;172;175;173;171 16:43:02 INFO - PID 5959 | |13;stanford-crypto-sha256-iterative;67;69;71;67;67;68;68;69;68;73 16:43:02 INFO - PID 5959 | __end_tp_report 16:43:02 INFO - PID 5959 | __start_cc_report 16:43:02 INFO - PID 5959 | _x_x_mozilla_cycle_collect,964 16:43:02 INFO - PID 5959 | __end_cc_report 16:43:02 INFO - PID 5959 | __startTimestamp1502926982478__endTimestamp 16:43:02 INFO - PID 5959 | 16:43:02 INFO - PID 5959 | ------- Summary: start ------- 16:43:02 INFO - PID 5959 | Number of tests: 14 16:43:02 INFO - PID 5959 | 16:43:02 INFO - PID 5959 | [#0] ai-astar Cycles:10 Average:106.80 Median:107.00 stddev:4.85 (4.5%) stddev-sans-first:4.82 16:43:02 INFO - PID 5959 | Values: 102.0 107.0 101.0 107.0 114.0 113.0 111.0 100.0 106.0 107.0 16:43:02 INFO - PID 5959 | 16:43:02 INFO - PID 5959 | [#1] audio-beat-detection Cycles:10 Average:144.70 Median:151.00 stddev:23.69 (15.7%) stddev-sans-first:25.08 16:43:02 INFO - PID 5959 | Values: 149.0 130.0 156.0 188.0 117.0 153.0 148.0 120.0 169.0 117.0 16:43:02 INFO - PID 5959 | 16:43:02 INFO - PID 5959 | [#2] audio-dft Cycles:10 Average:166.20 Median:165.00 stddev:5.49 (3.3%) stddev-sans-first:5.70 16:43:02 INFO - PID 5959 | Values: 163.0 180.0 162.0 163.0 164.0 166.0 171.0 166.0 164.0 163.0 16:43:02 INFO - PID 5959 | 16:43:02 INFO - PID 5959 | [#3] audio-fft Cycles:10 Average:93.60 Median:75.50 stddev:37.85 (50.1%) stddev-sans-first:39.72 16:43:02 INFO - PID 5959 | Values: 78.0 78.0 76.0 173.0 75.0 74.0 74.0 74.0 157.0 77.0 16:43:02 INFO - PID 5959 | 16:43:02 INFO - PID 5959 | [#4] audio-oscillator Cycles:10 Average:95.40 Median:78.50 stddev:25.90 (33.0%) stddev-sans-first:26.78 16:43:02 INFO - PID 5959 | Values: 79.0 79.0 139.0 78.0 78.0 78.0 131.0 82.0 82.0 128.0 16:43:02 INFO - PID 5959 | 16:43:02 INFO - PID 5959 | [#5] imaging-gaussian-blur Cycles:10 Average:117.50 Median:117.00 stddev:4.06 (3.5%) stddev-sans-first:4.11 16:43:02 INFO - PID 5959 | Values: 114.0 121.0 114.0 114.0 124.0 115.0 115.0 124.0 116.0 118.0 16:43:02 INFO - PID 5959 | 16:43:02 INFO - PID 5959 | [#6] imaging-darkroom Cycles:10 Average:151.10 Median:151.00 stddev:1.79 (1.2%) stddev-sans-first:0.53 16:43:02 INFO - PID 5959 | Values: 156.0 151.0 150.0 151.0 150.0 150.0 150.0 151.0 151.0 151.0 16:43:02 INFO - PID 5959 | 16:43:02 INFO - PID 5959 | [#7] imaging-desaturate Cycles:10 Average:96.30 Median:94.00 stddev:3.68 (3.9%) stddev-sans-first:3.28 16:43:02 INFO - PID 5959 | Values: 102.0 103.0 94.0 93.0 94.0 94.0 96.0 99.0 94.0 94.0 16:43:02 INFO - PID 5959 | 16:43:02 INFO - PID 5959 | [#8] json-parse-financial Cycles:10 Average:54.70 Median:55.50 stddev:2.00 (3.6%) stddev-sans-first:1.87 16:43:02 INFO - PID 5959 | Values: 52.0 53.0 53.0 54.0 58.0 56.0 56.0 55.0 57.0 53.0 16:43:02 INFO - PID 5959 | 16:43:02 INFO - PID 5959 | [#9] json-stringify-tinderbox Cycles:10 Average:56.60 Median:58.00 stddev:2.41 (4.2%) stddev-sans-first:2.51 16:43:02 INFO - PID 5959 | Values: 58.0 60.0 58.0 57.0 59.0 58.0 55.0 54.0 53.0 54.0 16:43:02 INFO - PID 5959 | 16:43:02 INFO - PID 5959 | [#10] stanford-crypto-aes Cycles:10 Average:76.90 Median:77.00 stddev:2.77 (3.6%) stddev-sans-first:2.93 16:43:02 INFO - PID 5959 | Values: 77.0 76.0 74.0 81.0 77.0 78.0 82.0 75.0 75.0 74.0 16:43:02 INFO - PID 5959 | 16:43:02 INFO - PID 5959 | [#11] stanford-crypto-ccm Cycles:10 Average:129.80 Median:129.00 stddev:9.61 (7.5%) stddev-sans-first:10.07 16:43:02 INFO - PID 5959 | Values: 134.0 127.0 127.0 122.0 124.0 138.0 131.0 123.0 120.0 152.0 16:43:02 INFO - PID 5959 | 16:43:02 INFO - PID 5959 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:176.70 Median:177.00 stddev:4.88 (2.8%) stddev-sans-first:4.15 16:43:02 INFO - PID 5959 | Values: 185.0 173.0 176.0 178.0 181.0 183.0 172.0 175.0 173.0 171.0 16:43:02 INFO - PID 5959 | 16:43:02 INFO - PID 5959 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.70 Median:68.50 stddev:1.95 (2.8%) stddev-sans-first:1.96 16:43:02 INFO - PID 5959 | Values: 67.0 69.0 71.0 67.0 67.0 68.0 68.0 69.0 68.0 73.0 16:43:02 INFO - PID 5959 | -------- Summary: end -------- 16:43:02 INFO - PID 5959 | 16:43:02 INFO - PID 5959 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 16:43:03 INFO - TEST-INFO | 5959: exit 0 16:43:03 INFO - TEST-OK | kraken | took 62676ms 16:43:03 INFO - SUITE-END | took 1174s 16:43:03 INFO - Completed test suite (00:19:34) 16:43:03 INFO - javascript benchmark 16:43:03 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8635.856972698975, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3119.8752049918003, 3168.461361568533, 3204.8237346945916, 3222.2427729483566, 3235.449973504504, 6129.908051379233, 6188.907166392502, 6288.151099601552, 6319.494440444771, 6323.367663233686, 6106.297775755789, 6231.189945307115, 6235.314115447309, 6245.56281060326, 6259.311475737665, 5686.744096515657, 5694.515966142862, 5697.658140511562, 5708.429157084279, 5766.365699773021, 5721.284839395075, 5746.936816688905, 5783.942160578383, 5791.189233507313, 5842.503387212092, 101.05607455006908, 5682.261306030189, 5702.914456283138, 5838.4453476919625, 5839.970800146015, 5694.743736531866, 5721.199032135504, 5728.312602487728, 5818.44724751148, 5819.970900145515, 5667.263255776764, 5674.347450043257, 5746.425357464262, 5750.827475175752, 5759.107338362561, 6129.2032035835055, 6140.907886381708, 6155.045967874987, 6218.347073557302, 6255.155554000197, 6697.631630260334, 6701.463882889406, 6771.525993180479, 6793.4225590824835, 6812.420944219747, 6577.539572229945, 6678.799636010927, 6707.195136583592, 6782.559133656297, 6879.793606191823, 6290.025046117905, 6304.085907543426, 6306.400891915261, 6319.178506794087, 6351.079093531458, 6871.244163142051, 6906.067680863019, 6984.511084224056, 6987.1266091738535, 6989.42737883972, 6561.179852518435, 6585.0, 6603.108580341688, 6701.32986701326, 6707.396334329934, 6542.0, 6606.504512161511, 6647.368499992493, 6754.121964144728, 6766.594004359754, 6737.326267373322, 6746.0892779475125, 6748.628825414649, 6754.864902701918, 6775.22084960226, 6735.090762747064, 6743.629100399525, 6807.863842723118, 6835.58986460814, 6839.760608378683, 5409.377921539073, 5446.2375267462585, 5450.781968721207, 5533.114701647717, 5544.085225937756, 4649.930251046237, 4685.01614660925, 4694.108119457293, 4699.224627936421, 4712.410948631421, 5800.100984347433, 5800.854978625483, 5823.912641310384, 5830.591858569859, 5837.562182836305, 6750.932490675129, 6759.2226893906845, 6816.62508562024, 6834.6582670866255, 6856.142982127234, 5742.54059675225, 5784.595078344475, 5788.88422231553, 5836.620619659793, 5847.210626565359, 5876.9118463223085, 5946.791862284799, 5976.402359763989, 5979.6412215266355, 5982.4017598239825, 6525.119108920235, 6525.347465253437, 6529.249136349285, 6529.902051469232, 6547.345265473415, 6699.631520266432, 6704.061431399706, 6765.695543700447, 6781.457483401217, 6795.116634837439, 6548.705308261235, 6557.377049180321, 6567.047778072249, 6576.309487503743, 6617.702203400762, 6604.042413850061, 6627.966860165669, 6634.137562116894, 6704.094947182263, 6711.798646040626, 6659.101021362054, 6762.594244345355, 6778.017187507882, 6852.760153394607, 6853.520253582401, 6501.902471463027, 6582.210134783665, 6583.63789991555, 6590.275069742421, 6610.008498725229, 6571.507136964651, 6575.309592492719, 6577.440917522064, 6579.17760279965, 6597.868042639025, 6180.505559555135, 6462.903056454251, 6476.352364763486, 6492.480601551959, 6541.901871472027, 6554.14796076507, 6575.736970521126, 6580.638064906476, 6657.567258128206, 6669.46644268467, 6296.716647750954, 6365.681715914093, 6413.551051426542, 6460.127882735958, 6461.676916154268], "value": 6103.6870739116275, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [732.5641243460143, 809.651849704627, 835.1690068381959, 838.3628442383787, 1149.8447709559207, 30098.849505752467, 30610.0, 40851.591484085184, 41703.79148104263, 41829.0, 41531.79234103825, 42050.789746051225, 42068.15863682725, 42180.57819421805, 42280.36579451303, 7470.178280389153, 7548.92451075489, 7665.1951545087795, 7668.578228197447, 7693.692252309901, 7455.515391499563, 7555.886661700079, 7557.130929943072, 7558.168601453835, 7558.735444259452, 7518.360939320137, 7526.5484070955645, 7529.171791102975, 7533.28433798791, 7568.848623027564, 7529.0, 7559.697612095537, 7566.243375662445, 7567.3189412952825, 7572.469927105105, 7490.101187857492, 7514.173440921549, 7519.962400187964, 7546.09446866374, 7550.244975502461, 37824.0, 37878.24243515114, 37906.0, 38058.0, 38149.427758583646, 3472.322897035079, 3507.053095664182, 3515.8769443069627, 3516.208853008078, 3519.260955199411, 30471.542926856117, 30689.846550767328, 30693.0, 30706.84646576775, 30722.69277307243, 4966.2054071348775, 4996.950030499721, 4999.4250661174065, 5004.724740139291, 5023.522765337324, 186754.0, 188069.0, 188915.0, 189693.0, 189711.0, 46643.53356466392, 46777.29834052492, 46917.0, 46922.0, 46968.0, 49753.50246497489, 50015.0, 50092.0, 50190.0, 50219.24671129936, 14345.569632911029, 16314.531692147764, 16546.0, 16557.08936008507, 16567.751483727752, 11955.462004209832, 13334.599962001155, 13420.46318147263, 13439.798403023962, 13450.0, 14176.220307883166, 14243.216623085622, 14246.857531424761, 14254.287285635677, 14360.138391696531, 5672.8865422691315, 5881.206426947166, 5883.352831188566, 5912.0, 5967.40417918207, 961.2214106573698, 993.3940296419179, 1007.3250921882357, 1019.179560453827, 1022.7187523431116, 22959.540809184058, 23040.65439018416, 23163.0, 23235.419114522272, 23358.299251022498, 1112.093643680398, 1118.3848883114254, 1126.5887950897863, 1129.1418521923397, 1130.3048625095507, 12274.0, 12296.20074695142, 12324.260544367367, 12354.567590134482, 12360.0, 228368.0, 228644.0, 228770.0, 229693.0, 230042.0, 52162.739186304585, 52357.0, 52395.73802130965, 52432.47567524352, 52528.0, 1442.783582462639, 1461.13062727679, 1479.7040591881666, 1480.2006916265095, 1495.3121564080427, 22444.663330049734, 22641.886790565943, 22759.88620056889, 22794.772052279266, 22966.311010669706, 35731.285374291845, 35827.82086089657, 35889.82055089708, 35928.8203558991, 35998.4600231002, 188910.0, 189026.0, 189078.0, 189246.0, 189308.0, 33197.66802331946, 34041.0, 34530.82734586411, 34548.30903381868, 34575.82712086423, 42967.785161073996, 44826.10347793091, 44840.32739508845, 45088.323675145555, 45242.86892827574, 33279.66720332862, 33289.500657489676, 33360.33279334448, 33398.49902251517, 33767.15582110467, 32811.671883281815, 33200.33599328048, 33224.0, 33301.16747081342, 33958.0, 36541.0, 36628.08429789277, 37138.44292335563, 37883.81058094692, 37903.62096379001, 33177.50233746544, 33277.334453310315, 33322.00033998984, 33380.666193337755, 33566.328673426884, 23902.880485598158, 24629.261122166365, 24632.0, 24715.0, 24903.128390506245], "value": 17092.336626405762, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [559.941206173352, 562.9014922388584, 577.9046457334542, 579.261441661881, 582.7610679621355, 21981.120755169795, 22758.0, 22778.0, 22826.88586557065, 22831.0, 25975.0, 26850.597241041352, 28221.576676349872, 28279.434411311762, 28335.85832070842, 6853.588784672923, 7028.086348774652, 7028.367446929776, 7029.683664235122, 7030.964845175767, 6379.489640828722, 6708.027336036272, 6712.9328706712795, 6909.930900691004, 6971.965140174318, 6649.0, 6707.966460167692, 6709.966450167743, 6710.228323742784, 6722.462203023746, 6686.732530698766, 6691.230508491537, 6692.297308782557, 6696.732130714766, 6714.227863795677, 6585.736570537173, 6587.505937054692, 6589.505787065989, 6591.835204119888, 6596.538242323039, 30485.390292194254, 31356.843215784003, 31843.0, 31921.042368728977, 32047.0, 1902.7526421565108, 1934.1973081171298, 1934.8839069655726, 1934.9032548372666, 1935.235581945138, 19941.900290498455, 20611.278605248743, 20678.483037924172, 20690.586188276302, 20748.481287967923, 2413.855168689884, 2507.0723832182025, 2564.307636938035, 2573.6396904433395, 2589.8705064746878, 136693.0, 139136.0, 139599.99999999898, 139680.0, 139851.0, 20586.691199632016, 22342.329730108122, 22575.0, 22623.773762262495, 23282.65076023861, 22849.428764281027, 23808.04767809303, 42589.36115958201, 42783.0, 43082.0, 10133.442660653734, 10388.168946484264, 10483.266171367932, 10498.895011049945, 10517.316374435637, 9617.903820961841, 9706.95146524277, 9739.805203896025, 9873.901260987443, 9892.307538472382, 9201.631934722536, 9201.63193472267, 9309.860352094724, 9310.0, 9542.952285238669, 2554.2847753673163, 2560.567460912104, 2633.749793769627, 2680.423708902595, 2757.2968892932577, 947.8957314695378, 953.2040745977187, 969.5927710361665, 973.9286784536953, 986.9062439068277, 20143.798562014486, 20201.292954746514, 20649.69025464589, 20741.79258207429, 20778.896105519376, 1046.984295235572, 1049.7795462952713, 1052.231870734353, 1052.4316868890712, 1055.8152323343384, 10996.670099897015, 11393.430328483542, 13751.174929504261, 14146.504872329419, 14174.0, 534099.0, 540905.0, 559165.0, 566002.0, 567082.0, 127356.0, 132373.0, 132501.0, 133011.0, 134697.0, 1261.829652996852, 1286.8327117474669, 1295.6436979830432, 1297.5847728726906, 1310.6395741171254, 21806.34580962574, 22710.64467766117, 22746.0, 22814.65778013298, 22836.543269134858, 60757.392426075174, 61698.0, 61879.6906015467, 61966.69016654888, 63464.048039278525, 79815.20184798077, 80126.0, 80351.19648803437, 80420.0, 80553.0, 20685.793142068385, 21122.366329010154, 21226.469338266048, 21537.784622154206, 21574.89212553927, 23675.40811479727, 23996.160134395213, 24096.63855042141, 24217.39456513601, 24239.515209695353, 18808.529786754894, 18945.242190312234, 19073.523161921064, 19283.807161928762, 19292.517687057934, 16733.74899376486, 17043.31826726917, 17321.0, 17769.911150444164, 18425.17086731127, 18316.81683183151, 19228.230870765572, 19325.226990920204, 19416.126274317972, 19479.90260048691, 20509.0, 20637.0, 20725.27461538839, 20764.896175519025, 20799.584008320053, 18795.0, 18868.150933207766, 19639.509012274237, 19667.606647867247, 19891.403257902286], "value": 13081.709179842339, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1333.8199343088684, 1379.2827729580617, 1397.0639671420147, 1404.2838152542213, 1415.8371787244464, 13966.301684915752, 14622.56132316031, 14647.121172729643, 14678.853211467882, 14681.926590367046, 13577.0, 13978.231197284145, 14506.202158881284, 14558.636034099127, 14586.927065364685, 2644.854533000684, 2715.592661100831, 2721.9319517012136, 2723.414465889833, 2726.5501192303345, 2565.679290088739, 2612.399148195916, 2680.8123431359813, 2681.6379788728564, 2712.050782226215, 2651.9337016574646, 2654.16393835942, 2681.678198616159, 2683.1011611110303, 2683.221865658966, 2605.986970065147, 2639.432522007768, 2644.735526447359, 2663.400734834666, 2664.427148163154, 2504.561701702213, 2533.40464990727, 2533.9239822805343, 2550.566403711355, 2569.4732579821093, 14278.143311401349, 14402.639934001629, 14413.495527656587, 14415.0, 14415.423383064664, 7228.0, 7498.47510674253, 7513.060867391576, 7531.887021694679, 7540.057492813398, 4881.658283920127, 5009.574186194178, 5154.793808247703, 5167.612429067797, 5169.53474187325, 1820.8816426932208, 1838.7333836593752, 1857.2942281932915, 1897.3928342930267, 1910.6178764247206, 21869.781302187093, 22592.548149036927, 22762.77237227623, 22764.203252886236, 22790.54418911629, 6676.9332306676315, 6829.692663830139, 6862.279460656659, 7019.754308599175, 7113.288671132948, 19153.425397238105, 19174.0, 19176.8082319175, 19184.424467266006, 19220.231190752493, 7863.135055144044, 8008.159143289987, 8011.038675358995, 8017.518948863087, 8018.398620103399, 6770.187577490733, 6958.512904096766, 6969.686364113627, 7036.788896333118, 7175.067241258707, 5466.644668096561, 5608.635438696553, 5614.466625670555, 5636.2391077204875, 5648.491635752802, 1639.753787121796, 1651.4137481194243, 1672.8996260224426, 1699.498647898848, 1701.1154199816274, 867.8524650809252, 881.7046289493092, 891.4517571693492, 891.8840550728364, 896.2068569316071, 7936.3254123399, 8167.509949403055, 8196.508209507449, 8249.752507424786, 8384.700371442435, 681.4241965539112, 954.513198268874, 967.970960871175, 972.5429048347265, 980.07872599756, 4886.926696099561, 5119.6160287978555, 5161.045206636784, 5302.628815982845, 5445.910817836449, 18031.72952405715, 18138.0, 18729.0, 18739.437816865517, 18748.718769218474, 19710.507237319183, 19981.100850461473, 20124.798752012586, 20143.39569812908, 20154.093065812074, 9100.180983711498, 9585.760355991157, 9926.255530835217, 10880.510377032893, 11157.832632510519, 7856.332211761835, 8183.468074575134, 8309.83380332378, 8392.496450213006, 8416.4108512406, 16950.83049169542, 17345.49441786314, 17488.125593720517, 17602.559936001704, 17907.910460447616, 17752.3786667466, 17818.376356827448, 17869.195886185415, 17885.28458861631, 18047.729284060486, 11088.279261847954, 11472.483738231967, 11476.254043487146, 11479.139064570023, 11485.942570287096, 12469.064820138707, 12525.123241373016, 12665.620031399072, 12687.175333603287, 12690.555830545887, 10243.334183278062, 10251.179905607385, 10359.912209218224, 10466.895331046591, 10483.895161048293, 9830.311878168746, 9880.814302283772, 9979.550920208463, 10066.49667516636, 10265.84601230997, 9178.67874624385, 9555.23558115363, 9808.117269445784, 9810.901890980998, 9862.408255504693, 6891.345322194384, 6917.93082069193, 6954.130733658293, 7003.0, 7045.11936007999, 6826.317368263134, 6852.760153394806, 6922.480813938874, 6997.860042799217, 7036.0], "value": 6442.602191060952, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [495.0765728373951, 502.9974850125749, 525.928999585056, 529.9364076310843, 531.3915566676156, 6261.937380626192, 6302.369763023696, 6330.0, 6343.0, 6353.618782873031, 5970.761169553212, 6086.72609732562, 6121.326654068049, 6144.969275153618, 6152.0, 4930.679505832128, 4931.408231012284, 4935.284383764352, 4942.357493525837, 4953.752312384393, 4923.975380123113, 4966.553010229079, 4985.451600323961, 4991.875203119915, 4992.8281197679125, 4702.952970470303, 4922.0, 4935.101269996699, 4940.382452193476, 4945.950540494585, 4899.412070551521, 4905.460399356068, 4914.11545921734, 4919.926201106986, 4922.483139270379, 4410.7794610269675, 4429.269170586849, 4443.800028998703, 4449.731826429452, 4457.420535330419, 6040.546958978094, 6073.51411887048, 6093.69531523422, 6095.019118786412, 6130.111133885606, 5701.0, 5727.312722473288, 5773.624714393593, 5776.364599894008, 5778.508826749731, 6447.6131432114225, 6483.351664833526, 6501.934980650228, 6506.7722629708205, 6560.0, 4821.156297647897, 4897.020595880803, 4902.3872015998, 4909.926351104737, 4912.312276281324, 6880.862382752367, 6959.8956015659805, 6972.825679358057, 6981.89527157093, 7015.789526314168, 4943.579795717333, 4946.35697359341, 4947.851564453073, 4966.081274964144, 5026.195808670595, 5046.394432668103, 5068.0, 5079.898402032012, 5098.872528186825, 5126.128558145049, 5707.914381284284, 5726.198332233491, 5743.93737158627, 5750.837039628188, 5765.616252099466, 6496.740130394731, 6501.707423165969, 6560.770373036921, 6598.911179655399, 6605.537612367184, 1683.09113078936, 1715.9313627455012, 1716.5880188754609, 1737.6785294720517, 1780.617167309009, 1208.5649166300125, 1226.1539537719123, 1227.6378468351857, 1239.7210627608715, 1246.7942789439642, 5646.560127167546, 5648.6893220872425, 5666.15007748841, 5709.371969083398, 5809.14107485609, 6584.275729669733, 6587.604743715392, 6596.472282217411, 6600.438962688226, 6653.0, 5669.262995810518, 5698.686572238566, 5705.429457054344, 5715.142728590745, 5788.652680839163, 3565.1104914395414, 3574.428091505347, 3580.480830279595, 3604.801735904498, 3621.3843646580144, 6473.579217350857, 6510.121133646991, 6517.706703198368, 6561.179852518435, 6629.303923088103, 6844.93155068443, 6868.313168683092, 6875.5874647521305, 6993.790186294419, 7035.92964070363, 6432.260290066515, 6460.353964603502, 6496.285408604956, 6563.442107420923, 6588.8352791180605, 6655.633940133339, 6720.932790672031, 6793.830154246183, 6798.184217893884, 6810.046593477016, 6566.8358291041195, 6689.799306020827, 6756.932430675631, 6784.864302714017, 6815.114035175396, 6618.602883826986, 6621.5364924454825, 6628.950682685826, 6632.867342653023, 6656.36764507371, 4957.454679985271, 4972.726500042532, 5008.799648014185, 5026.874328141826, 5033.6476446648385, 6628.668566571749, 6689.565178263398, 6751.358620931003, 6787.287334829969, 6799.93200067993, 6548.279689234276, 6564.5076619252795, 6611.570247933869, 6624.238212605419, 6645.60126392418, 6171.6297022178815, 6426.196725409324, 6433.5496515243485, 6540.182477190351, 6587.0, 5915.467607915309, 6389.2971773105855, 6427.228732551936, 6459.515536334699, 6527.0, 6511.381418765399, 6557.606543607399, 6599.5050371223315, 6625.768098116543, 6642.701078451385, 6344.524160688059, 6356.2054743157105, 6366.363363663597, 6411.198600174978, 6447.742090316335], "value": 5053.07293370483, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [869.356676059716, 879.8064425826318, 893.2005854759994, 896.896856861461, 897.2732087009523, 18490.722639160405, 19254.0, 19279.710804337945, 19284.228630854785, 19304.806951930477, 17062.317507299726, 18836.811631883676, 21343.57312853742, 21529.354119376403, 21550.784492155075, 1031.1802117316752, 1058.2327812336034, 1060.4061725433744, 1062.1661995333664, 1063.3301020357164, 966.5602151021303, 1014.9596663420017, 1063.0432610650398, 1063.7181146996052, 1063.8404239364118, 1117.5418078587782, 1120.882307357728, 1130.7908037013178, 1131.3947038334493, 1131.5869707556724, 1108.578740078765, 1111.9110471162287, 1116.1684545013936, 1117.2402766119035, 1121.1031175059961, 820.2699597358355, 823.6417158536055, 826.4958375391006, 827.0447632983913, 827.7971896885301, 19629.0, 19666.606667866563, 19928.80071199284, 20004.199832006703, 20089.095990680453, 22120.89395530233, 22431.775682243133, 22518.66222006671, 22619.208327708453, 22712.65931011036, 17135.48593542196, 17322.653546929116, 17327.802652530525, 17335.913320433316, 17565.56086097845, 3576.910577235564, 3576.946345804815, 3604.1530240393486, 3606.1886075633033, 3609.2601016791496, 121761.0, 125903.37048314791, 126311.0, 127196.36401817932, 128641.35679321544, 17381.0, 17769.7334539982, 18078.276868925095, 18368.816311836712, 18404.907975460304, 32071.0, 32828.835855821046, 32862.671373285964, 33353.66646333506, 33599.49600755991, 8727.738167854848, 8966.0, 8979.191872731486, 8991.685291014783, 8994.685186018458, 4082.244784714778, 4155.771432571177, 4163.208990291835, 4177.958220417757, 4179.435776170239, 5221.843344699665, 5299.39057008449, 5384.0, 5396.568274538106, 5400.83797486076, 977.745786095606, 1046.4506134279563, 1054.1092776603757, 1054.7626783973544, 1056.99471502642, 632.8417895526119, 642.2036674523557, 643.1606753187135, 651.0754728285846, 663.9236487803868, 11869.694333623294, 12446.31545265001, 12762.10665253442, 12982.221066736027, 13289.867101328862, 700.457145712067, 702.596007295807, 706.5901776969346, 706.8586282743472, 715.896195051725, 5625.493705566519, 5633.254858146111, 5693.459121383462, 5757.510611597977, 5829.067349224104, 101644.49177754064, 108652.45673771738, 111294.0, 113176.43411783053, 113449.43275283571, 93117.0, 93180.53409732907, 94779.52610237042, 95640.0, 95692.0, 83966.0, 86463.0, 87040.69438958421, 89428.0, 89490.0, 12937.547185848827, 13126.803097953729, 13301.66745831362, 13313.400896959467, 13415.731685366432, 38765.0, 39522.0, 39612.207755845295, 39981.60018399779, 40194.59805401909, 48315.0, 48993.75503122462, 48998.0, 49647.751761240965, 51042.74478627732, 19638.410847674593, 19743.506412339808, 20138.496537586678, 20150.39548813538, 20193.798062019192, 22055.22806701758, 22197.778022219572, 22258.88870555637, 22459.663105053765, 22620.773792262524, 17779.11104444747, 18044.188011539776, 18855.90572047131, 19256.518587035436, 19456.319028833925, 19610.8038919609, 20195.192192312144, 20420.0, 20905.790942090993, 20993.58012839704, 18445.524358051593, 18593.2562697496, 18999.335023274118, 19264.807351926862, 19597.31409400664, 13769.931150344584, 13997.5100871469, 14078.718425631634, 14080.647983800487, 14140.50508232207, 14268.64328391757, 14490.203038832544, 14562.41750329975, 14592.854071459149, 14597.342139816077], "value": 9335.330155887203, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1535.0, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [102.0, 107.0, 101.0, 107.0, 114.0, 113.0, 111.0, 100.0, 106.0, 107.0], "value": 106.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 130.0, 156.0, 188.0, 117.0, 153.0, 148.0, 120.0, 169.0, 117.0], "value": 144.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 180.0, 162.0, 163.0, 164.0, 166.0, 171.0, 166.0, 164.0, 163.0], "value": 166.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 78.0, 76.0, 173.0, 75.0, 74.0, 74.0, 74.0, 157.0, 77.0], "value": 93.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 79.0, 139.0, 78.0, 78.0, 78.0, 131.0, 82.0, 82.0, 128.0], "value": 95.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 121.0, 114.0, 114.0, 124.0, 115.0, 115.0, 124.0, 116.0, 118.0], "value": 117.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [156.0, 151.0, 150.0, 151.0, 150.0, 150.0, 150.0, 151.0, 151.0, 151.0], "value": 151.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [102.0, 103.0, 94.0, 93.0, 94.0, 94.0, 96.0, 99.0, 94.0, 94.0], "value": 96.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [52.0, 53.0, 53.0, 54.0, 58.0, 56.0, 56.0, 55.0, 57.0, 53.0], "value": 54.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 60.0, 58.0, 57.0, 59.0, 58.0, 55.0, 54.0, 53.0, 54.0], "value": 56.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 76.0, 74.0, 81.0, 77.0, 78.0, 82.0, 75.0, 75.0, 74.0], "value": 76.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [134.0, 127.0, 127.0, 122.0, 124.0, 138.0, 131.0, 123.0, 120.0, 152.0], "value": 129.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [185.0, 173.0, 176.0, 178.0, 181.0, 183.0, 172.0, 175.0, 173.0, 171.0], "value": 176.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 69.0, 71.0, 67.0, 67.0, 68.0, 68.0, 69.0, 68.0, 73.0], "value": 68.7, "unit": "score"}]}]} 16:43:03 INFO - Return code: 0 16:43:03 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 16:43:03 INFO - # TBPL SUCCESS # 16:43:03 INFO - Running post-action listener: _package_coverage_data 16:43:03 INFO - Running post-action listener: _resource_record_post_action 16:43:03 INFO - [mozharness: 2017-08-16 23:43:03.731595Z] Finished run-tests step (success) 16:43:03 INFO - Running post-run listener: _resource_record_post_run 16:43:03 INFO - Total resource usage - Wall time: 1193s; CPU: 13.0%; Read bytes: 4096; Write bytes: 431112192; Read time: 16; Write time: 524652 16:43:03 INFO - TinderboxPrint: CPU usage
13.2% 16:43:03 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 16 16:43:03 INFO - TinderboxPrint: I/O write bytes / time
431,112,192 / 524,652 16:43:03 INFO - TinderboxPrint: CPU idle
8,258.4 (86.8%) 16:43:03 INFO - TinderboxPrint: CPU user
1,200.5 (12.6%) 16:43:03 INFO - TinderboxPrint: Swap in / out
0 / 0 16:43:03 INFO - install - Wall time: 18s; CPU: 14.0%; Read bytes: 0; Write bytes: 108187648; Read time: 0; Write time: 200904 16:43:03 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 16:43:03 INFO - run-tests - Wall time: 1175s; CPU: 13.0%; Read bytes: 0; Write bytes: 322924544; Read time: 0; Write time: 323748 16:43:04 INFO - Running post-run listener: _upload_blobber_files 16:43:04 INFO - Blob upload gear active. 16:43:04 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 16:43:04 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 16:43:04 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'] 16:43:04 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 16:43:04 INFO - (blobuploader) - INFO - Open directory for files ... 16:43:04 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 16:43:04 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:43:04 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:43:05 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 16:43:05 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:43:05 INFO - (blobuploader) - INFO - Done attempting. 16:43:05 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 16:43:05 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:43:05 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:43:12 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 16:43:12 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:43:12 INFO - (blobuploader) - INFO - Done attempting. 16:43:12 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 16:43:12 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:43:12 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:43:13 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 16:43:13 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:43:13 INFO - (blobuploader) - INFO - Done attempting. 16:43:13 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 16:43:13 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:43:13 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:43:13 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 16:43:13 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:43:13 INFO - (blobuploader) - INFO - Done attempting. 16:43:13 INFO - (blobuploader) - INFO - Iteration through files over. 16:43:13 INFO - Return code: 0 16:43:13 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 16:43:13 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 16:43:13 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2038bca5efb48a1e1ef1d5472d95d8d7369ea34df17789a09d345078d456f9e12e5525ee386fedd3aa9087ce6aa0d882c989b87be2d27f399cdc6f12e85b9949", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9ad655849fd7e21d4e270691a6915c57900a1739db0817b5fbb02b37217fc5796cc3a1267171e8da880e8c1e57ed765a1d80e023b32d5a22a3bfe407cc797cad", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/247e5417d89695e4e66a33d9049b65c85d369057ba3483cf27e9cbf35b00c1c6cd3fdc235acb1fcb4d6adc4d681cd9f484e4575e0bdd7ae907a4152afe15c87d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/eab6c7d5fe880bbcd2c3990bbca403f1ce80e61c864f27c55da8bd9e007c850556ef3d38ad8973cfe3d3a7f89f2ad1298503f5d8669776f3ffd14edc9fd8d1e4"} 16:43:13 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 16:43:13 INFO - Writing to file /builds/slave/test/properties/blobber_files 16:43:13 INFO - Contents: 16:43:13 INFO - blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2038bca5efb48a1e1ef1d5472d95d8d7369ea34df17789a09d345078d456f9e12e5525ee386fedd3aa9087ce6aa0d882c989b87be2d27f399cdc6f12e85b9949", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9ad655849fd7e21d4e270691a6915c57900a1739db0817b5fbb02b37217fc5796cc3a1267171e8da880e8c1e57ed765a1d80e023b32d5a22a3bfe407cc797cad", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/247e5417d89695e4e66a33d9049b65c85d369057ba3483cf27e9cbf35b00c1c6cd3fdc235acb1fcb4d6adc4d681cd9f484e4575e0bdd7ae907a4152afe15c87d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/eab6c7d5fe880bbcd2c3990bbca403f1ce80e61c864f27c55da8bd9e007c850556ef3d38ad8973cfe3d3a7f89f2ad1298503f5d8669776f3ffd14edc9fd8d1e4"} 16:43:13 INFO - Running post-run listener: copy_logs_to_upload_dir 16:43:13 INFO - Copying logs to upload dir... 16:43:13 INFO - mkdir: /builds/slave/test/build/upload/logs 16:43:13 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1254.189951 ========= master_lag: 0.49 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 54 secs) (at 2017-08-16 16:43:13.459840) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-08-16 16:43:13.464486) ========= 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=5c37b704b588aaa989324530000001d0-1502925633.748835-531335602 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/2038bca5efb48a1e1ef1d5472d95d8d7369ea34df17789a09d345078d456f9e12e5525ee386fedd3aa9087ce6aa0d882c989b87be2d27f399cdc6f12e85b9949", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9ad655849fd7e21d4e270691a6915c57900a1739db0817b5fbb02b37217fc5796cc3a1267171e8da880e8c1e57ed765a1d80e023b32d5a22a3bfe407cc797cad", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/247e5417d89695e4e66a33d9049b65c85d369057ba3483cf27e9cbf35b00c1c6cd3fdc235acb1fcb4d6adc4d681cd9f484e4575e0bdd7ae907a4152afe15c87d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/eab6c7d5fe880bbcd2c3990bbca403f1ce80e61c864f27c55da8bd9e007c850556ef3d38ad8973cfe3d3a7f89f2ad1298503f5d8669776f3ffd14edc9fd8d1e4"} build_url:https://queue.taskcluster.net/v1/task/MwNIxikqQeW7ZnNry6c34A/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011135 build_url: 'https://queue.taskcluster.net/v1/task/MwNIxikqQeW7ZnNry6c34A/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2038bca5efb48a1e1ef1d5472d95d8d7369ea34df17789a09d345078d456f9e12e5525ee386fedd3aa9087ce6aa0d882c989b87be2d27f399cdc6f12e85b9949", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9ad655849fd7e21d4e270691a6915c57900a1739db0817b5fbb02b37217fc5796cc3a1267171e8da880e8c1e57ed765a1d80e023b32d5a22a3bfe407cc797cad", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/247e5417d89695e4e66a33d9049b65c85d369057ba3483cf27e9cbf35b00c1c6cd3fdc235acb1fcb4d6adc4d681cd9f484e4575e0bdd7ae907a4152afe15c87d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/eab6c7d5fe880bbcd2c3990bbca403f1ce80e61c864f27c55da8bd9e007c850556ef3d38ad8973cfe3d3a7f89f2ad1298503f5d8669776f3ffd14edc9fd8d1e4"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-08-16 16:43:13.493935) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-08-16 16:43:13.494239) ========= 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=5c37b704b588aaa989324530000001d0-1502925633.748835-531335602 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004493 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-08-16 16:43:13.577231) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-08-16 16:43:13.577558) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-08-16 16:43:13.577875) ========= ========= Total master_lag: 0.71 =========