builder: cedar_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-019 starttime: 1501629598.32 results: success (0) revision: e830c6a105c7e266b710bd9f0eb76c501394f9b9 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-08-01 16:19:58.319537) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-08-01 16:19:58.319917) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-08-01 16:19:58.320176) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-08-01 16:19:58.351680) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-01 16:19:58.351926) ========= 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=78329bfc0fd5309db0a6e0ac000001b4-1501626263.871003-2094513666 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-08-01 16:19:58-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 47.4M=0s 2017-08-01 16:19:58 (47.4 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.128226 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-01 16:19:58.496328) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-08-01 16:19:58.499607) ========= 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=78329bfc0fd5309db0a6e0ac000001b4-1501626263.871003-2094513666 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014536 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-08-01 16:19:58.548996) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-01 16:19:58.549293) ========= bash -c 'python archiver_client.py mozharness --repo projects/cedar --rev e830c6a105c7e266b710bd9f0eb76c501394f9b9 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'python archiver_client.py mozharness --repo projects/cedar --rev e830c6a105c7e266b710bd9f0eb76c501394f9b9 --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=78329bfc0fd5309db0a6e0ac000001b4-1501626263.871003-2094513666 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-08-01 16:19:58,655 truncating revision to first 12 chars 2017-08-01 16:19:58,655 Setting DEBUG logging. 2017-08-01 16:19:58,655 attempt 1/10 2017-08-01 16:19:58,655 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/projects/cedar/e830c6a105c7?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-08-01 16:19:59,117 unpacking tar archive at: cedar-e830c6a105c7/testing/mozharness/ program finished with exit code 0 elapsedTime=0.790533 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-01 16:19:59.353147) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-08-01 16:19:59.353466) ========= script_repo_revision: e830c6a105c7e266b710bd9f0eb76c501394f9b9 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-08-01 16:19:59.354924) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-08-01 16:19:59.355191) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-08-01 16:19:59.364951) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 57 secs) (at 2017-08-01 16:19:59.365209) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Cedar --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Cedar 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', 'Cedar', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Cedar'] 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=78329bfc0fd5309db0a6e0ac000001b4-1501626263.871003-2094513666 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 16:19:59 INFO - MultiFileLogger online at 20170801 16:19:59 in /builds/slave/test 16:19:59 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Cedar --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Cedar 16:19:59 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 16:19:59 INFO - {'append_to_log': False, 16:19:59 INFO - 'base_work_dir': '/builds/slave/test', 16:19:59 INFO - 'blob_upload_branch': 'Cedar', 16:19:59 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 16:19:59 INFO - 'branch': 'Cedar', 16:19:59 INFO - 'buildbot_json_path': 'buildprops.json', 16:19:59 INFO - 'code_coverage': False, 16:19:59 INFO - 'config_files': ('talos/linux_config.py',), 16:19:59 INFO - 'default_actions': ('clobber', 16:19:59 INFO - 'read-buildbot-config', 16:19:59 INFO - 'download-and-extract', 16:19:59 INFO - 'populate-webroot', 16:19:59 INFO - 'create-virtualenv', 16:19:59 INFO - 'install', 16:19:59 INFO - 'setup-mitmproxy', 16:19:59 INFO - 'run-tests'), 16:19:59 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 16:19:59 INFO - 'disable_ccov_upload': False, 16:19:59 INFO - 'download_minidump_stackwalk': True, 16:19:59 INFO - 'download_symbols': 'ondemand', 16:19:59 INFO - 'enable_stylo': False, 16:19:59 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 16:19:59 INFO - 'tooltool.py': '/tools/tooltool.py', 16:19:59 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 16:19:59 INFO - '/tools/misc-python/virtualenv.py')}, 16:19:59 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 16:19:59 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 16:19:59 INFO - 'gecko_profile': False, 16:19:59 INFO - 'gecko_profile_interval': 0, 16:19:59 INFO - 'installer_path': 'installer.exe', 16:19:59 INFO - 'log_level': 'info', 16:19:59 INFO - 'log_name': 'talos', 16:19:59 INFO - 'log_to_console': True, 16:19:59 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 16:19:59 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 16:19:59 INFO - 'opt_config_files': (), 16:19:59 INFO - 'pip_index': False, 16:19:59 INFO - 'suite': 'dromaeojs-e10s', 16:19:59 INFO - 'system_bits': '32', 16:19:59 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 16:19:59 INFO - 'title': 'talos-linux64-ix-019', 16:19:59 INFO - 'tooltool_cache': '/builds/tooltool_cache', 16:19:59 INFO - 'use_talos_json': True, 16:19:59 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 16:19:59 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 16:19:59 INFO - 'work_dir': 'build'} 16:19:59 INFO - [mozharness: 2017-08-01 23:19:59.571358Z] Running clobber step. 16:19:59 INFO - Running pre-action listener: _resource_record_pre_action 16:19:59 INFO - Running main action method: clobber 16:19:59 INFO - rmtree: /builds/slave/test/build 16:19:59 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 16:20:00 INFO - Running post-action listener: _resource_record_post_action 16:20:00 INFO - [mozharness: 2017-08-01 23:20:00.600597Z] Finished clobber step (success) 16:20:00 INFO - [mozharness: 2017-08-01 23:20:00.600700Z] Running read-buildbot-config step. 16:20:00 INFO - Running pre-action listener: _resource_record_pre_action 16:20:00 INFO - Running main action method: read_buildbot_config 16:20:00 INFO - Using buildbot properties: 16:20:00 INFO - { 16:20:00 INFO - "project": "", 16:20:00 INFO - "product": "firefox", 16:20:00 INFO - "who": "mconley@mozilla.com", 16:20:00 INFO - "installer_path": "public/build/target.tar.bz2", 16:20:00 INFO - "builddir": "cedar_ubuntu64_hw_test-dromaeojs-e10s", 16:20:00 INFO - "repository": "https://hg.mozilla.org/projects/cedar", 16:20:00 INFO - "buildername": "Ubuntu HW 12.04 x64 cedar talos dromaeojs-e10s", 16:20:00 INFO - "stage_platform": "linux64", 16:20:00 INFO - "basedir": "/builds/slave/test", 16:20:00 INFO - "buildnumber": 3, 16:20:00 INFO - "platform": "ubuntu64_hw", 16:20:00 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 16:20:00 INFO - "slavebuilddir": "test", 16:20:00 INFO - "taskId": "Lbh9uBG5Q4KbeLf1y57ztQ", 16:20:00 INFO - "branch": "cedar", 16:20:00 INFO - "script_repo_revision": "default", 16:20:00 INFO - "revision": "e830c6a105c7e266b710bd9f0eb76c501394f9b9", 16:20:00 INFO - "slavename": "talos-linux64-ix-019", 16:20:00 INFO - "repo_path": "projects/cedar" 16:20:00 INFO - } 16:20:00 INFO - Finding installer, test and symbols from parent task. 16:20:00 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Lbh9uBG5Q4KbeLf1y57ztQ'}, attempt #1 16:20:01 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Lbh9uBG5Q4KbeLf1y57ztQ'}, attempt #1 16:20:01 INFO - Task dependencies: e43m8dL_TlaSsgPPmNYEzw 16:20:01 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/e43m8dL_TlaSsgPPmNYEzw'}, attempt #1 16:20:01 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/e43m8dL_TlaSsgPPmNYEzw/artifacts/public/build/target.tar.bz2 16:20:01 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/e43m8dL_TlaSsgPPmNYEzw/artifacts/public/build/target.test_packages.json 16:20:01 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/e43m8dL_TlaSsgPPmNYEzw/artifacts/public/build/target.crashreporter-symbols.zip 16:20:01 INFO - Running post-action listener: _resource_record_post_action 16:20:01 INFO - [mozharness: 2017-08-01 23:20:01.957811Z] Finished read-buildbot-config step (success) 16:20:01 INFO - [mozharness: 2017-08-01 23:20:01.958032Z] Running download-and-extract step. 16:20:01 INFO - Running pre-action listener: _resource_record_pre_action 16:20:01 INFO - Running main action method: download_and_extract 16:20:01 INFO - mkdir: /builds/slave/test/build/tests 16:20: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:20:01 INFO - trying https://queue.taskcluster.net/v1/task/e43m8dL_TlaSsgPPmNYEzw/artifacts/public/build/target.test_packages.json 16:20:01 INFO - Downloading https://queue.taskcluster.net/v1/task/e43m8dL_TlaSsgPPmNYEzw/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 16:20:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/e43m8dL_TlaSsgPPmNYEzw/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 16:20:02 INFO - Downloaded 989 bytes. 16:20:02 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 16:20:02 INFO - Using the following test package requirements: 16:20:02 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 16:20:02 INFO - u'common': [u'target.common.tests.zip'], 16:20:02 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 16:20:02 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 16:20:02 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 16:20:02 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 16:20:02 INFO - u'mozbase': [u'target.common.tests.zip'], 16:20:02 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 16:20:02 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 16:20:02 INFO - u'web-platform': [u'target.common.tests.zip', 16:20:02 INFO - u'target.web-platform.tests.tar.gz'], 16:20:02 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 16:20:02 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 16:20:02 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/e43m8dL_TlaSsgPPmNYEzw/artifacts/public/build/target.common.tests.zip 16:20:02 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/e43m8dL_TlaSsgPPmNYEzw/artifacts/public/build/target.common.tests.zip'}, attempt #1 16:20:02 INFO - Fetch https://queue.taskcluster.net/v1/task/e43m8dL_TlaSsgPPmNYEzw/artifacts/public/build/target.common.tests.zip into memory 16:20:03 INFO - Content-Length response header: 72390321 16:20:03 INFO - Bytes received: 72390321 16:20:15 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 16:20:15 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/e43m8dL_TlaSsgPPmNYEzw/artifacts/public/build/target.common.tests.zip 16:20:15 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/e43m8dL_TlaSsgPPmNYEzw/artifacts/public/build/target.common.tests.zip'}, attempt #1 16:20:15 INFO - Fetch https://queue.taskcluster.net/v1/task/e43m8dL_TlaSsgPPmNYEzw/artifacts/public/build/target.common.tests.zip into memory 16:20:16 INFO - Content-Length response header: 72390321 16:20:16 INFO - Bytes received: 72390321 16:20:28 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/e43m8dL_TlaSsgPPmNYEzw/artifacts/public/build/target.talos.tests.zip 16:20:28 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/e43m8dL_TlaSsgPPmNYEzw/artifacts/public/build/target.talos.tests.zip'}, attempt #1 16:20:28 INFO - Fetch https://queue.taskcluster.net/v1/task/e43m8dL_TlaSsgPPmNYEzw/artifacts/public/build/target.talos.tests.zip into memory 16:20:29 INFO - Content-Length response header: 14496467 16:20:29 INFO - Bytes received: 14496467 16:20:29 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:20:29 INFO - trying https://queue.taskcluster.net/v1/task/e43m8dL_TlaSsgPPmNYEzw/artifacts/public/build/target.tar.bz2 16:20:29 INFO - Downloading https://queue.taskcluster.net/v1/task/e43m8dL_TlaSsgPPmNYEzw/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 16:20:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/e43m8dL_TlaSsgPPmNYEzw/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 16:20:30 INFO - Downloaded 62116631 bytes. 16:20:30 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/e43m8dL_TlaSsgPPmNYEzw/artifacts/public/build/target.tar.bz2 16:20:30 INFO - mkdir: /builds/slave/test/properties 16:20:30 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 16:20:30 INFO - Writing to file /builds/slave/test/properties/build_url 16:20:30 INFO - Contents: 16:20:30 INFO - build_url:https://queue.taskcluster.net/v1/task/e43m8dL_TlaSsgPPmNYEzw/artifacts/public/build/target.tar.bz2 16:20:30 INFO - Running post-action listener: _resource_record_post_action 16:20:30 INFO - Running post-action listener: set_extra_try_arguments 16:20:30 INFO - [mozharness: 2017-08-01 23:20:30.939399Z] Finished download-and-extract step (success) 16:20:30 INFO - [mozharness: 2017-08-01 23:20:30.939497Z] Running populate-webroot step. 16:20:30 INFO - Running pre-action listener: _resource_record_pre_action 16:20:30 INFO - Running main action method: populate_webroot 16:20:30 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 16:20:30 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 16:20:30 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 16:20:30 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:20:30 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 16:20:30 INFO - 'tests': ['damp', 'tps']}, 16:20:30 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 16:20:30 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 16:20:30 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 16:20:30 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 16:20:30 INFO - 'other-e10s': {'tests': ['a11yr', 16:20:30 INFO - 'ts_paint', 16:20:30 INFO - 'tpaint', 16:20:30 INFO - 'sessionrestore', 16:20:30 INFO - 'sessionrestore_many_windows', 16:20:30 INFO - 'sessionrestore_no_auto_restore', 16:20:30 INFO - 'tabpaint']}, 16:20:30 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 16:20:30 INFO - 'perf-reftest-singletons-e10s': {'tests': ['bloom_basic_singleton']}, 16:20:30 INFO - 'quantum-pageload-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 16:20:30 INFO - 'talos_options': ['--mitmproxy', 16:20:30 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 16:20:30 INFO - '--firstNonBlankPaint'], 16:20:30 INFO - 'tests': ['quantum_pageload_google', 16:20:30 INFO - 'quantum_pageload_youtube', 16:20:30 INFO - 'quantum_pageload_amazon', 16:20:30 INFO - 'quantum_pageload_facebook']}, 16:20:30 INFO - 'quantum-pageload-stylo-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 16:20:30 INFO - 'talos_options': ['--stylo', 16:20:30 INFO - '--mitmproxy', 16:20:30 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 16:20:30 INFO - '--firstNonBlankPaint'], 16:20:30 INFO - 'tests': ['quantum_pageload_google', 16:20:30 INFO - 'quantum_pageload_youtube', 16:20:30 INFO - 'quantum_pageload_amazon', 16:20:30 INFO - 'quantum_pageload_facebook']}, 16:20:30 INFO - 'svgr-e10s': {'tests': ['tsvgx', 16:20:30 INFO - 'tsvgr_opacity', 16:20:30 INFO - 'tart', 16:20:30 INFO - 'tscrollx', 16:20:30 INFO - 'cart', 16:20:30 INFO - 'tsvg_static']}, 16:20:30 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 16:20:30 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 16:20:30 INFO - 'talos_options': ['--stylo', 16:20:30 INFO - '--stylo-threads=1', 16:20:30 INFO - '--mitmproxy', 16:20:30 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 16:20:30 INFO - '--firstNonBlankPaint'], 16:20:30 INFO - 'tests': ['tp6_google', 16:20:30 INFO - 'tp6_youtube', 16:20:30 INFO - 'tp6_amazon', 16:20:30 INFO - 'tp6_facebook']}, 16:20:30 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 16:20:30 INFO - 'talos_options': ['--xperf_path', 16:20:30 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:20:30 INFO - 'tests': ['tp5n']}}} 16:20:30 INFO - Running post-action listener: _resource_record_post_action 16:20:30 INFO - [mozharness: 2017-08-01 23:20:30.948250Z] Finished populate-webroot step (success) 16:20:30 INFO - [mozharness: 2017-08-01 23:20:30.948340Z] Running create-virtualenv step. 16:20:30 INFO - Running pre-action listener: _resource_record_pre_action 16:20:30 INFO - Running main action method: create_virtualenv 16:20:30 INFO - Creating virtualenv /builds/slave/test/build/venv 16:20:30 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:20:30 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 16:20:30 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 16:20:31 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 16:20:31 INFO - Using real prefix '/usr' 16:20:31 INFO - New python executable in /builds/slave/test/build/venv/bin/python 16:20:31 INFO - Installing distribute.............................................................................................................................................................................................done. 16:20:33 INFO - Installing pip.................done. 16:20:33 INFO - Return code: 0 16:20:33 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 16:20:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 16:20:33 INFO - Reading from file tmpfile_stdout 16:20:33 INFO - Output received: 16:20:33 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:20:33 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 16:20:33 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:20:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:20:33 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:20:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:20:33 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 0x22eb1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24b7a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x265ad10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2657eb0>, '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 0x2658db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2659240>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1501626263.871003-2094513666', '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:20:33 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:20:33 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:20:33 INFO - Using env: {'DISPLAY': ':0', 16:20:33 INFO - 'HOME': '/home/cltbld', 16:20:33 INFO - 'LANG': 'en_US.UTF-8', 16:20:33 INFO - 'LANGUAGE': 'en_US:en', 16:20:33 INFO - 'LOGNAME': 'cltbld', 16:20:33 INFO - 'MAIL': '/var/mail/cltbld', 16:20:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:20:33 INFO - 'MOZ_NO_REMOTE': '1', 16:20:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:20:33 INFO - 'NO_EM_RESTART': '1', 16:20:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:20:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:20:33 INFO - 'PWD': '/builds/slave/test', 16:20:33 INFO - 'SHELL': '/bin/bash', 16:20:33 INFO - 'SHLVL': '1', 16:20:33 INFO - 'TERM': 'linux', 16:20:33 INFO - 'TMOUT': '86400', 16:20:33 INFO - 'USER': 'cltbld', 16:20:33 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1501626263.871003-2094513666', 16:20:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:20:33 INFO - '_': '/tools/buildbot/bin/python'} 16:20:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:20:33 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:20:33 INFO - Cleaning up... 16:20:33 INFO - Return code: 0 16:20:33 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 16:20:33 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:20:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:20:33 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:20:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:20:33 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 0x22eb1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24b7a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x265ad10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2657eb0>, '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 0x2658db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2659240>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1501626263.871003-2094513666', '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:20:33 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:20:33 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:20:33 INFO - Using env: {'DISPLAY': ':0', 16:20:33 INFO - 'HOME': '/home/cltbld', 16:20:33 INFO - 'LANG': 'en_US.UTF-8', 16:20:33 INFO - 'LANGUAGE': 'en_US:en', 16:20:33 INFO - 'LOGNAME': 'cltbld', 16:20:33 INFO - 'MAIL': '/var/mail/cltbld', 16:20:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:20:33 INFO - 'MOZ_NO_REMOTE': '1', 16:20:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:20:33 INFO - 'NO_EM_RESTART': '1', 16:20:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:20:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:20:33 INFO - 'PWD': '/builds/slave/test', 16:20:33 INFO - 'SHELL': '/bin/bash', 16:20:33 INFO - 'SHLVL': '1', 16:20:33 INFO - 'TERM': 'linux', 16:20:33 INFO - 'TMOUT': '86400', 16:20:33 INFO - 'USER': 'cltbld', 16:20:33 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1501626263.871003-2094513666', 16:20:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:20:33 INFO - '_': '/tools/buildbot/bin/python'} 16:20:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:20:34 INFO - Downloading/unpacking psutil>=3.1.1 16:20:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:20:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:20:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:20:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:20:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 16:20:35 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:20:35 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:20:35 INFO - Installing collected packages: psutil 16:20:35 INFO - Running setup.py install for psutil 16:20:35 INFO - building 'psutil._psutil_linux' extension 16:20:35 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:20:35 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:20:35 INFO - building 'psutil._psutil_posix' extension 16:20:35 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:20:35 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:20:35 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:20:35 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:20:35 INFO - Successfully installed psutil 16:20:35 INFO - Cleaning up... 16:20:35 INFO - Return code: 0 16:20:35 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 16:20:35 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:20:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:20:35 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:20:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:20:35 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 0x22eb1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24b7a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x265ad10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2657eb0>, '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 0x2658db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2659240>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1501626263.871003-2094513666', '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:20:35 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:20:35 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:20:35 INFO - Using env: {'DISPLAY': ':0', 16:20:35 INFO - 'HOME': '/home/cltbld', 16:20:35 INFO - 'LANG': 'en_US.UTF-8', 16:20:35 INFO - 'LANGUAGE': 'en_US:en', 16:20:35 INFO - 'LOGNAME': 'cltbld', 16:20:35 INFO - 'MAIL': '/var/mail/cltbld', 16:20:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:20:35 INFO - 'MOZ_NO_REMOTE': '1', 16:20:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:20:35 INFO - 'NO_EM_RESTART': '1', 16:20:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:20:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:20:35 INFO - 'PWD': '/builds/slave/test', 16:20:35 INFO - 'SHELL': '/bin/bash', 16:20:35 INFO - 'SHLVL': '1', 16:20:35 INFO - 'TERM': 'linux', 16:20:35 INFO - 'TMOUT': '86400', 16:20:35 INFO - 'USER': 'cltbld', 16:20:35 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1501626263.871003-2094513666', 16:20:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:20:35 INFO - '_': '/tools/buildbot/bin/python'} 16:20:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:20:36 INFO - Downloading/unpacking mozsystemmonitor==0.3 16:20:36 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:20:36 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:20:36 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:20:36 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:20:37 INFO - Downloading mozsystemmonitor-0.3.tar.gz 16:20:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 16:20:37 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 16:20:37 INFO - Installing collected packages: mozsystemmonitor 16:20:37 INFO - Running setup.py install for mozsystemmonitor 16:20:37 INFO - Successfully installed mozsystemmonitor 16:20:37 INFO - Cleaning up... 16:20:37 INFO - Return code: 0 16:20:37 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 16:20:37 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:20:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:20:37 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:20:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:20:37 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 0x22eb1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24b7a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x265ad10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2657eb0>, '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 0x2658db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2659240>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1501626263.871003-2094513666', '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:20:37 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:20:37 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:20:37 INFO - Using env: {'DISPLAY': ':0', 16:20:37 INFO - 'HOME': '/home/cltbld', 16:20:37 INFO - 'LANG': 'en_US.UTF-8', 16:20:37 INFO - 'LANGUAGE': 'en_US:en', 16:20:37 INFO - 'LOGNAME': 'cltbld', 16:20:37 INFO - 'MAIL': '/var/mail/cltbld', 16:20:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:20:37 INFO - 'MOZ_NO_REMOTE': '1', 16:20:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:20:37 INFO - 'NO_EM_RESTART': '1', 16:20:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:20:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:20:37 INFO - 'PWD': '/builds/slave/test', 16:20:37 INFO - 'SHELL': '/bin/bash', 16:20:37 INFO - 'SHLVL': '1', 16:20:37 INFO - 'TERM': 'linux', 16:20:37 INFO - 'TMOUT': '86400', 16:20:37 INFO - 'USER': 'cltbld', 16:20:37 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1501626263.871003-2094513666', 16:20:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:20:37 INFO - '_': '/tools/buildbot/bin/python'} 16:20:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:20:37 INFO - Downloading/unpacking jsonschema==2.5.1 16:20:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:20:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:20:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:20:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:20:38 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 16:20:38 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 16:20:38 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:20:38 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:20:38 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:20:38 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:20:38 INFO - Downloading functools32-3.2.3-2.tar.gz 16:20:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 16:20:38 INFO - warning: no files found matching '*.txt' 16:20:38 INFO - no previously-included directories found matching 'build' 16:20:38 INFO - no previously-included directories found matching 'dist' 16:20:38 INFO - no previously-included directories found matching '.git*' 16:20:38 INFO - Installing collected packages: jsonschema, functools32 16:20:38 INFO - Running setup.py install for functools32 16:20:38 INFO - warning: no files found matching '*.txt' 16:20:38 INFO - no previously-included directories found matching 'build' 16:20:38 INFO - no previously-included directories found matching 'dist' 16:20:38 INFO - no previously-included directories found matching '.git*' 16:20:39 INFO - Successfully installed jsonschema functools32 16:20:39 INFO - Cleaning up... 16:20:39 INFO - Return code: 0 16:20:39 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 16:20:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:20:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:20:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:20:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:20:39 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 0x22eb1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24b7a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x265ad10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2657eb0>, '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 0x2658db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2659240>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1501626263.871003-2094513666', '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:20:39 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:20:39 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:20:39 INFO - Using env: {'DISPLAY': ':0', 16:20:39 INFO - 'HOME': '/home/cltbld', 16:20:39 INFO - 'LANG': 'en_US.UTF-8', 16:20:39 INFO - 'LANGUAGE': 'en_US:en', 16:20:39 INFO - 'LOGNAME': 'cltbld', 16:20:39 INFO - 'MAIL': '/var/mail/cltbld', 16:20:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:20:39 INFO - 'MOZ_NO_REMOTE': '1', 16:20:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:20:39 INFO - 'NO_EM_RESTART': '1', 16:20:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:20:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:20:39 INFO - 'PWD': '/builds/slave/test', 16:20:39 INFO - 'SHELL': '/bin/bash', 16:20:39 INFO - 'SHLVL': '1', 16:20:39 INFO - 'TERM': 'linux', 16:20:39 INFO - 'TMOUT': '86400', 16:20:39 INFO - 'USER': 'cltbld', 16:20:39 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1501626263.871003-2094513666', 16:20:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:20:39 INFO - '_': '/tools/buildbot/bin/python'} 16:20:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:20:39 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 16:20:39 INFO - Cleaning up... 16:20:39 INFO - Return code: 0 16:20:39 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 16:20:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:20:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:20:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:20:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:20:39 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 0x22eb1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24b7a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x265ad10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2657eb0>, '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 0x2658db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2659240>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1501626263.871003-2094513666', '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:20:39 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:20:39 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:20:39 INFO - Using env: {'DISPLAY': ':0', 16:20:39 INFO - 'HOME': '/home/cltbld', 16:20:39 INFO - 'LANG': 'en_US.UTF-8', 16:20:39 INFO - 'LANGUAGE': 'en_US:en', 16:20:39 INFO - 'LOGNAME': 'cltbld', 16:20:39 INFO - 'MAIL': '/var/mail/cltbld', 16:20:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:20:39 INFO - 'MOZ_NO_REMOTE': '1', 16:20:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:20:39 INFO - 'NO_EM_RESTART': '1', 16:20:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:20:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:20:39 INFO - 'PWD': '/builds/slave/test', 16:20:39 INFO - 'SHELL': '/bin/bash', 16:20:39 INFO - 'SHLVL': '1', 16:20:39 INFO - 'TERM': 'linux', 16:20:39 INFO - 'TMOUT': '86400', 16:20:39 INFO - 'USER': 'cltbld', 16:20:39 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1501626263.871003-2094513666', 16:20:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:20:39 INFO - '_': '/tools/buildbot/bin/python'} 16:20:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:20:39 INFO - Downloading/unpacking blobuploader==1.2.4 16:20:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:20:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:20:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:20:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:20:40 INFO - Downloading blobuploader-1.2.4.tar.gz 16:20:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 16:20:40 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 16:20:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:20:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:20:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:20:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:20:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 16:20:40 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 16:20:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:20:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:20:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:20:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:20:41 INFO - Downloading docopt-0.6.1.tar.gz 16:20:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 16:20:41 INFO - Installing collected packages: blobuploader, requests, docopt 16:20:41 INFO - Running setup.py install for blobuploader 16:20:41 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 16:20:41 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 16:20:41 INFO - Running setup.py install for requests 16:20:41 INFO - Running setup.py install for docopt 16:20:41 INFO - Successfully installed blobuploader requests docopt 16:20:41 INFO - Cleaning up... 16:20:41 INFO - Return code: 0 16:20:41 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:20:41 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:20:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:20:41 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:20:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:20:41 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 0x22eb1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24b7a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x265ad10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2657eb0>, '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 0x2658db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2659240>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1501626263.871003-2094513666', '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:20:41 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:20:41 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:20:41 INFO - Using env: {'DISPLAY': ':0', 16:20:41 INFO - 'HOME': '/home/cltbld', 16:20:41 INFO - 'LANG': 'en_US.UTF-8', 16:20:41 INFO - 'LANGUAGE': 'en_US:en', 16:20:41 INFO - 'LOGNAME': 'cltbld', 16:20:41 INFO - 'MAIL': '/var/mail/cltbld', 16:20:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:20:41 INFO - 'MOZ_NO_REMOTE': '1', 16:20:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:20:41 INFO - 'NO_EM_RESTART': '1', 16:20:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:20:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:20:41 INFO - 'PWD': '/builds/slave/test', 16:20:41 INFO - 'SHELL': '/bin/bash', 16:20:41 INFO - 'SHLVL': '1', 16:20:41 INFO - 'TERM': 'linux', 16:20:41 INFO - 'TMOUT': '86400', 16:20:41 INFO - 'USER': 'cltbld', 16:20:41 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1501626263.871003-2094513666', 16:20:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:20:41 INFO - '_': '/tools/buildbot/bin/python'} 16:20:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:20:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:20:41 INFO - Running setup.py (path:/tmp/pip-P6H2mz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:20:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:20:42 INFO - Running setup.py (path:/tmp/pip-wun1pL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:20:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:20:42 INFO - Running setup.py (path:/tmp/pip-RFon91-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:20:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:20:42 INFO - Running setup.py (path:/tmp/pip-PosQd8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:20:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:20:42 INFO - Running setup.py (path:/tmp/pip-CM1TC3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:20:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:20:42 INFO - Running setup.py (path:/tmp/pip-oxxaHO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:20:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:20:42 INFO - Running setup.py (path:/tmp/pip-ahVooZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:20:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:20:42 INFO - Running setup.py (path:/tmp/pip-7QCsM8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:20:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:20:42 INFO - Running setup.py (path:/tmp/pip-zlerU4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:20:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:20:42 INFO - Running setup.py (path:/tmp/pip-elU1gm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:20:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:20:42 INFO - Running setup.py (path:/tmp/pip-bTUuU1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:20:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:20:42 INFO - Running setup.py (path:/tmp/pip-H4lLb2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:20:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:20:42 INFO - Running setup.py (path:/tmp/pip-76Lrcq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:20:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:20:42 INFO - Running setup.py (path:/tmp/pip-GIpQfK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:20:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:20:42 INFO - Running setup.py (path:/tmp/pip-bsrYsx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:20:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:20:43 INFO - Running setup.py (path:/tmp/pip-uui8zt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:20:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:20:43 INFO - Running setup.py (path:/tmp/pip-URZ0Jp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:20:43 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 16:20:43 INFO - Running setup.py install for manifestparser 16:20:43 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 16:20:43 INFO - Running setup.py install for mozcrash 16:20:43 INFO - Running setup.py install for mozdebug 16:20:43 INFO - Running setup.py install for mozdevice 16:20:43 INFO - Installing dm script to /builds/slave/test/build/venv/bin 16:20:43 INFO - Running setup.py install for mozfile 16:20:43 INFO - Running setup.py install for mozhttpd 16:20:43 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 16:20:43 INFO - Running setup.py install for mozinfo 16:20:43 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 16:20:43 INFO - Running setup.py install for mozInstall 16:20:43 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 16:20:43 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 16:20:43 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 16:20:43 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 16:20:43 INFO - Running setup.py install for mozleak 16:20:44 INFO - Running setup.py install for mozlog 16:20:44 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 16:20:44 INFO - Running setup.py install for moznetwork 16:20:44 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 16:20:44 INFO - Running setup.py install for mozprocess 16:20:44 INFO - Running setup.py install for mozprofile 16:20:44 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 16:20:44 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 16:20:44 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 16:20:44 INFO - Running setup.py install for mozrunner 16:20:44 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 16:20:44 INFO - Running setup.py install for mozscreenshot 16:20:44 INFO - Running setup.py install for moztest 16:20:44 INFO - Running setup.py install for mozversion 16:20:44 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 16:20:44 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 16:20:44 INFO - Cleaning up... 16:20:45 INFO - Return code: 0 16:20:45 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:20:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:20:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:20:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:20:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:20:45 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 0x22eb1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24b7a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x265ad10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2657eb0>, '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 0x2658db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2659240>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1501626263.871003-2094513666', '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:20:45 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:20:45 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:20:45 INFO - Using env: {'DISPLAY': ':0', 16:20:45 INFO - 'HOME': '/home/cltbld', 16:20:45 INFO - 'LANG': 'en_US.UTF-8', 16:20:45 INFO - 'LANGUAGE': 'en_US:en', 16:20:45 INFO - 'LOGNAME': 'cltbld', 16:20:45 INFO - 'MAIL': '/var/mail/cltbld', 16:20:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:20:45 INFO - 'MOZ_NO_REMOTE': '1', 16:20:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:20:45 INFO - 'NO_EM_RESTART': '1', 16:20:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:20:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:20:45 INFO - 'PWD': '/builds/slave/test', 16:20:45 INFO - 'SHELL': '/bin/bash', 16:20:45 INFO - 'SHLVL': '1', 16:20:45 INFO - 'TERM': 'linux', 16:20:45 INFO - 'TMOUT': '86400', 16:20:45 INFO - 'USER': 'cltbld', 16:20:45 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1501626263.871003-2094513666', 16:20:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:20:45 INFO - '_': '/tools/buildbot/bin/python'} 16:20:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:20:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:20:45 INFO - Running setup.py (path:/tmp/pip-ZkCUKJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:20:45 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:20:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:20:45 INFO - Running setup.py (path:/tmp/pip-jWIm0k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:20:45 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:20:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:20:45 INFO - Running setup.py (path:/tmp/pip-b7WlnV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:20:45 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:20:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:20:45 INFO - Running setup.py (path:/tmp/pip-6ZBFj3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:20:45 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:20:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:20:45 INFO - Running setup.py (path:/tmp/pip-vbW4W4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:20:45 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:20:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:20:45 INFO - Running setup.py (path:/tmp/pip-iUFoC0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:20:45 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:20:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:20:45 INFO - Running setup.py (path:/tmp/pip-QWtkqP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:20:45 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:20:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:20:45 INFO - Running setup.py (path:/tmp/pip-gI34SU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:20:45 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:20:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:20:45 INFO - Running setup.py (path:/tmp/pip-ldqXeJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:20:45 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:20:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:20:45 INFO - Running setup.py (path:/tmp/pip-ZCgw1a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:20:45 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:20:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:20:45 INFO - Running setup.py (path:/tmp/pip-Gwf4ji-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:20:46 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:20:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:20:46 INFO - Running setup.py (path:/tmp/pip-CmkTa0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:20:46 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:20:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:20:46 INFO - Running setup.py (path:/tmp/pip-RvW1oN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:20:46 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:20:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:20:46 INFO - Running setup.py (path:/tmp/pip-WVhW1S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:20:46 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:20:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:20:46 INFO - Running setup.py (path:/tmp/pip-Ysssok-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:20:46 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:20:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:20:46 INFO - Running setup.py (path:/tmp/pip-xQieYm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:20:46 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:20:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:20:46 INFO - Running setup.py (path:/tmp/pip-GGLC_Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:20:46 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:20:46 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:20:46 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:20:46 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:20:46 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:20:46 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:20:46 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:20:46 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 16:20:46 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:20:46 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:20:46 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:20:46 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:20:47 INFO - Downloading blessings-1.6.tar.gz 16:20:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 16:20:47 INFO - Installing collected packages: blessings 16:20:47 INFO - Running setup.py install for blessings 16:20:47 INFO - Successfully installed blessings 16:20:47 INFO - Cleaning up... 16:20:47 INFO - Return code: 0 16:20:47 INFO - Done creating virtualenv /builds/slave/test/build/venv. 16:20:47 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:20:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:20:47 INFO - Reading from file tmpfile_stdout 16:20:47 INFO - Current package versions: 16:20:47 INFO - argparse == 1.2.1 16:20:47 INFO - blessings == 1.6 16:20:47 INFO - blobuploader == 1.2.4 16:20:47 INFO - docopt == 0.6.1 16:20:47 INFO - functools32 == 3.2.3-2 16:20:47 INFO - jsonschema == 2.5.1 16:20:48 INFO - manifestparser == 1.1 16:20:48 INFO - mozInstall == 1.13 16:20:48 INFO - mozcrash == 1.0 16:20:48 INFO - mozdebug == 0.1 16:20:48 INFO - mozdevice == 0.51 16:20:48 INFO - mozfile == 1.2 16:20:48 INFO - mozhttpd == 0.7 16:20:48 INFO - mozinfo == 0.10 16:20:48 INFO - mozleak == 0.1 16:20:48 INFO - mozlog == 3.5 16:20:48 INFO - moznetwork == 0.27 16:20:48 INFO - mozprocess == 0.25 16:20:48 INFO - mozprofile == 0.28 16:20:48 INFO - mozrunner == 6.13 16:20:48 INFO - mozscreenshot == 0.1 16:20:48 INFO - mozsystemmonitor == 0.3 16:20:48 INFO - moztest == 0.8 16:20:48 INFO - mozversion == 1.4 16:20:48 INFO - psutil == 3.1.1 16:20:48 INFO - requests == 1.2.3 16:20:48 INFO - wsgiref == 0.1.2 16:20:48 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:20: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:20:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:20: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:20:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:20:48 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 0x22eb1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24b7a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x265ad10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2657eb0>, '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 0x2658db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2659240>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1501626263.871003-2094513666', '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:20:48 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:20:48 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:20:48 INFO - Using env: {'DISPLAY': ':0', 16:20:48 INFO - 'HOME': '/home/cltbld', 16:20:48 INFO - 'LANG': 'en_US.UTF-8', 16:20:48 INFO - 'LANGUAGE': 'en_US:en', 16:20:48 INFO - 'LOGNAME': 'cltbld', 16:20:48 INFO - 'MAIL': '/var/mail/cltbld', 16:20:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:20:48 INFO - 'MOZ_NO_REMOTE': '1', 16:20:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:20:48 INFO - 'NO_EM_RESTART': '1', 16:20:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:20:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:20:48 INFO - 'PWD': '/builds/slave/test', 16:20:48 INFO - 'SHELL': '/bin/bash', 16:20:48 INFO - 'SHLVL': '1', 16:20:48 INFO - 'TERM': 'linux', 16:20:48 INFO - 'TMOUT': '86400', 16:20:48 INFO - 'USER': 'cltbld', 16:20:48 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1501626263.871003-2094513666', 16:20:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:20:48 INFO - '_': '/tools/buildbot/bin/python'} 16:20:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:20:48 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:20:48 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:20:48 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:20:48 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:20:48 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:20:48 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:20:48 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:20:48 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:20:48 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:20:48 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 16:20:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:20:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:20:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:20:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:20:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 16:20:49 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:20:49 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:20:49 INFO - Installing collected packages: simplejson 16:20:49 INFO - Running setup.py install for simplejson 16:20:49 INFO - building 'simplejson._speedups' extension 16:20:49 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:20:50 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:20:50 INFO - Successfully installed simplejson 16:20:50 INFO - Cleaning up... 16:20:50 INFO - Return code: 0 16:20:50 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 16:20:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:20:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:20:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:20:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:20:50 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22eb1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24b7a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x265ad10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2657eb0>, '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 0x2658db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2659240>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1501626263.871003-2094513666', '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:20:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 16:20:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 16:20:50 INFO - Using env: {'DISPLAY': ':0', 16:20:50 INFO - 'HOME': '/home/cltbld', 16:20:50 INFO - 'LANG': 'en_US.UTF-8', 16:20:50 INFO - 'LANGUAGE': 'en_US:en', 16:20:50 INFO - 'LOGNAME': 'cltbld', 16:20:50 INFO - 'MAIL': '/var/mail/cltbld', 16:20:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:20:50 INFO - 'MOZ_NO_REMOTE': '1', 16:20:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:20:50 INFO - 'NO_EM_RESTART': '1', 16:20:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:20:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:20:50 INFO - 'PWD': '/builds/slave/test', 16:20:50 INFO - 'SHELL': '/bin/bash', 16:20:50 INFO - 'SHLVL': '1', 16:20:50 INFO - 'TERM': 'linux', 16:20:50 INFO - 'TMOUT': '86400', 16:20:50 INFO - 'USER': 'cltbld', 16:20:50 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1501626263.871003-2094513666', 16:20:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:20:50 INFO - '_': '/tools/buildbot/bin/python'} 16:20:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:20:50 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 16:20:50 INFO - Cleaning up... 16:20:50 INFO - Return code: 0 16:20:50 INFO - Running post-action listener: _resource_record_post_action 16:20:50 INFO - Running post-action listener: _start_resource_monitoring 16:20:50 INFO - Starting resource monitoring. 16:20:50 INFO - [mozharness: 2017-08-01 23:20:50.716367Z] Finished create-virtualenv step (success) 16:20:50 INFO - [mozharness: 2017-08-01 23:20:50.716872Z] Running install step. 16:20:50 INFO - Running pre-action listener: _resource_record_pre_action 16:20:50 INFO - Running main action method: install 16:20:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:20:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:20:50 INFO - Reading from file tmpfile_stdout 16:20:50 INFO - Detecting whether we're running mozinstall >=1.0... 16:20:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 16:20:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 16:20:51 INFO - Reading from file tmpfile_stdout 16:20:51 INFO - Output received: 16:20:51 INFO - Usage: mozinstall [options] installer 16:20:51 INFO - Options: 16:20:51 INFO - -h, --help show this help message and exit 16:20:51 INFO - -d DEST, --destination=DEST 16:20:51 INFO - Directory to install application into. [default: 16:20:51 INFO - "/builds/slave/test"] 16:20:51 INFO - --app=APP Application being installed. [default: firefox] 16:20:51 INFO - mkdir: /builds/slave/test/build/application 16:20:51 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:20:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 16:21:09 INFO - Reading from file tmpfile_stdout 16:21:09 INFO - Output received: 16:21:09 INFO - /builds/slave/test/build/application/firefox/firefox 16:21:09 INFO - Running post-action listener: _resource_record_post_action 16:21:09 INFO - [mozharness: 2017-08-01 23:21:09.096381Z] Finished install step (success) 16:21:09 INFO - [mozharness: 2017-08-01 23:21:09.096637Z] Running setup-mitmproxy step. 16:21:09 INFO - Running pre-action listener: _resource_record_pre_action 16:21:09 INFO - Running main action method: setup_mitmproxy 16:21:09 INFO - Skipping: mitmproxy is not required 16:21:09 INFO - Running post-action listener: _resource_record_post_action 16:21:09 INFO - [mozharness: 2017-08-01 23:21:09.097853Z] Finished setup-mitmproxy step (success) 16:21:09 INFO - [mozharness: 2017-08-01 23:21:09.098076Z] Running run-tests step. 16:21:09 INFO - Running pre-action listener: _resource_record_pre_action 16:21:09 INFO - Running pre-action listener: _set_gcov_prefix 16:21:09 INFO - Running main action method: run_tests 16:21:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 16:21:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 16:21:09 INFO - Python 2.7.3 16:21:09 INFO - Return code: 0 16:21:09 INFO - grabbing minidump binary from tooltool 16:21: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:21:09 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 0x2657eb0>, '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 0x2658db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2659240>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 16:21:09 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:21:09 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:21:09 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:21:09 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 16:21:09 INFO - Return code: 0 16:21:09 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 16:21:09 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 16:21:09 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 16:21:09 INFO - ENV: RUST_BACKTRACE is now 1 16:21:09 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 16:21:09 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 16:21:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Cedar', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/e43m8dL_TlaSsgPPmNYEzw/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-019', '--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:21:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Cedar --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/e43m8dL_TlaSsgPPmNYEzw/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-019 --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:21:09 INFO - Using env: {'DISPLAY': ':0', 16:21:09 INFO - 'HOME': '/home/cltbld', 16:21:09 INFO - 'LANG': 'en_US.UTF-8', 16:21:09 INFO - 'LANGUAGE': 'en_US:en', 16:21:09 INFO - 'LOGNAME': 'cltbld', 16:21:09 INFO - 'MAIL': '/var/mail/cltbld', 16:21:09 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 16:21:09 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 16:21:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:21:09 INFO - 'MOZ_NO_REMOTE': '1', 16:21:09 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 16:21:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:21:09 INFO - 'NO_EM_RESTART': '1', 16:21:09 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:21:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:21:09 INFO - 'PWD': '/builds/slave/test', 16:21:09 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 16:21:09 INFO - 'RUST_BACKTRACE': '1', 16:21:09 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 16:21:09 INFO - 'SHELL': '/bin/bash', 16:21:09 INFO - 'SHLVL': '1', 16:21:09 INFO - 'TERM': 'linux', 16:21:09 INFO - 'TMOUT': '86400', 16:21:09 INFO - 'USER': 'cltbld', 16:21:09 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1501626263.871003-2094513666', 16:21:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:21:09 INFO - '_': '/tools/buildbot/bin/python'} 16:21:09 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Cedar', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/e43m8dL_TlaSsgPPmNYEzw/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-019', '--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:21:09 INFO - mozversion application_buildid: 20170801222629 16:21:09 INFO - mozversion application_changeset: e830c6a105c7e266b710bd9f0eb76c501394f9b9 16:21:09 INFO - mozversion application_display_name: Nightly 16:21:09 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 16:21:09 INFO - mozversion application_name: Firefox 16:21:09 INFO - mozversion application_remotingname: firefox 16:21:09 INFO - mozversion application_repository: https://hg.mozilla.org/projects/cedar 16:21:09 INFO - mozversion application_vendor: Mozilla 16:21:09 INFO - mozversion application_version: 56.0a1 16:21:09 INFO - mozversion platform_buildid: 20170801222629 16:21:09 INFO - mozversion platform_changeset: e830c6a105c7e266b710bd9f0eb76c501394f9b9 16:21:09 INFO - mozversion platform_repository: https://hg.mozilla.org/projects/cedar 16:21:09 INFO - mozversion platform_version: 56.0a1 16:21:09 INFO - using testdate: 1501629669 16:21:09 INFO - actual date: 1501629669 16:21:09 INFO - starting webserver on 'localhost:35870' 16:21:09 INFO - SUITE-START | Running 2 tests 16:21:09 INFO - TEST-START | dromaeo_css 16:21:09 INFO - Initialising browser for dromaeo_css test... 16:21:09 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:35870/getInfo.html -profile /tmp/tmp5r40jZ/profile 16:21:09 INFO - TEST-INFO | started process 19313 (/builds/slave/test/build/application/firefox/firefox http://localhost:35870/getInfo.html) 16:21:15 INFO - TEST-INFO | 19313: exit 0 16:21:16 INFO - Browser initialized. 16:21:16 INFO - Running cycle 1/1 for dromaeo_css test... 16:21:16 INFO - TEST-INFO | started process 19521 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp5r40jZ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 16:21:17 INFO - PID 19521 | 16:21:17 INFO - PID 19521 | (/builds/slave/test/build/application/firefox/firefox:19569): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 16:21:17 INFO - PID 19521 | 16:21:27 INFO - PID 19521 | RSS: Main: 172470272 16:21:27 INFO - PID 19521 | 16:24:27 INFO - PID 19521 | Cycle 1(1): loaded http://localhost:35870/tests/dromaeo/cssquery-dojo.html (next: http://localhost:35870/tests/dromaeo/cssquery-ext.html) 16:24:28 INFO - PID 19521 | RSS: Main: 173678592 16:24:28 INFO - PID 19521 | 16:27:30 INFO - PID 19521 | Cycle 1(1): loaded http://localhost:35870/tests/dromaeo/cssquery-ext.html (next: http://localhost:35870/tests/dromaeo/cssquery-jquery.html) 16:27:31 INFO - PID 19521 | RSS: Main: 169820160 16:27:31 INFO - PID 19521 | 16:30:33 INFO - PID 19521 | Cycle 1(1): loaded http://localhost:35870/tests/dromaeo/cssquery-jquery.html (next: http://localhost:35870/tests/dromaeo/cssquery-mootools.html) 16:30:33 INFO - PID 19521 | RSS: Main: 173592576 16:30:33 INFO - PID 19521 | 16:33:35 INFO - PID 19521 | Cycle 1(1): loaded http://localhost:35870/tests/dromaeo/cssquery-mootools.html (next: http://localhost:35870/tests/dromaeo/cssquery-prototype.html) 16:33:36 INFO - PID 19521 | RSS: Main: 171839488 16:33:36 INFO - PID 19521 | 16:36:39 INFO - PID 19521 | Cycle 1(1): loaded http://localhost:35870/tests/dromaeo/cssquery-prototype.html (next: http://localhost:35870/tests/dromaeo/cssquery-yui.html) 16:36:40 INFO - PID 19521 | RSS: Main: 175050752 16:36:40 INFO - PID 19521 | 16:39:42 INFO - PID 19521 | Cycle 1(1): loaded http://localhost:35870/tests/dromaeo/cssquery-yui.html (next: http://localhost:35870/tests/dromaeo/cssquery-dojo.html) 16:39:42 INFO - PID 19521 | RSS: Main: 175861760 16:39:42 INFO - PID 19521 | 16:39:42 INFO - PID 19521 | __start_tp_report 16:39:42 INFO - PID 19521 | _x_x_mozilla_page_load 16:39:42 INFO - PID 19521 | _x_x_mozilla_page_load_details 16:39:42 INFO - PID 19521 | |i|pagename|runs| 16:39:42 INFO - PID 19521 | |0;dojo.html;3166.984165079176;3185.442547554178;3216.7426605871533;3222.258880457495;3222.484402495601;6213.285472170702;6309.369063093688;6357.078223657567;6387.520935929806;6423.486121110312;6101.267847858252;6184.783532576361;6203.8759224815585;6205.22434695663;6211.782587609435;5705.629134106291;5715.142728590703;5729.026065568843;5740.196372507852;5781.421857814227;5701.315842098954;5763.9711801440935;5771;5800.970995145019;5846.970765146169;5707.5148612368;5770.942290577103;5779.248697669318;5780.393058728836;5841.532677385799;5531.834044978657;5653.236813030229;5740;5761.971190144064;5785.103308987113;5580.358258800249;5590.91613625796;5602.4957753802355;5616.550675945915;5667.603267771257;6100.298465676459;6176.413240742122;6207.751689932443;6245.313015568284;6251.406116418979;6694.899576506356;6701.463882889358;6703.061571380011;6778.966105169492;6792.966035169792;6747.05541224229;6794.422474089708;6796.796096117125;6802.455803535705;6802.65986700663;6237.1891654084675;6251.093591429263;6254.655993920287;6255.218097737783;6264.968675156686;6875.862482750417;6949.826254343682;6959.4432445404245;6966.651667416711;6968.79093627192;6595.8021259362295;6601.603903765789;6603.636799976048;6611.63636000015;6623.370779775913;6638.83402914931;6681.699323530453;6718.49611279156;6718.731250750013;6718.865622687519;6705.396514313735;6714.261431242559;6727.327267273331;6771.052052712625;6771.085903403076;6656.167979002625;6665.300143484864;6682.3317668232785;6732.528722989344;6749.291324410866;5262.315898933114;5351.411344752074;5351.518363347317;5360.758765855546;5367.973160134175;4610.884727881829;4638.072385522909;4680.67235293533;4714.057188562301;4726.952730472652;5757.136429535603;5843.152742852262;5843.415658434207;5872.119182122716;5876.118582212703;6692.933070669231;6702.162229721285;6719.0593316935665;6719.731210751613;6726.630035348005;5763.971180144073;5765.625234359753;5765.769369225268;5776.826695199066;5778.191053252548;5727;5858.2677165354335;5870.73581688825;5874.559408044413;5878.911816322759;6514.934850651528;6573.934260657428;6579.24338701046;6666.133402657623;6673.566218195801;6681.365270299314;6746.831329216809;6765.086713293839;6812.3187681232475;6838.487113466411;6377.23473183221;6486.54594178403;6508.869822603427;6592;6616.536842420985;6653.767118150841;6677.232118306457;6681.76613818514;6682.69927853238;6693.899591506034;6651.467882569286;6805.761798337035;6809.659517024228;6831.521793474409;6844.28135045813;6508.381703738138;6509.869802603826;6609.438197753245;6616.139901812733;6624.436922861611;6415.454686351713;6492.415682588589;6507.349265073455;6590.47276217911;6610.537262391586;6446.871062578628;6449.7097630605795;6452.387023232785;6466.870662586816;6491.318411566717;6449.3873082057125;6522.28254891952;6551.574147680385;6682.9331706682315;6724.7646332378135;6405.167328247298;6430.871382572229;6494;6506.479481641362;6510.804675859732 16:39:42 INFO - PID 19521 | |1;ext.html;872.2585802068241;900.9369344145911;1177.1759768162283;1206.5656363709063;1262.6022802817117;36557.81721091394;39673.20653586926;39751.80124099379;39820.40269395954;39895.601043989554;37348;37666.4350034749;37727.434088488626;37734.4339834902;37786.622133778656;7213.2426095260025;7368.484206105575;7374.705011799549;7374.815629609276;7376.22549632289;7175.103112110986;7270.963645181767;7304;7338;7347.669354879044;7247.528910620819;7279.090113735783;7507.361874240696;7728.922710772877;7743.38052955765;7599.050118735158;7639.19788422216;7701.845963080707;7702.614869256571;7715.189905059944;7463.4029277657655;7583.165851756303;7669.808254793675;7673.733833917397;7683.193264707181;37909;38299.425508617394;38351.61648383508;38483.807580962195;38514.614853851665;3483.1814523586936;3519.595246546629;3535.681788639009;3552.573691157052;3566.286742651454;30650.54024189639;30702.53946190809;30750.84624576885;30954.845225773726;31071;4795.088933102734;4828.686135401188;4850.611951043908;4854.490278520775;4877.975610121926;181290;182282;182722.99999999866;183238;183378;42254.1549169021;43171.78414107909;48814.75592622014;48891.75554122207;48933.510664893605;51711.48288517142;52277.47722522802;52601.210981835306;52644.473555263954;52672.20991685128;15404.075755454485;15528.767068493982;15536.378544858306;15555.688886222439;15563.221838908235;12465.688357791129;12469.002479801595;12487.687807804878;12489.937550312372;12490.250584964931;14137.151770893779;14147.646308842155;14157.787633185511;14247.287635618177;14316;5903.58674892762;5940;6019.187409699634;6032;6041.879162416727;1002.173207104142;1011.4639241202175;1018.760591261053;1021.3208216536069;1023.3399457350116;22936.655950160763;28309.858450708027;28930.27674308159;29109.126726198247;29641.40717185644;1071.6892101290694;1082.2694681090234;1090.465671820802;1105.7290963713942;1120.9047230985295;11968.461419236155;12448.190867593577;12495;12547.309897955518;12636.557720479923;212863;218060;226462;227656;241191;55453;55577.444225558036;56049.71975140098;56091.43908560944;56175.719121404945;1486.791849141121;1489.7616381378928;1495.1851241073641;1497.6779992301708;1499.2878382768097;26392.340191495365;27294.181174564794;27640.58539121955;27777.166684999484;27964.30089247785;38391.61608383992;38716.41925371065;38743;38746;38748.6125138745;204740;205829;205954;205985;206047;33742;36519.45220821743;37020;37141.442878356305;37181;44981.775091125644;45446.54553454423;46031.76984115058;46319;47622.76188619035;33429.33141337111;34151.31697366088;34440.311193776484;34456.483152752226;35210.11974700653;31588;33278.334433311684;33820.66179338274;34047.14882127867;35051.29897401987;36972.630273696916;37580.24839503249;37654;37670.24659506849;38010.42984355292;30416.5437518433;31990.52014219835;32870.67129328676;32933.17667058343;33757.83121084379;23541.293761187193;24359.75640243575;24929.252122436355;25052.874735626207;25095.49809003773 16:39:42 INFO - PID 19521 | |2;jquery.html;578.7829563913532;592.8280798568416;593.5666963116925;598.7156100852094;599.1791245992989;22422.32733018008;22809.429764255903;23407.882960585193;23436;23446;27940.860295698494;28608.427831443358;28626.856865715694;28655.713442865566;28751;6906.309369063104;7091.964540177292;7100.112485939258;7102.644867756618;7103.289671032881;6665.566738162028;6863.245043045261;6932.306769323078;7023.61370124643;7048.964755176243;6936.549124306929;6942.305769423067;7001.054857594236;7007.684654190573;7009.12385951756;6916.3429474200375;6965.860682786341;6967.303269673042;6997.125359330109;7005.404540614054;6771.762988295435;6788.2193547742145;6849.657517124124;6867.793966181022;6869.278725733826;30971.22571935697;31862.681373186202;31951.360972780647;32681.50977735336;32706.509402358744;1967.6261510312995;1995.3714579907428;2002.929897453582;2003.7495313085865;2004.7293615361884;20466.079026443847;20812.27157049511;20867.165313387446;20894;20894.791052089437;2338.725956685993;2385.1890357278608;2450.901963921441;2542.872856357175;2557.2072657476056;142541;143031;146064.26967865092;146514;146890;19871.964657847693;21408.844607586336;21887.562248754937;21901;22392.888035559718;45393.09213815705;45486.772566136955;45494.54505454903;45511.86220344518;45808.312875306896;11841.28952262867;12018.158728888893;12041.698957526132;12149.271043737228;12175.573854915212;8389.496630202208;10024.14794742455;10076;10215.13171380441;10217.33587316822;10125.797484050277;11434.599789007345;11639.148408639769;11821;11915.523379064914;3762.360398732167;3769.9304120366187;4126.504819421689;4424.734515929054;4483.103379324149;967.1778987860263;984.0897170117613;985.6599473181741;986.8075725233654;986.8963758805365;19742;19896.50258743543;20423.489412764502;20704;20735.792642073386;1042.2443728297076;1059.1473863539925;1065.3554599467366;1069.417167643636;1078.5470102556944;11002.119830413547;11126.944365278283;11221.719457013476;11270.943645281885;11373.545058197746;431961;441792;451139;452571;454362;111356.4432177834;111463;112808.43595781969;112891;114163.42918285521;1189.7679952409196;1205.3250179899285;1216.8113942338953;1222.1444988507901;1227.9754404911853;16988.49034528966;17548.91225543864;17551.210195540974;17770;18256.90871545634;55326.72336638291;55899.44100559105;59356.70321648364;59988.400116000026;62523.6873815628;70584.64707676429;71200;71422.64288678524;71630;71822.64088679732;14852.331645076214;15284.770728439305;15348.155851428279;15472;15649;23488.765112348658;23852.403689907893;24025.75974240305;24056.75943240545;24298.63552046756;18533;19173.712394313818;19196.904015479835;19210.519737006685;19266.22935082581;16993.69901041473;17082.316707331567;18044;18061.187246573674;18110.637787244446;20213.49466263355;20258.392248232576;20281.59436811226;20295.08672109729;20411.183552657727;14474.782878256625;15166.31751571204;15222.086674799548;15325.46360877364;15494.070355778238;18657.81342186561;18775.34286299973;18929.716054259472;19328.61342773165;19555.413337599894 16:39:42 INFO - PID 19521 | |3;mootools.html;1359.075828436663;1408.5281430720704;1420.3821337718086;1428.8285405751312;1431.6420894776306;13689.315534223286;14290.499832505877;14301.427942882285;14326.212058336787;14431.92784036081;14455.566333010027;14714.926425367885;14727.631809204748;14733.631659208526;14782.630434239149;2585.780208682255;2700.7569318761257;2759.296379423254;2763.309172706823;2763.751262386385;2674.130907455075;2712.633794437755;2715.67411910571;2715.9321016974536;2717.7961652876015;2584.2505673354704;2629.894804207839;2676;2715.3483164040686;2735.548634475309;2555.2462023702865;2562;2608.3870290481723;2625.7242989486117;2626.921192364232;2538.416164282207;2593.5590949538623;2616.4636249568794;2617.7251388604113;2627.1855724725397;13810;14216.573502794932;14266;14283.500077497341;14321.069130506483;7414.480986330959;7682.846343073107;7707.730229441942;7710.228977102245;7715;4797.544233297831;4979.875503112415;4997.212258169538;5115.053715062688;5145.073886700392;1895.6113996630659;1898.1742941820353;1910.5128192310872;1953.394447721211;1955.4817973237105;23571.410714732097;23801.285961421185;23806.64290035651;23809.92855321532;23839;6354.682265886687;6733.6036750511685;6772.085768421299;6804.55770374924;6855.417289530346;15861.52415427539;15878.285477153557;15925.442609508611;15950.361985520682;15976.520704378887;7319.41444684424;7677.155512893577;7677.731279405194;7684.077910650758;7695.807604809813;6943.583384996917;7045.471589630798;7334.3032411920785;7340.339369456668;7343.706251749977;4870.172070747911;5065.898682026339;5074.11203039474;5107.182850743863;5158.613104017214;1428.6999730056596;1448.2758620689656;1458.9197594132213;1463.6267751723242;1469.3469846422774;846.4667259626395;848.3510114762212;851.476342049635;886.6940905387631;896.8654701794783;6843.3840954313355;7128.679209435588;7205.71177152908;7257.8911316330295;7295.088113985752;711.5232794028013;719.8452332748484;720.935115839577;735.2941176470541;737.2332773915175;4219.472565929259;4874.902501949941;4953.826616068421;5097.337346144977;5116.488351164928;18325.816741832678;18966.146523406478;19696.803031969783;19743.802561974197;19790.802091978894;19246.4226073218;19301.80698193;19302.903485482482;19343.12955916959;19583.314583989493;10207.540660670287;10635.734106647242;11003.889961100447;11124.888751112547;11195.776084478264;7697.499662521918;7795.493292935941;8221.136780637948;8381.03618083928;8410.495370277802;16178.029318240942;16816.159192040595;16857.831421685627;17214.741778873577;17258;16715.582110447336;17135.314587416364;17263.82736172622;17598.91200543989;17768.55578610545;11547.769044619228;11624.88375116238;11656.358900260568;11716.531338746354;11734.647960561197;13051.21692698441;13077.280749558486;13168;13276.07067505304;13331.3334333281;9824.65613703517;10211.132053775513;10319.94840025795;10320.896791032294;10377.533011014673;10131.341462804894;10751.569937202425;10787.568497260336;10834.945825270823;10881.18391120685;9498.762530936781;9678.70963871085;9680.806383872425;9687.612495500101;9687.66093186735;6703;6783.287754785676;7084.858302833812;7269.600171990592;7320.450966177452;7035.33164349386;7344.559326440431;7529.322360987538;7531.585762783099;7560.508566943131 16:39:42 INFO - PID 19521 | |4;prototype.html;472.20197865607145;495.9181735013724;503.5493233555965;511.83621241202815;514.2312243196421;6273.309935907058;6302.495800335973;6337.461315788152;6344.6207672122955;6354.568532992184;5969.432903874136;6055.2430946131735;6061.272537326851;6119.265688117433;6128.479079278256;4911.189653707134;4933.580645645125;4957.330760347352;4984.601231901457;4985.1774457214515;4742.359781429497;4964.950350496485;4998.800047998076;5003.324551185598;5012.373453318335;4854.635902307324;4868.78090485929;4879.58523525499;4893.608511319086;4900.313956046157;4794.49657785931;4863.562279394854;4872.366592343008;4906.337644417994;4930.211166213388;4371.431713877208;4416.580424859633;4425.159219748238;4425.734455932655;4445.310976798602;6039.698015099228;6107.847303817396;6113.646246195202;6121.143039974407;6140.84647883802;5734.168545560912;5742.100239379129;5752.28096487939;5752.884942301131;5756.912592059601;6614.404703576702;6627.2378676452345;6631.977246939681;6649.268580456146;6655.866882662368;4839.491853355417;4847.975760121212;4854.7572621369145;4859.73271470069;4862.149123903303;6937.375636192716;6943.097397338313;7015.263397343308;7041.5422997505;7046.260142684944;4797;4800.231962885991;4830.396200474941;4862.5380588844;4907.460179380265;4874.658773885794;4891.437484689306;4940.555350018516;4949.529794669501;4956.801727930842;5619.522340601013;5622.606417550732;5622.859428514238;5651.434856514398;5651.915221271602;6433.485321174295;6455.644939528277;6507.511936604774;6594.73621055162;6600.900986485207;1621.7810595569683;1681.7813684221217;1683.8231985641576;1684.2757614225754;1711.4437807712295;1130.6042884990188;1186.3890096600257;1200.8739082396398;1205.2527432991426;1208.1060015588578;5643.492085712305;5730.1404789281105;5786.218860453785;5791.3339965903615;5823.30120385548;6528.37980391862;6565.934340656628;6681.5656982296;6727.428168605626;6796.76211332601;5720.656760594377;5747.3103227612955;5752.36723960364;5756.625819321731;5782.3639399666;3510.526078979305;3565.4651802229355;3579.749417540799;3609.7473176877365;3610.1696609779374;6428.303725357938;6443.615862130948;6521.902171467432;6550.3449655035065;6597.109390232353;6765.627890466071;6848.931510684929;6862.245153033163;6862.9313706863295;6943.375096241362;6461.741530338733;6469.159009328757;6511.613960740483;6530.836729081716;6574.243961944438;6660.933390666031;6700.865982680417;6709.496787741036;6724.93275067243;6752.176912233767;6570.704318305592;6619.768308109193;6648;6709.913439817738;6738.056672066013;6391.776287829904;6456.612603243821;6475.805725828232;6582.670866456754;6594.868102637824;4845.224764037737;4940.580050695731;4941.925871111865;4946.604271658331;4951.207806750903;6702.296258892746;6711.664416779239;6718.529702920749;6744.932550674431;6763.425108865801;6480.157579514633;6496.206631148462;6502.4472919800455;6507.28419873823;6542;6290.339514350927;6565.058621947145;6570.211574611078;6584.934150658432;6617.43751781104;6030.859045039124;6327.715252813542;6379.202599675041;6431.517636177399;6448.935510644834;6438.742450301936;6510.967445162744;6594.967025164843;6598.406143447113;6627.1716035495565;6286.654234017173;6299.685015749286;6335.208098987627;6358.77744278948;6394.90407643895 16:39:42 INFO - PID 19521 | |5;yui.html;906.6192199276303;909.6088681866798;917.8990311065786;922.2483675804219;931.7856892914632;16440.42458513952;16613.83386166141;16777.832221677778;16899.493015209548;16954.491365259048;20608.793912060875;21389.35831925041;21647.567048659057;21782.564348713015;21793.237236696717;1035.3891204189545;1060.8249638809586;1061.4692653673164;1070.6734445993968;1071.6838532632892;1062.4740753327114;1064.0689396777818;1064.8243039898407;1065.350136416785;1065.9147268218562;1014.7463134216446;1104.3429159649995;1108.1910205549952;1108.3571528513444;1108.9611863584776;1103.0348445110528;1103.11199484415;1103.4372470040257;1104.4201794058145;1105.4251789069679;807.8384323135397;808.454293351985;808.8341889912554;809.6113865344608;810.3557671651051;18148.637027259512;18326.816731832776;19317.903410483;19615.117319720648;19669.508262293413;19934;20165.39503814888;20803;20809;21167.576648466944;16435.753463698053;16461.25924333408;16497.83502164987;16566.088865112415;16646.58383540409;3534.2224710563637;3568.892933212008;3570.232400034005;3573.1781690211137;3573.535440392758;128961;132567;134661.27119235264;135864.88608012564;136585;15015.549533514011;15637.765433518507;15935.203239837962;15944.601384965468;16162.272697728631;29583.26041848928;29619.407611848073;29711.811527538655;29746.40507189844;31015.844920775253;7152.678129484186;7507.0240868687815;8343.290820280345;8426.410151289474;8431.536265505456;3328.234506063619;4125.484314460692;4258;4275.914481710349;4293.8835902664905;4941.827036053721;4986.276989836526;5098.872528186825;5141.38303403594;5157.303763991888;1028.3161697471248;1034.5034383495963;1054.5254635414094;1058.9364638121583;1067.32225037102;628.8302158417201;637.0985056145502;651.9087327774115;663.9468842492589;672.7208208593477;10915.727106822234;13796.379162937692;13906.930465347608;13925.721485570231;13969.511067112806;686.2588404523103;691.3363171355555;700.5131433653663;704.429412176139;705.1855107351017;5542.279503664578;5845.766169353264;5885.352611212763;6278.529110316745;6450.5484616077365;106330;112496.4375178119;113094;113318.43340783243;120096.39951800185;88636.5568172155;94920.52539737258;95793.52103239579;95900.52049739707;99668;81229.18770812216;82466;85844;86692;90188;12389.380530973596;12757.576060548467;12860.678483037998;13231.669208269484;13286.734265314446;34612;36750.44874326941;37234.25531489409;38169.427458588696;39057.414138787375;46176.07647847092;68537;69761;69914;73269;19130.61738765189;19171;19324.516887077934;20305.59388812186;20326;18175.45473635793;18479.992409450322;21321.46696332542;21840.672389913845;21908;19328.613427731085;19412.126454309873;19433.611327773648;19897.204111835945;20070.698939516213;18889.71665425047;19724.40826775199;20144.39566812998;20157;20197.192112315344;18276.45170644883;18658;18687;19076.523086922938;19166.425007249803;14093.15441073539;14275.500357487437;14311.499097531536;14341;14345.569632911029;13100.279484628438;13336.399862006427;13601.387937542637;13614.93192534031;13688.452461901412 16:39:42 INFO - PID 19521 | __end_tp_report 16:39:42 INFO - PID 19521 | __start_cc_report 16:39:42 INFO - PID 19521 | _x_x_mozilla_cycle_collect,376 16:39:42 INFO - PID 19521 | __end_cc_report 16:39:42 INFO - PID 19521 | __startTimestamp1501630782519__endTimestamp 16:39:42 INFO - PID 19521 | 16:39:42 INFO - PID 19521 | ------- Summary: start ------- 16:39:42 INFO - PID 19521 | Number of tests: 6 16:39:42 INFO - PID 19521 | 16:39:42 INFO - PID 19521 | [#0] dojo.html Cycles:165 Average:6185.19 Median:6452.39 stddev:737.88 (11.4%) stddev-sans-first:701.13 16:39:42 INFO - PID 19521 | Values: 3167.0 3185.4 3216.7 3222.3 3222.5 6213.3 6309.4 6357.1 6387.5 6423.5 6101.3 6184.8 6203.9 6205.2 6211.8 5705.6 5715.1 5729.0 5740.2 5781.4 5701.3 5764.0 5771.0 5801.0 5847.0 5707.5 5770.9 5779.2 5780.4 5841.5 5531.8 5653.2 5740.0 5762.0 5785.1 5580.4 5590.9 5602.5 5616.6 5667.6 6100.3 6176.4 6207.8 6245.3 6251.4 6694.9 6701.5 6703.1 6779.0 6793.0 6747.1 6794.4 6796.8 6802.5 6802.7 6237.2 6251.1 6254.7 6255.2 6265.0 6875.9 6949.8 6959.4 6966.7 6968.8 6595.8 6601.6 6603.6 6611.6 6623.4 6638.8 6681.7 6718.5 6718.7 6718.9 6705.4 6714.3 6727.3 6771.1 6771.1 6656.2 6665.3 6682.3 6732.5 6749.3 5262.3 5351.4 5351.5 5360.8 5368.0 4610.9 4638.1 4680.7 4714.1 4727.0 5757.1 5843.2 5843.4 5872.1 5876.1 6692.9 6702.2 6719.1 6719.7 6726.6 5764.0 5765.6 5765.8 5776.8 5778.2 5727.0 5858.3 5870.7 5874.6 5878.9 6514.9 6573.9 6579.2 6666.1 6673.6 6681.4 6746.8 6765.1 6812.3 6838.5 6377.2 6486.5 6508.9 6592.0 6616.5 6653.8 6677.2 6681.8 6682.7 6693.9 6651.5 6805.8 6809.7 6831.5 6844.3 6508.4 6509.9 6609.4 6616.1 6624.4 6415.5 6492.4 6507.3 6590.5 6610.5 6446.9 6449.7 6452.4 6466.9 6491.3 6449.4 6522.3 6551.6 6682.9 6724.8 6405.2 6430.9 6494.0 6506.5 6510.8 16:39:42 INFO - PID 19521 | 16:39:42 INFO - PID 19521 | [#1] ext.html Cycles:180 Average:37887.41 Median:19372.90 stddev:53157.44 (274.4%) stddev-sans-first:53233.90 16:39:42 INFO - PID 19521 | Values: 872.3 900.9 1177.2 1206.6 1262.6 36557.8 39673.2 39751.8 39820.4 39895.6 37348.0 37666.4 37727.4 37734.4 37786.6 7213.2 7368.5 7374.7 7374.8 7376.2 7175.1 7271.0 7304.0 7338.0 7347.7 7247.5 7279.1 7507.4 7728.9 7743.4 7599.1 7639.2 7701.8 7702.6 7715.2 7463.4 7583.2 7669.8 7673.7 7683.2 37909.0 38299.4 38351.6 38483.8 38514.6 3483.2 3519.6 3535.7 3552.6 3566.3 30650.5 30702.5 30750.8 30954.8 31071.0 4795.1 4828.7 4850.6 4854.5 4878.0 181290.0 182282.0 182723.0 183238.0 183378.0 42254.2 43171.8 48814.8 48891.8 48933.5 51711.5 52277.5 52601.2 52644.5 52672.2 15404.1 15528.8 15536.4 15555.7 15563.2 12465.7 12469.0 12487.7 12489.9 12490.3 14137.2 14147.6 14157.8 14247.3 14316.0 5903.6 5940.0 6019.2 6032.0 6041.9 1002.2 1011.5 1018.8 1021.3 1023.3 22936.7 28309.9 28930.3 29109.1 29641.4 1071.7 1082.3 1090.5 1105.7 1120.9 11968.5 12448.2 12495.0 12547.3 12636.6 212863.0 218060.0 226462.0 227656.0 241191.0 55453.0 55577.4 56049.7 56091.4 56175.7 1486.8 1489.8 1495.2 1497.7 1499.3 26392.3 27294.2 27640.6 27777.2 27964.3 38391.6 38716.4 38743.0 38746.0 38748.6 204740.0 205829.0 205954.0 205985.0 206047.0 33742.0 36519.5 37020.0 37141.4 37181.0 44981.8 45446.5 46031.8 46319.0 47622.8 33429.3 34151.3 34440.3 34456.5 35210.1 31588.0 33278.3 33820.7 34047.1 35051.3 36972.6 37580.2 37654.0 37670.2 38010.4 30416.5 31990.5 32870.7 32933.2 33757.8 23541.3 24359.8 24929.3 25052.9 25095.5 16:39:42 INFO - PID 19521 | 16:39:42 INFO - PID 19521 | [#2] jquery.html Cycles:180 Average:35147.55 Median:21648.20 stddev:75928.33 (350.7%) stddev-sans-first:76096.97 16:39:42 INFO - PID 19521 | Values: 578.8 592.8 593.6 598.7 599.2 22422.3 22809.4 23407.9 23436.0 23446.0 27940.9 28608.4 28626.9 28655.7 28751.0 6906.3 7092.0 7100.1 7102.6 7103.3 6665.6 6863.2 6932.3 7023.6 7049.0 6936.5 6942.3 7001.1 7007.7 7009.1 6916.3 6965.9 6967.3 6997.1 7005.4 6771.8 6788.2 6849.7 6867.8 6869.3 30971.2 31862.7 31951.4 32681.5 32706.5 1967.6 1995.4 2002.9 2003.7 2004.7 20466.1 20812.3 20867.2 20894.0 20894.8 2338.7 2385.2 2450.9 2542.9 2557.2 142541.0 143031.0 146064.3 146514.0 146890.0 19872.0 21408.8 21887.6 21901.0 22392.9 45393.1 45486.8 45494.5 45511.9 45808.3 11841.3 12018.2 12041.7 12149.3 12175.6 8389.5 10024.1 10076.0 10215.1 10217.3 10125.8 11434.6 11639.1 11821.0 11915.5 3762.4 3769.9 4126.5 4424.7 4483.1 967.2 984.1 985.7 986.8 986.9 19742.0 19896.5 20423.5 20704.0 20735.8 1042.2 1059.1 1065.4 1069.4 1078.5 11002.1 11126.9 11221.7 11270.9 11373.5 431961.0 441792.0 451139.0 452571.0 454362.0 111356.4 111463.0 112808.4 112891.0 114163.4 1189.8 1205.3 1216.8 1222.1 1228.0 16988.5 17548.9 17551.2 17770.0 18256.9 55326.7 55899.4 59356.7 59988.4 62523.7 70584.6 71200.0 71422.6 71630.0 71822.6 14852.3 15284.8 15348.2 15472.0 15649.0 23488.8 23852.4 24025.8 24056.8 24298.6 18533.0 19173.7 19196.9 19210.5 19266.2 16993.7 17082.3 18044.0 18061.2 18110.6 20213.5 20258.4 20281.6 20295.1 20411.2 14474.8 15166.3 15222.1 15325.5 15494.1 18657.8 18775.3 18929.7 19328.6 19555.4 16:39:42 INFO - PID 19521 | 16:39:42 INFO - PID 19521 | [#3] mootools.html Cycles:180 Average:8755.53 Median:2612.43 stddev:6026.73 (230.7%) stddev-sans-first:6018.01 16:39:42 INFO - PID 19521 | Values: 1359.1 1408.5 1420.4 1428.8 1431.6 13689.3 14290.5 14301.4 14326.2 14431.9 14455.6 14714.9 14727.6 14733.6 14782.6 2585.8 2700.8 2759.3 2763.3 2763.8 2674.1 2712.6 2715.7 2715.9 2717.8 2584.3 2629.9 2676.0 2715.3 2735.5 2555.2 2562.0 2608.4 2625.7 2626.9 2538.4 2593.6 2616.5 2617.7 2627.2 13810.0 14216.6 14266.0 14283.5 14321.1 7414.5 7682.8 7707.7 7710.2 7715.0 4797.5 4979.9 4997.2 5115.1 5145.1 1895.6 1898.2 1910.5 1953.4 1955.5 23571.4 23801.3 23806.6 23809.9 23839.0 6354.7 6733.6 6772.1 6804.6 6855.4 15861.5 15878.3 15925.4 15950.4 15976.5 7319.4 7677.2 7677.7 7684.1 7695.8 6943.6 7045.5 7334.3 7340.3 7343.7 4870.2 5065.9 5074.1 5107.2 5158.6 1428.7 1448.3 1458.9 1463.6 1469.3 846.5 848.4 851.5 886.7 896.9 6843.4 7128.7 7205.7 7257.9 7295.1 711.5 719.8 720.9 735.3 737.2 4219.5 4874.9 4953.8 5097.3 5116.5 18325.8 18966.1 19696.8 19743.8 19790.8 19246.4 19301.8 19302.9 19343.1 19583.3 10207.5 10635.7 11003.9 11124.9 11195.8 7697.5 7795.5 8221.1 8381.0 8410.5 16178.0 16816.2 16857.8 17214.7 17258.0 16715.6 17135.3 17263.8 17598.9 17768.6 11547.8 11624.9 11656.4 11716.5 11734.6 13051.2 13077.3 13168.0 13276.1 13331.3 9824.7 10211.1 10319.9 10320.9 10377.5 10131.3 10751.6 10787.6 10834.9 10881.2 9498.8 9678.7 9680.8 9687.6 9687.7 6703.0 6783.3 7084.9 7269.6 7320.5 7035.3 7344.6 7529.3 7531.6 7560.5 16:39:42 INFO - PID 19521 | 16:39:42 INFO - PID 19521 | [#4] prototype.html Cycles:180 Average:5484.80 Median:6110.75 stddev:1561.94 (25.6%) stddev-sans-first:1520.33 16:39:42 INFO - PID 19521 | Values: 472.2 495.9 503.5 511.8 514.2 6273.3 6302.5 6337.5 6344.6 6354.6 5969.4 6055.2 6061.3 6119.3 6128.5 4911.2 4933.6 4957.3 4984.6 4985.2 4742.4 4965.0 4998.8 5003.3 5012.4 4854.6 4868.8 4879.6 4893.6 4900.3 4794.5 4863.6 4872.4 4906.3 4930.2 4371.4 4416.6 4425.2 4425.7 4445.3 6039.7 6107.8 6113.6 6121.1 6140.8 5734.2 5742.1 5752.3 5752.9 5756.9 6614.4 6627.2 6632.0 6649.3 6655.9 4839.5 4848.0 4854.8 4859.7 4862.1 6937.4 6943.1 7015.3 7041.5 7046.3 4797.0 4800.2 4830.4 4862.5 4907.5 4874.7 4891.4 4940.6 4949.5 4956.8 5619.5 5622.6 5622.9 5651.4 5651.9 6433.5 6455.6 6507.5 6594.7 6600.9 1621.8 1681.8 1683.8 1684.3 1711.4 1130.6 1186.4 1200.9 1205.3 1208.1 5643.5 5730.1 5786.2 5791.3 5823.3 6528.4 6565.9 6681.6 6727.4 6796.8 5720.7 5747.3 5752.4 5756.6 5782.4 3510.5 3565.5 3579.7 3609.7 3610.2 6428.3 6443.6 6521.9 6550.3 6597.1 6765.6 6848.9 6862.2 6862.9 6943.4 6461.7 6469.2 6511.6 6530.8 6574.2 6660.9 6700.9 6709.5 6724.9 6752.2 6570.7 6619.8 6648.0 6709.9 6738.1 6391.8 6456.6 6475.8 6582.7 6594.9 4845.2 4940.6 4941.9 4946.6 4951.2 6702.3 6711.7 6718.5 6744.9 6763.4 6480.2 6496.2 6502.4 6507.3 6542.0 6290.3 6565.1 6570.2 6584.9 6617.4 6030.9 6327.7 6379.2 6431.5 6448.9 6438.7 6511.0 6595.0 6598.4 6627.2 6286.7 6299.7 6335.2 6358.8 6394.9 16:39:42 INFO - PID 19521 | 16:39:42 INFO - PID 19521 | [#5] yui.html Cycles:180 Average:23805.47 Median:19915.60 stddev:32646.48 (163.9%) stddev-sans-first:32692.78 16:39:42 INFO - PID 19521 | Values: 906.6 909.6 917.9 922.2 931.8 16440.4 16613.8 16777.8 16899.5 16954.5 20608.8 21389.4 21647.6 21782.6 21793.2 1035.4 1060.8 1061.5 1070.7 1071.7 1062.5 1064.1 1064.8 1065.4 1065.9 1014.7 1104.3 1108.2 1108.4 1109.0 1103.0 1103.1 1103.4 1104.4 1105.4 807.8 808.5 808.8 809.6 810.4 18148.6 18326.8 19317.9 19615.1 19669.5 19934.0 20165.4 20803.0 20809.0 21167.6 16435.8 16461.3 16497.8 16566.1 16646.6 3534.2 3568.9 3570.2 3573.2 3573.5 128961.0 132567.0 134661.3 135864.9 136585.0 15015.5 15637.8 15935.2 15944.6 16162.3 29583.3 29619.4 29711.8 29746.4 31015.8 7152.7 7507.0 8343.3 8426.4 8431.5 3328.2 4125.5 4258.0 4275.9 4293.9 4941.8 4986.3 5098.9 5141.4 5157.3 1028.3 1034.5 1054.5 1058.9 1067.3 628.8 637.1 651.9 663.9 672.7 10915.7 13796.4 13906.9 13925.7 13969.5 686.3 691.3 700.5 704.4 705.2 5542.3 5845.8 5885.4 6278.5 6450.5 106330.0 112496.4 113094.0 113318.4 120096.4 88636.6 94920.5 95793.5 95900.5 99668.0 81229.2 82466.0 85844.0 86692.0 90188.0 12389.4 12757.6 12860.7 13231.7 13286.7 34612.0 36750.4 37234.3 38169.4 39057.4 46176.1 68537.0 69761.0 69914.0 73269.0 19130.6 19171.0 19324.5 20305.6 20326.0 18175.5 18480.0 21321.5 21840.7 21908.0 19328.6 19412.1 19433.6 19897.2 20070.7 18889.7 19724.4 20144.4 20157.0 20197.2 18276.5 18658.0 18687.0 19076.5 19166.4 14093.2 14275.5 14311.5 14341.0 14345.6 13100.3 13336.4 13601.4 13614.9 13688.5 16:39:42 INFO - PID 19521 | -------- Summary: end -------- 16:39:42 INFO - PID 19521 | 16:39:43 INFO - TEST-INFO | 19521: exit 0 16:39:43 INFO - TEST-OK | dromaeo_css | took 1113732ms 16:39:43 INFO - TEST-START | kraken 16:39:43 INFO - Initialising browser for kraken test... 16:39:43 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:35870/getInfo.html -profile /tmp/tmpX2kmd6/profile 16:39:43 INFO - TEST-INFO | started process 19874 (/builds/slave/test/build/application/firefox/firefox http://localhost:35870/getInfo.html) 16:39:49 INFO - TEST-INFO | 19874: exit 0 16:39:49 INFO - Browser initialized. 16:39:49 INFO - Running cycle 1/1 for kraken test... 16:39:49 INFO - TEST-INFO | started process 20081 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpX2kmd6/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 16:39:50 INFO - PID 20081 | 16:39:50 INFO - PID 20081 | (/builds/slave/test/build/application/firefox/firefox:20129): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 16:39:50 INFO - PID 20081 | 16:40:00 INFO - PID 20081 | RSS: Main: 172158976 16:40:00 INFO - PID 20081 | 16:40:03 INFO - PID 20081 | Cycle 1(1): loaded http://localhost:35870/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:35870/tests/kraken/driver.html?testName=audio-beat-detection) 16:40:04 INFO - PID 20081 | RSS: Main: 178331648 16:40:04 INFO - PID 20081 | 16:40:06 INFO - PID 20081 | Cycle 1(1): loaded http://localhost:35870/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:35870/tests/kraken/driver.html?testName=audio-dft) 16:40:07 INFO - PID 20081 | RSS: Main: 178843648 16:40:07 INFO - PID 20081 | 16:40:10 INFO - PID 20081 | Cycle 1(1): loaded http://localhost:35870/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:35870/tests/kraken/driver.html?testName=audio-fft) 16:40:11 INFO - PID 20081 | RSS: Main: 172179456 16:40:11 INFO - PID 20081 | 16:40:13 INFO - PID 20081 | Cycle 1(1): loaded http://localhost:35870/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:35870/tests/kraken/driver.html?testName=audio-oscillator) 16:40:13 INFO - PID 20081 | RSS: Main: 172494848 16:40:13 INFO - PID 20081 | 16:40:16 INFO - PID 20081 | Cycle 1(1): loaded http://localhost:35870/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:35870/tests/kraken/driver.html?testName=imaging-gaussian-blur) 16:40:16 INFO - PID 20081 | RSS: Main: 172904448 16:40:16 INFO - PID 20081 | 16:40:19 INFO - PID 20081 | Cycle 1(1): loaded http://localhost:35870/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:35870/tests/kraken/driver.html?testName=imaging-darkroom) 16:40:20 INFO - PID 20081 | RSS: Main: 175222784 16:40:20 INFO - PID 20081 | 16:40:23 INFO - PID 20081 | Cycle 1(1): loaded http://localhost:35870/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:35870/tests/kraken/driver.html?testName=imaging-desaturate) 16:40:24 INFO - PID 20081 | RSS: Main: 175616000 16:40:24 INFO - PID 20081 | 16:40:27 INFO - PID 20081 | Cycle 1(1): loaded http://localhost:35870/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:35870/tests/kraken/driver.html?testName=json-parse-financial) 16:40:28 INFO - PID 20081 | RSS: Main: 175697920 16:40:28 INFO - PID 20081 | 16:40:29 INFO - PID 20081 | Cycle 1(1): loaded http://localhost:35870/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:35870/tests/kraken/driver.html?testName=json-stringify-tinderbox) 16:40:30 INFO - PID 20081 | RSS: Main: 176066560 16:40:30 INFO - PID 20081 | 16:40:32 INFO - PID 20081 | Cycle 1(1): loaded http://localhost:35870/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:35870/tests/kraken/driver.html?testName=stanford-crypto-aes) 16:40:32 INFO - PID 20081 | RSS: Main: 175968256 16:40:32 INFO - PID 20081 | 16:40:34 INFO - PID 20081 | Cycle 1(1): loaded http://localhost:35870/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:35870/tests/kraken/driver.html?testName=stanford-crypto-ccm) 16:40:35 INFO - PID 20081 | RSS: Main: 172822528 16:40:35 INFO - PID 20081 | 16:40:38 INFO - PID 20081 | Cycle 1(1): loaded http://localhost:35870/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:35870/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 16:40:38 INFO - PID 20081 | RSS: Main: 173084672 16:40:38 INFO - PID 20081 | 16:40:41 INFO - PID 20081 | Cycle 1(1): loaded http://localhost:35870/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:35870/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 16:40:42 INFO - PID 20081 | RSS: Main: 173535232 16:40:42 INFO - PID 20081 | 16:40:44 INFO - PID 20081 | Cycle 1(1): loaded http://localhost:35870/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:35870/tests/kraken/driver.html?testName=ai-astar) 16:40:44 INFO - PID 20081 | RSS: Main: 174833664 16:40:44 INFO - PID 20081 | 16:40:44 INFO - PID 20081 | __start_tp_report 16:40:44 INFO - PID 20081 | _x_x_mozilla_page_load 16:40:44 INFO - PID 20081 | _x_x_mozilla_page_load_details 16:40:44 INFO - PID 20081 | |i|pagename|runs| 16:40:44 INFO - PID 20081 | |0;ai-astar;99;111;101;108;109;108;111;99;110;109 16:40:44 INFO - PID 20081 | |1;audio-beat-detection;147;117;143;181;117;153;150;119;178;118 16:40:44 INFO - PID 20081 | |2;audio-dft;167;164;163;163;164;162;166;171;165;162 16:40:44 INFO - PID 20081 | |3;audio-fft;74;76;75;166;75;75;75;75;161;76 16:40:44 INFO - PID 20081 | |4;audio-oscillator;80;79;135;81;79;80;130;81;80;134 16:40:44 INFO - PID 20081 | |5;imaging-gaussian-blur;114;114;115;114;115;113;114;113;114;114 16:40:44 INFO - PID 20081 | |6;imaging-darkroom;151;151;151;150;151;151;153;153;151;153 16:40:44 INFO - PID 20081 | |7;imaging-desaturate;98;95;94;94;94;94;95;95;94;95 16:40:44 INFO - PID 20081 | |8;json-parse-financial;54;54;54;55;54;55;57;55;55;53 16:40:44 INFO - PID 20081 | |9;json-stringify-tinderbox;54;55;59;55;53;55;54;60;54;54 16:40:44 INFO - PID 20081 | |10;stanford-crypto-aes;77;78;78;76;78;77;78;79;87;76 16:40:44 INFO - PID 20081 | |11;stanford-crypto-ccm;127;126;142;131;128;136;127;123;133;167 16:40:44 INFO - PID 20081 | |12;stanford-crypto-pbkdf2;173;174;176;172;179;178;192;183;172;170 16:40:44 INFO - PID 20081 | |13;stanford-crypto-sha256-iterative;75;70;64;67;65;65;66;69;65;65 16:40:44 INFO - PID 20081 | __end_tp_report 16:40:44 INFO - PID 20081 | __start_cc_report 16:40:44 INFO - PID 20081 | _x_x_mozilla_cycle_collect,932 16:40:44 INFO - PID 20081 | __end_cc_report 16:40:44 INFO - PID 20081 | __startTimestamp1501630844625__endTimestamp 16:40:44 INFO - PID 20081 | 16:40:44 INFO - PID 20081 | ------- Summary: start ------- 16:40:44 INFO - PID 20081 | Number of tests: 14 16:40:44 INFO - PID 20081 | 16:40:44 INFO - PID 20081 | [#0] ai-astar Cycles:10 Average:106.50 Median:110.50 stddev:4.86 (4.4%) stddev-sans-first:4.33 16:40:44 INFO - PID 20081 | Values: 99.0 111.0 101.0 108.0 109.0 108.0 111.0 99.0 110.0 109.0 16:40:44 INFO - PID 20081 | 16:40:44 INFO - PID 20081 | [#1] audio-beat-detection Cycles:10 Average:142.30 Median:148.50 stddev:24.45 (16.5%) stddev-sans-first:25.88 16:40:44 INFO - PID 20081 | Values: 147.0 117.0 143.0 181.0 117.0 153.0 150.0 119.0 178.0 118.0 16:40:44 INFO - PID 20081 | 16:40:44 INFO - PID 20081 | [#2] audio-dft Cycles:10 Average:164.70 Median:164.50 stddev:2.75 (1.7%) stddev-sans-first:2.79 16:40:44 INFO - PID 20081 | Values: 167.0 164.0 163.0 163.0 164.0 162.0 166.0 171.0 165.0 162.0 16:40:44 INFO - PID 20081 | 16:40:44 INFO - PID 20081 | [#3] audio-fft Cycles:10 Average:92.80 Median:75.00 stddev:37.29 (49.7%) stddev-sans-first:38.92 16:40:44 INFO - PID 20081 | Values: 74.0 76.0 75.0 166.0 75.0 75.0 75.0 75.0 161.0 76.0 16:40:44 INFO - PID 20081 | 16:40:44 INFO - PID 20081 | [#4] audio-oscillator Cycles:10 Average:95.90 Median:80.00 stddev:25.64 (32.1%) stddev-sans-first:26.54 16:40:44 INFO - PID 20081 | Values: 80.0 79.0 135.0 81.0 79.0 80.0 130.0 81.0 80.0 134.0 16:40:44 INFO - PID 20081 | 16:40:44 INFO - PID 20081 | [#5] imaging-gaussian-blur Cycles:10 Average:114.00 Median:114.00 stddev:0.67 (0.6%) stddev-sans-first:0.71 16:40:44 INFO - PID 20081 | Values: 114.0 114.0 115.0 114.0 115.0 113.0 114.0 113.0 114.0 114.0 16:40:44 INFO - PID 20081 | 16:40:44 INFO - PID 20081 | [#6] imaging-darkroom Cycles:10 Average:151.50 Median:151.00 stddev:1.08 (0.7%) stddev-sans-first:1.13 16:40:44 INFO - PID 20081 | Values: 151.0 151.0 151.0 150.0 151.0 151.0 153.0 153.0 151.0 153.0 16:40:44 INFO - PID 20081 | 16:40:44 INFO - PID 20081 | [#7] imaging-desaturate Cycles:10 Average:94.80 Median:95.00 stddev:1.23 (1.3%) stddev-sans-first:0.53 16:40:44 INFO - PID 20081 | Values: 98.0 95.0 94.0 94.0 94.0 94.0 95.0 95.0 94.0 95.0 16:40:44 INFO - PID 20081 | 16:40:44 INFO - PID 20081 | [#8] json-parse-financial Cycles:10 Average:54.60 Median:55.00 stddev:1.07 (2.0%) stddev-sans-first:1.12 16:40:44 INFO - PID 20081 | Values: 54.0 54.0 54.0 55.0 54.0 55.0 57.0 55.0 55.0 53.0 16:40:44 INFO - PID 20081 | 16:40:44 INFO - PID 20081 | [#9] json-stringify-tinderbox Cycles:10 Average:55.30 Median:55.00 stddev:2.31 (4.2%) stddev-sans-first:2.40 16:40:44 INFO - PID 20081 | Values: 54.0 55.0 59.0 55.0 53.0 55.0 54.0 60.0 54.0 54.0 16:40:44 INFO - PID 20081 | 16:40:44 INFO - PID 20081 | [#10] stanford-crypto-aes Cycles:10 Average:78.40 Median:78.00 stddev:3.17 (4.1%) stddev-sans-first:3.32 16:40:44 INFO - PID 20081 | Values: 77.0 78.0 78.0 76.0 78.0 77.0 78.0 79.0 87.0 76.0 16:40:44 INFO - PID 20081 | 16:40:44 INFO - PID 20081 | [#11] stanford-crypto-ccm Cycles:10 Average:134.00 Median:132.00 stddev:12.85 (9.7%) stddev-sans-first:13.38 16:40:44 INFO - PID 20081 | Values: 127.0 126.0 142.0 131.0 128.0 136.0 127.0 123.0 133.0 167.0 16:40:44 INFO - PID 20081 | 16:40:44 INFO - PID 20081 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:176.90 Median:177.00 stddev:6.59 (3.7%) stddev-sans-first:6.84 16:40:44 INFO - PID 20081 | Values: 173.0 174.0 176.0 172.0 179.0 178.0 192.0 183.0 172.0 170.0 16:40:44 INFO - PID 20081 | 16:40:44 INFO - PID 20081 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.10 Median:66.50 stddev:3.38 (5.1%) stddev-sans-first:2.05 16:40:44 INFO - PID 20081 | Values: 75.0 70.0 64.0 67.0 65.0 65.0 66.0 69.0 65.0 65.0 16:40:44 INFO - PID 20081 | -------- Summary: end -------- 16:40:44 INFO - PID 20081 | 16:40:45 INFO - PID 20081 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 16:40:45 INFO - TEST-INFO | 20081: exit 0 16:40:45 INFO - TEST-OK | kraken | took 62148ms 16:40:45 INFO - SUITE-END | took 1175s 16:40:45 INFO - Completed test suite (00:19:36) 16:40:45 INFO - javascript benchmark 16:40:45 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8609.83850050932, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3166.984165079176, 3185.442547554178, 3216.7426605871533, 3222.258880457495, 3222.484402495601, 6213.285472170702, 6309.369063093688, 6357.078223657567, 6387.520935929806, 6423.486121110312, 6101.267847858252, 6184.783532576361, 6203.8759224815585, 6205.22434695663, 6211.782587609435, 5705.629134106291, 5715.142728590703, 5729.026065568843, 5740.196372507852, 5781.421857814227, 5701.315842098954, 5763.9711801440935, 5771.0, 5800.970995145019, 5846.970765146169, 5707.5148612368, 5770.942290577103, 5779.248697669318, 5780.393058728836, 5841.532677385799, 5531.834044978657, 5653.236813030229, 5740.0, 5761.971190144064, 5785.103308987113, 5580.358258800249, 5590.91613625796, 5602.4957753802355, 5616.550675945915, 5667.603267771257, 6100.298465676459, 6176.413240742122, 6207.751689932443, 6245.313015568284, 6251.406116418979, 6694.899576506356, 6701.463882889358, 6703.061571380011, 6778.966105169492, 6792.966035169792, 6747.05541224229, 6794.422474089708, 6796.796096117125, 6802.455803535705, 6802.65986700663, 6237.1891654084675, 6251.093591429263, 6254.655993920287, 6255.218097737783, 6264.968675156686, 6875.862482750417, 6949.826254343682, 6959.4432445404245, 6966.651667416711, 6968.79093627192, 6595.8021259362295, 6601.603903765789, 6603.636799976048, 6611.63636000015, 6623.370779775913, 6638.83402914931, 6681.699323530453, 6718.49611279156, 6718.731250750013, 6718.865622687519, 6705.396514313735, 6714.261431242559, 6727.327267273331, 6771.052052712625, 6771.085903403076, 6656.167979002625, 6665.300143484864, 6682.3317668232785, 6732.528722989344, 6749.291324410866, 5262.315898933114, 5351.411344752074, 5351.518363347317, 5360.758765855546, 5367.973160134175, 4610.884727881829, 4638.072385522909, 4680.67235293533, 4714.057188562301, 4726.952730472652, 5757.136429535603, 5843.152742852262, 5843.415658434207, 5872.119182122716, 5876.118582212703, 6692.933070669231, 6702.162229721285, 6719.0593316935665, 6719.731210751613, 6726.630035348005, 5763.971180144073, 5765.625234359753, 5765.769369225268, 5776.826695199066, 5778.191053252548, 5727.0, 5858.2677165354335, 5870.73581688825, 5874.559408044413, 5878.911816322759, 6514.934850651528, 6573.934260657428, 6579.24338701046, 6666.133402657623, 6673.566218195801, 6681.365270299314, 6746.831329216809, 6765.086713293839, 6812.3187681232475, 6838.487113466411, 6377.23473183221, 6486.54594178403, 6508.869822603427, 6592.0, 6616.536842420985, 6653.767118150841, 6677.232118306457, 6681.76613818514, 6682.69927853238, 6693.899591506034, 6651.467882569286, 6805.761798337035, 6809.659517024228, 6831.521793474409, 6844.28135045813, 6508.381703738138, 6509.869802603826, 6609.438197753245, 6616.139901812733, 6624.436922861611, 6415.454686351713, 6492.415682588589, 6507.349265073455, 6590.47276217911, 6610.537262391586, 6446.871062578628, 6449.7097630605795, 6452.387023232785, 6466.870662586816, 6491.318411566717, 6449.3873082057125, 6522.28254891952, 6551.574147680385, 6682.9331706682315, 6724.7646332378135, 6405.167328247298, 6430.871382572229, 6494.0, 6506.479481641362, 6510.804675859732], "value": 6129.794616831206, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [872.2585802068241, 900.9369344145911, 1177.1759768162283, 1206.5656363709063, 1262.6022802817117, 36557.81721091394, 39673.20653586926, 39751.80124099379, 39820.40269395954, 39895.601043989554, 37348.0, 37666.4350034749, 37727.434088488626, 37734.4339834902, 37786.622133778656, 7213.2426095260025, 7368.484206105575, 7374.705011799549, 7374.815629609276, 7376.22549632289, 7175.103112110986, 7270.963645181767, 7304.0, 7338.0, 7347.669354879044, 7247.528910620819, 7279.090113735783, 7507.361874240696, 7728.922710772877, 7743.38052955765, 7599.050118735158, 7639.19788422216, 7701.845963080707, 7702.614869256571, 7715.189905059944, 7463.4029277657655, 7583.165851756303, 7669.808254793675, 7673.733833917397, 7683.193264707181, 37909.0, 38299.425508617394, 38351.61648383508, 38483.807580962195, 38514.614853851665, 3483.1814523586936, 3519.595246546629, 3535.681788639009, 3552.573691157052, 3566.286742651454, 30650.54024189639, 30702.53946190809, 30750.84624576885, 30954.845225773726, 31071.0, 4795.088933102734, 4828.686135401188, 4850.611951043908, 4854.490278520775, 4877.975610121926, 181290.0, 182282.0, 182722.99999999866, 183238.0, 183378.0, 42254.1549169021, 43171.78414107909, 48814.75592622014, 48891.75554122207, 48933.510664893605, 51711.48288517142, 52277.47722522802, 52601.210981835306, 52644.473555263954, 52672.20991685128, 15404.075755454485, 15528.767068493982, 15536.378544858306, 15555.688886222439, 15563.221838908235, 12465.688357791129, 12469.002479801595, 12487.687807804878, 12489.937550312372, 12490.250584964931, 14137.151770893779, 14147.646308842155, 14157.787633185511, 14247.287635618177, 14316.0, 5903.58674892762, 5940.0, 6019.187409699634, 6032.0, 6041.879162416727, 1002.173207104142, 1011.4639241202175, 1018.760591261053, 1021.3208216536069, 1023.3399457350116, 22936.655950160763, 28309.858450708027, 28930.27674308159, 29109.126726198247, 29641.40717185644, 1071.6892101290694, 1082.2694681090234, 1090.465671820802, 1105.7290963713942, 1120.9047230985295, 11968.461419236155, 12448.190867593577, 12495.0, 12547.309897955518, 12636.557720479923, 212863.0, 218060.0, 226462.0, 227656.0, 241191.0, 55453.0, 55577.444225558036, 56049.71975140098, 56091.43908560944, 56175.719121404945, 1486.791849141121, 1489.7616381378928, 1495.1851241073641, 1497.6779992301708, 1499.2878382768097, 26392.340191495365, 27294.181174564794, 27640.58539121955, 27777.166684999484, 27964.30089247785, 38391.61608383992, 38716.41925371065, 38743.0, 38746.0, 38748.6125138745, 204740.0, 205829.0, 205954.0, 205985.0, 206047.0, 33742.0, 36519.45220821743, 37020.0, 37141.442878356305, 37181.0, 44981.775091125644, 45446.54553454423, 46031.76984115058, 46319.0, 47622.76188619035, 33429.33141337111, 34151.31697366088, 34440.311193776484, 34456.483152752226, 35210.11974700653, 31588.0, 33278.334433311684, 33820.66179338274, 34047.14882127867, 35051.29897401987, 36972.630273696916, 37580.24839503249, 37654.0, 37670.24659506849, 38010.42984355292, 30416.5437518433, 31990.52014219835, 32870.67129328676, 32933.17667058343, 33757.83121084379, 23541.293761187193, 24359.75640243575, 24929.252122436355, 25052.874735626207, 25095.49809003773], "value": 17446.876926835208, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [578.7829563913532, 592.8280798568416, 593.5666963116925, 598.7156100852094, 599.1791245992989, 22422.32733018008, 22809.429764255903, 23407.882960585193, 23436.0, 23446.0, 27940.860295698494, 28608.427831443358, 28626.856865715694, 28655.713442865566, 28751.0, 6906.309369063104, 7091.964540177292, 7100.112485939258, 7102.644867756618, 7103.289671032881, 6665.566738162028, 6863.245043045261, 6932.306769323078, 7023.61370124643, 7048.964755176243, 6936.549124306929, 6942.305769423067, 7001.054857594236, 7007.684654190573, 7009.12385951756, 6916.3429474200375, 6965.860682786341, 6967.303269673042, 6997.125359330109, 7005.404540614054, 6771.762988295435, 6788.2193547742145, 6849.657517124124, 6867.793966181022, 6869.278725733826, 30971.22571935697, 31862.681373186202, 31951.360972780647, 32681.50977735336, 32706.509402358744, 1967.6261510312995, 1995.3714579907428, 2002.929897453582, 2003.7495313085865, 2004.7293615361884, 20466.079026443847, 20812.27157049511, 20867.165313387446, 20894.0, 20894.791052089437, 2338.725956685993, 2385.1890357278608, 2450.901963921441, 2542.872856357175, 2557.2072657476056, 142541.0, 143031.0, 146064.26967865092, 146514.0, 146890.0, 19871.964657847693, 21408.844607586336, 21887.562248754937, 21901.0, 22392.888035559718, 45393.09213815705, 45486.772566136955, 45494.54505454903, 45511.86220344518, 45808.312875306896, 11841.28952262867, 12018.158728888893, 12041.698957526132, 12149.271043737228, 12175.573854915212, 8389.496630202208, 10024.14794742455, 10076.0, 10215.13171380441, 10217.33587316822, 10125.797484050277, 11434.599789007345, 11639.148408639769, 11821.0, 11915.523379064914, 3762.360398732167, 3769.9304120366187, 4126.504819421689, 4424.734515929054, 4483.103379324149, 967.1778987860263, 984.0897170117613, 985.6599473181741, 986.8075725233654, 986.8963758805365, 19742.0, 19896.50258743543, 20423.489412764502, 20704.0, 20735.792642073386, 1042.2443728297076, 1059.1473863539925, 1065.3554599467366, 1069.417167643636, 1078.5470102556944, 11002.119830413547, 11126.944365278283, 11221.719457013476, 11270.943645281885, 11373.545058197746, 431961.0, 441792.0, 451139.0, 452571.0, 454362.0, 111356.4432177834, 111463.0, 112808.43595781969, 112891.0, 114163.42918285521, 1189.7679952409196, 1205.3250179899285, 1216.8113942338953, 1222.1444988507901, 1227.9754404911853, 16988.49034528966, 17548.91225543864, 17551.210195540974, 17770.0, 18256.90871545634, 55326.72336638291, 55899.44100559105, 59356.70321648364, 59988.400116000026, 62523.6873815628, 70584.64707676429, 71200.0, 71422.64288678524, 71630.0, 71822.64088679732, 14852.331645076214, 15284.770728439305, 15348.155851428279, 15472.0, 15649.0, 23488.765112348658, 23852.403689907893, 24025.75974240305, 24056.75943240545, 24298.63552046756, 18533.0, 19173.712394313818, 19196.904015479835, 19210.519737006685, 19266.22935082581, 16993.69901041473, 17082.316707331567, 18044.0, 18061.187246573674, 18110.637787244446, 20213.49466263355, 20258.392248232576, 20281.59436811226, 20295.08672109729, 20411.183552657727, 14474.782878256625, 15166.31751571204, 15222.086674799548, 15325.46360877364, 15494.070355778238, 18657.81342186561, 18775.34286299973, 18929.716054259472, 19328.61342773165, 19555.413337599894], "value": 12995.999249166938, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1359.075828436663, 1408.5281430720704, 1420.3821337718086, 1428.8285405751312, 1431.6420894776306, 13689.315534223286, 14290.499832505877, 14301.427942882285, 14326.212058336787, 14431.92784036081, 14455.566333010027, 14714.926425367885, 14727.631809204748, 14733.631659208526, 14782.630434239149, 2585.780208682255, 2700.7569318761257, 2759.296379423254, 2763.309172706823, 2763.751262386385, 2674.130907455075, 2712.633794437755, 2715.67411910571, 2715.9321016974536, 2717.7961652876015, 2584.2505673354704, 2629.894804207839, 2676.0, 2715.3483164040686, 2735.548634475309, 2555.2462023702865, 2562.0, 2608.3870290481723, 2625.7242989486117, 2626.921192364232, 2538.416164282207, 2593.5590949538623, 2616.4636249568794, 2617.7251388604113, 2627.1855724725397, 13810.0, 14216.573502794932, 14266.0, 14283.500077497341, 14321.069130506483, 7414.480986330959, 7682.846343073107, 7707.730229441942, 7710.228977102245, 7715.0, 4797.544233297831, 4979.875503112415, 4997.212258169538, 5115.053715062688, 5145.073886700392, 1895.6113996630659, 1898.1742941820353, 1910.5128192310872, 1953.394447721211, 1955.4817973237105, 23571.410714732097, 23801.285961421185, 23806.64290035651, 23809.92855321532, 23839.0, 6354.682265886687, 6733.6036750511685, 6772.085768421299, 6804.55770374924, 6855.417289530346, 15861.52415427539, 15878.285477153557, 15925.442609508611, 15950.361985520682, 15976.520704378887, 7319.41444684424, 7677.155512893577, 7677.731279405194, 7684.077910650758, 7695.807604809813, 6943.583384996917, 7045.471589630798, 7334.3032411920785, 7340.339369456668, 7343.706251749977, 4870.172070747911, 5065.898682026339, 5074.11203039474, 5107.182850743863, 5158.613104017214, 1428.6999730056596, 1448.2758620689656, 1458.9197594132213, 1463.6267751723242, 1469.3469846422774, 846.4667259626395, 848.3510114762212, 851.476342049635, 886.6940905387631, 896.8654701794783, 6843.3840954313355, 7128.679209435588, 7205.71177152908, 7257.8911316330295, 7295.088113985752, 711.5232794028013, 719.8452332748484, 720.935115839577, 735.2941176470541, 737.2332773915175, 4219.472565929259, 4874.902501949941, 4953.826616068421, 5097.337346144977, 5116.488351164928, 18325.816741832678, 18966.146523406478, 19696.803031969783, 19743.802561974197, 19790.802091978894, 19246.4226073218, 19301.80698193, 19302.903485482482, 19343.12955916959, 19583.314583989493, 10207.540660670287, 10635.734106647242, 11003.889961100447, 11124.888751112547, 11195.776084478264, 7697.499662521918, 7795.493292935941, 8221.136780637948, 8381.03618083928, 8410.495370277802, 16178.029318240942, 16816.159192040595, 16857.831421685627, 17214.741778873577, 17258.0, 16715.582110447336, 17135.314587416364, 17263.82736172622, 17598.91200543989, 17768.55578610545, 11547.769044619228, 11624.88375116238, 11656.358900260568, 11716.531338746354, 11734.647960561197, 13051.21692698441, 13077.280749558486, 13168.0, 13276.07067505304, 13331.3334333281, 9824.65613703517, 10211.132053775513, 10319.94840025795, 10320.896791032294, 10377.533011014673, 10131.341462804894, 10751.569937202425, 10787.568497260336, 10834.945825270823, 10881.18391120685, 9498.762530936781, 9678.70963871085, 9680.806383872425, 9687.612495500101, 9687.66093186735, 6703.0, 6783.287754785676, 7084.858302833812, 7269.600171990592, 7320.450966177452, 7035.33164349386, 7344.559326440431, 7529.322360987538, 7531.585762783099, 7560.508566943131], "value": 6334.868975252006, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [472.20197865607145, 495.9181735013724, 503.5493233555965, 511.83621241202815, 514.2312243196421, 6273.309935907058, 6302.495800335973, 6337.461315788152, 6344.6207672122955, 6354.568532992184, 5969.432903874136, 6055.2430946131735, 6061.272537326851, 6119.265688117433, 6128.479079278256, 4911.189653707134, 4933.580645645125, 4957.330760347352, 4984.601231901457, 4985.1774457214515, 4742.359781429497, 4964.950350496485, 4998.800047998076, 5003.324551185598, 5012.373453318335, 4854.635902307324, 4868.78090485929, 4879.58523525499, 4893.608511319086, 4900.313956046157, 4794.49657785931, 4863.562279394854, 4872.366592343008, 4906.337644417994, 4930.211166213388, 4371.431713877208, 4416.580424859633, 4425.159219748238, 4425.734455932655, 4445.310976798602, 6039.698015099228, 6107.847303817396, 6113.646246195202, 6121.143039974407, 6140.84647883802, 5734.168545560912, 5742.100239379129, 5752.28096487939, 5752.884942301131, 5756.912592059601, 6614.404703576702, 6627.2378676452345, 6631.977246939681, 6649.268580456146, 6655.866882662368, 4839.491853355417, 4847.975760121212, 4854.7572621369145, 4859.73271470069, 4862.149123903303, 6937.375636192716, 6943.097397338313, 7015.263397343308, 7041.5422997505, 7046.260142684944, 4797.0, 4800.231962885991, 4830.396200474941, 4862.5380588844, 4907.460179380265, 4874.658773885794, 4891.437484689306, 4940.555350018516, 4949.529794669501, 4956.801727930842, 5619.522340601013, 5622.606417550732, 5622.859428514238, 5651.434856514398, 5651.915221271602, 6433.485321174295, 6455.644939528277, 6507.511936604774, 6594.73621055162, 6600.900986485207, 1621.7810595569683, 1681.7813684221217, 1683.8231985641576, 1684.2757614225754, 1711.4437807712295, 1130.6042884990188, 1186.3890096600257, 1200.8739082396398, 1205.2527432991426, 1208.1060015588578, 5643.492085712305, 5730.1404789281105, 5786.218860453785, 5791.3339965903615, 5823.30120385548, 6528.37980391862, 6565.934340656628, 6681.5656982296, 6727.428168605626, 6796.76211332601, 5720.656760594377, 5747.3103227612955, 5752.36723960364, 5756.625819321731, 5782.3639399666, 3510.526078979305, 3565.4651802229355, 3579.749417540799, 3609.7473176877365, 3610.1696609779374, 6428.303725357938, 6443.615862130948, 6521.902171467432, 6550.3449655035065, 6597.109390232353, 6765.627890466071, 6848.931510684929, 6862.245153033163, 6862.9313706863295, 6943.375096241362, 6461.741530338733, 6469.159009328757, 6511.613960740483, 6530.836729081716, 6574.243961944438, 6660.933390666031, 6700.865982680417, 6709.496787741036, 6724.93275067243, 6752.176912233767, 6570.704318305592, 6619.768308109193, 6648.0, 6709.913439817738, 6738.056672066013, 6391.776287829904, 6456.612603243821, 6475.805725828232, 6582.670866456754, 6594.868102637824, 4845.224764037737, 4940.580050695731, 4941.925871111865, 4946.604271658331, 4951.207806750903, 6702.296258892746, 6711.664416779239, 6718.529702920749, 6744.932550674431, 6763.425108865801, 6480.157579514633, 6496.206631148462, 6502.4472919800455, 6507.28419873823, 6542.0, 6290.339514350927, 6565.058621947145, 6570.211574611078, 6584.934150658432, 6617.43751781104, 6030.859045039124, 6327.715252813542, 6379.202599675041, 6431.517636177399, 6448.935510644834, 6438.742450301936, 6510.967445162744, 6594.967025164843, 6598.406143447113, 6627.1716035495565, 6286.654234017173, 6299.685015749286, 6335.208098987627, 6358.77744278948, 6394.90407643895], "value": 5019.025507576358, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [906.6192199276303, 909.6088681866798, 917.8990311065786, 922.2483675804219, 931.7856892914632, 16440.42458513952, 16613.83386166141, 16777.832221677778, 16899.493015209548, 16954.491365259048, 20608.793912060875, 21389.35831925041, 21647.567048659057, 21782.564348713015, 21793.237236696717, 1035.3891204189545, 1060.8249638809586, 1061.4692653673164, 1070.6734445993968, 1071.6838532632892, 1062.4740753327114, 1064.0689396777818, 1064.8243039898407, 1065.350136416785, 1065.9147268218562, 1014.7463134216446, 1104.3429159649995, 1108.1910205549952, 1108.3571528513444, 1108.9611863584776, 1103.0348445110528, 1103.11199484415, 1103.4372470040257, 1104.4201794058145, 1105.4251789069679, 807.8384323135397, 808.454293351985, 808.8341889912554, 809.6113865344608, 810.3557671651051, 18148.637027259512, 18326.816731832776, 19317.903410483, 19615.117319720648, 19669.508262293413, 19934.0, 20165.39503814888, 20803.0, 20809.0, 21167.576648466944, 16435.753463698053, 16461.25924333408, 16497.83502164987, 16566.088865112415, 16646.58383540409, 3534.2224710563637, 3568.892933212008, 3570.232400034005, 3573.1781690211137, 3573.535440392758, 128961.0, 132567.0, 134661.27119235264, 135864.88608012564, 136585.0, 15015.549533514011, 15637.765433518507, 15935.203239837962, 15944.601384965468, 16162.272697728631, 29583.26041848928, 29619.407611848073, 29711.811527538655, 29746.40507189844, 31015.844920775253, 7152.678129484186, 7507.0240868687815, 8343.290820280345, 8426.410151289474, 8431.536265505456, 3328.234506063619, 4125.484314460692, 4258.0, 4275.914481710349, 4293.8835902664905, 4941.827036053721, 4986.276989836526, 5098.872528186825, 5141.38303403594, 5157.303763991888, 1028.3161697471248, 1034.5034383495963, 1054.5254635414094, 1058.9364638121583, 1067.32225037102, 628.8302158417201, 637.0985056145502, 651.9087327774115, 663.9468842492589, 672.7208208593477, 10915.727106822234, 13796.379162937692, 13906.930465347608, 13925.721485570231, 13969.511067112806, 686.2588404523103, 691.3363171355555, 700.5131433653663, 704.429412176139, 705.1855107351017, 5542.279503664578, 5845.766169353264, 5885.352611212763, 6278.529110316745, 6450.5484616077365, 106330.0, 112496.4375178119, 113094.0, 113318.43340783243, 120096.39951800185, 88636.5568172155, 94920.52539737258, 95793.52103239579, 95900.52049739707, 99668.0, 81229.18770812216, 82466.0, 85844.0, 86692.0, 90188.0, 12389.380530973596, 12757.576060548467, 12860.678483037998, 13231.669208269484, 13286.734265314446, 34612.0, 36750.44874326941, 37234.25531489409, 38169.427458588696, 39057.414138787375, 46176.07647847092, 68537.0, 69761.0, 69914.0, 73269.0, 19130.61738765189, 19171.0, 19324.516887077934, 20305.59388812186, 20326.0, 18175.45473635793, 18479.992409450322, 21321.46696332542, 21840.672389913845, 21908.0, 19328.613427731085, 19412.126454309873, 19433.611327773648, 19897.204111835945, 20070.698939516213, 18889.71665425047, 19724.40826775199, 20144.39566812998, 20157.0, 20197.192112315344, 18276.45170644883, 18658.0, 18687.0, 19076.523086922938, 19166.425007249803, 14093.15441073539, 14275.500357487437, 14311.499097531536, 14341.0, 14345.569632911029, 13100.279484628438, 13336.399862006427, 13601.387937542637, 13614.93192534031, 13688.452461901412], "value": 9217.454190818691, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1528.8000000000002, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [99.0, 111.0, 101.0, 108.0, 109.0, 108.0, 111.0, 99.0, 110.0, 109.0], "value": 106.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 117.0, 143.0, 181.0, 117.0, 153.0, 150.0, 119.0, 178.0, 118.0], "value": 142.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [167.0, 164.0, 163.0, 163.0, 164.0, 162.0, 166.0, 171.0, 165.0, 162.0], "value": 164.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 76.0, 75.0, 166.0, 75.0, 75.0, 75.0, 75.0, 161.0, 76.0], "value": 92.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 79.0, 135.0, 81.0, 79.0, 80.0, 130.0, 81.0, 80.0, 134.0], "value": 95.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 114.0, 115.0, 114.0, 115.0, 113.0, 114.0, 113.0, 114.0, 114.0], "value": 114.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 151.0, 151.0, 150.0, 151.0, 151.0, 153.0, 153.0, 151.0, 153.0], "value": 151.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [98.0, 95.0, 94.0, 94.0, 94.0, 94.0, 95.0, 95.0, 94.0, 95.0], "value": 94.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 54.0, 54.0, 55.0, 54.0, 55.0, 57.0, 55.0, 55.0, 53.0], "value": 54.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 55.0, 59.0, 55.0, 53.0, 55.0, 54.0, 60.0, 54.0, 54.0], "value": 55.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 78.0, 78.0, 76.0, 78.0, 77.0, 78.0, 79.0, 87.0, 76.0], "value": 78.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [127.0, 126.0, 142.0, 131.0, 128.0, 136.0, 127.0, 123.0, 133.0, 167.0], "value": 134.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [173.0, 174.0, 176.0, 172.0, 179.0, 178.0, 192.0, 183.0, 172.0, 170.0], "value": 176.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 70.0, 64.0, 67.0, 65.0, 65.0, 66.0, 69.0, 65.0, 65.0], "value": 67.1, "unit": "score"}]}]} 16:40:45 INFO - Return code: 0 16:40:45 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 16:40:45 INFO - # TBPL SUCCESS # 16:40:45 INFO - Running post-action listener: _package_coverage_data 16:40:45 INFO - Running post-action listener: _resource_record_post_action 16:40:45 INFO - [mozharness: 2017-08-01 23:40:45.933874Z] Finished run-tests step (success) 16:40:45 INFO - Running post-run listener: _resource_record_post_run 16:40:46 INFO - Total resource usage - Wall time: 1195s; CPU: 13.0%; Read bytes: 208896; Write bytes: 432046080; Read time: 404; Write time: 238832 16:40:46 INFO - TinderboxPrint: CPU usage
13.1% 16:40:46 INFO - TinderboxPrint: I/O read bytes / time
208,896 / 404 16:40:46 INFO - TinderboxPrint: I/O write bytes / time
432,046,080 / 238,832 16:40:46 INFO - TinderboxPrint: CPU idle
8,275.1 (86.8%) 16:40:46 INFO - TinderboxPrint: CPU user
1,202.1 (12.6%) 16:40:46 INFO - TinderboxPrint: Swap in / out
0 / 0 16:40:46 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 4096; Write bytes: 107454464; Read time: 76; Write time: 73624 16:40:46 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 16:40:46 INFO - run-tests - Wall time: 1177s; CPU: 13.0%; Read bytes: 200704; Write bytes: 324591616; Read time: 316; Write time: 165208 16:40:46 INFO - Running post-run listener: _upload_blobber_files 16:40:46 INFO - Blob upload gear active. 16:40:46 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 16:40:46 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:40:46 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', 'Cedar', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 16:40:46 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 Cedar -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 16:40:46 INFO - (blobuploader) - INFO - Open directory for files ... 16:40:46 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 16:40:46 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:40:46 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:40:48 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 16:40:48 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:40:48 INFO - (blobuploader) - INFO - Done attempting. 16:40:48 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 16:40:48 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:40:48 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:40:49 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 16:40:49 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:40:49 INFO - (blobuploader) - INFO - Done attempting. 16:40:49 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 16:40:49 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:40:49 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:40:49 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 16:40:49 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:40:49 INFO - (blobuploader) - INFO - Done attempting. 16:40:49 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 16:40:49 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:40:49 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:40:56 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 16:40:56 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:40:56 INFO - (blobuploader) - INFO - Done attempting. 16:40:56 INFO - (blobuploader) - INFO - Iteration through files over. 16:40:56 INFO - Return code: 0 16:40:56 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 16:40:56 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 16:40:56 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Cedar/sha512/00498e16df8af69f4765a20a6cf7b4f2a5049b61f234b78801326592be8cf5f307fd3d884de7d898d2f8dadb51591103b1ddc90b4575dd3576532b2b62eb643b", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Cedar/sha512/6e228f75d8f36cbe9d46a778e419ffc9fcc559cb7eed44d509da59bd44aa21bfcf8f914297ec729f349d158657ac89f107a5b0141fe233da6b40002061c0f8fa", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Cedar/sha512/65556772b399409a001d97e6f14a9b2dd23543467daf5a7bb4ac5036db449f463818ccd7b8984f2f788787b9b7e423eabe19e5c841afe99e56a4e88de4a1b6ac", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Cedar/sha512/6b5da10db6b38f4e718802caa7ee2cc83c5978ccdb08ac3296d87e3aa4012c32c0df959dc80605c31b47ba19d16206b8954a2a069d2f5365d9af0335e6b79bb4"} 16:40:56 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 16:40:56 INFO - Writing to file /builds/slave/test/properties/blobber_files 16:40:56 INFO - Contents: 16:40:56 INFO - blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Cedar/sha512/00498e16df8af69f4765a20a6cf7b4f2a5049b61f234b78801326592be8cf5f307fd3d884de7d898d2f8dadb51591103b1ddc90b4575dd3576532b2b62eb643b", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Cedar/sha512/6e228f75d8f36cbe9d46a778e419ffc9fcc559cb7eed44d509da59bd44aa21bfcf8f914297ec729f349d158657ac89f107a5b0141fe233da6b40002061c0f8fa", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Cedar/sha512/65556772b399409a001d97e6f14a9b2dd23543467daf5a7bb4ac5036db449f463818ccd7b8984f2f788787b9b7e423eabe19e5c841afe99e56a4e88de4a1b6ac", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Cedar/sha512/6b5da10db6b38f4e718802caa7ee2cc83c5978ccdb08ac3296d87e3aa4012c32c0df959dc80605c31b47ba19d16206b8954a2a069d2f5365d9af0335e6b79bb4"} 16:40:56 INFO - Running post-run listener: copy_logs_to_upload_dir 16:40:56 INFO - Copying logs to upload dir... 16:40:56 INFO - mkdir: /builds/slave/test/build/upload/logs 16:40:56 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1257.400705 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 57 secs) (at 2017-08-01 16:40:56.794805) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-08-01 16:40:56.798971) ========= 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=78329bfc0fd5309db0a6e0ac000001b4-1501626263.871003-2094513666 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Cedar/sha512/00498e16df8af69f4765a20a6cf7b4f2a5049b61f234b78801326592be8cf5f307fd3d884de7d898d2f8dadb51591103b1ddc90b4575dd3576532b2b62eb643b", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Cedar/sha512/6e228f75d8f36cbe9d46a778e419ffc9fcc559cb7eed44d509da59bd44aa21bfcf8f914297ec729f349d158657ac89f107a5b0141fe233da6b40002061c0f8fa", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Cedar/sha512/65556772b399409a001d97e6f14a9b2dd23543467daf5a7bb4ac5036db449f463818ccd7b8984f2f788787b9b7e423eabe19e5c841afe99e56a4e88de4a1b6ac", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Cedar/sha512/6b5da10db6b38f4e718802caa7ee2cc83c5978ccdb08ac3296d87e3aa4012c32c0df959dc80605c31b47ba19d16206b8954a2a069d2f5365d9af0335e6b79bb4"} build_url:https://queue.taskcluster.net/v1/task/e43m8dL_TlaSsgPPmNYEzw/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011378 build_url: 'https://queue.taskcluster.net/v1/task/e43m8dL_TlaSsgPPmNYEzw/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Cedar/sha512/00498e16df8af69f4765a20a6cf7b4f2a5049b61f234b78801326592be8cf5f307fd3d884de7d898d2f8dadb51591103b1ddc90b4575dd3576532b2b62eb643b", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Cedar/sha512/6e228f75d8f36cbe9d46a778e419ffc9fcc559cb7eed44d509da59bd44aa21bfcf8f914297ec729f349d158657ac89f107a5b0141fe233da6b40002061c0f8fa", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Cedar/sha512/65556772b399409a001d97e6f14a9b2dd23543467daf5a7bb4ac5036db449f463818ccd7b8984f2f788787b9b7e423eabe19e5c841afe99e56a4e88de4a1b6ac", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Cedar/sha512/6b5da10db6b38f4e718802caa7ee2cc83c5978ccdb08ac3296d87e3aa4012c32c0df959dc80605c31b47ba19d16206b8954a2a069d2f5365d9af0335e6b79bb4"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-08-01 16:40:56.822580) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-08-01 16:40:56.824411) ========= 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=78329bfc0fd5309db0a6e0ac000001b4-1501626263.871003-2094513666 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004468 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-08-01 16:40:56.908208) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-08-01 16:40:56.908495) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-08-01 16:40:56.911784) ========= ========= Total master_lag: 0.18 =========