builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-065 starttime: 1502925680.39 results: success (0) revision: 1d38626ba9686d119e489db538ce84f8f9854217 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-08-16 16:21:20.389885) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-08-16 16:21:20.390893) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-08-16 16:21:20.391468) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-08-16 16:21:20.483279) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-16 16:21:20.483631) ========= 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=523ca41ca1e0623de333ad52000001bf-1502925520.224882-423439349 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-08-16 16:21:20-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 46.0M=0s 2017-08-16 16:21:20 (46.0 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.107403 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-16 16:21:20.610854) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-08-16 16:21:20.611251) ========= 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=523ca41ca1e0623de333ad52000001bf-1502925520.224882-423439349 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014628 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-08-16 16:21:20.664274) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 55 secs) (at 2017-08-16 16:21:20.664655) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 1d38626ba9686d119e489db538ce84f8f9854217 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'python archiver_client.py mozharness --repo mozilla-central --rev 1d38626ba9686d119e489db538ce84f8f9854217 --destination scripts --debug'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=523ca41ca1e0623de333ad52000001bf-1502925520.224882-423439349 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-08-16 16:21:20,748 truncating revision to first 12 chars 2017-08-16 16:21:20,748 Setting DEBUG logging. 2017-08-16 16:21:20,748 attempt 1/10 2017-08-16 16:21:20,748 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/1d38626ba968?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-08-16 16:21:21,362 attempt 1/10 2017-08-16 16:21:22,344 current task status: no status available at this point. state: PENDING 2017-08-16 16:21:22,345 sleeping for 11.00s (attempt 1/10) 2017-08-16 16:21:33,356 attempt 2/10 2017-08-16 16:21:33,926 current task status: no status available at this point. state: PENDING 2017-08-16 16:21:33,927 sleeping for 16.50s (attempt 2/10) 2017-08-16 16:21:50,443 attempt 3/10 2017-08-16 16:21:51,003 current task status: no status available at this point. state: PENDING 2017-08-16 16:21:51,003 sleeping for 24.75s (attempt 3/10) 2017-08-16 16:22:15,778 attempt 4/10 2017-08-16 16:22:16,090 current task status: Task completed! Check 's3_urls' for upload locations. state: SUCCESS 2017-08-16 16:22:16,307 unpacking tar archive at: mozilla-central-1d38626ba968/testing/mozharness/ program finished with exit code 0 elapsedTime=55.910623 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 55 secs) (at 2017-08-16 16:22:16.590051) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-08-16 16:22:16.590442) ========= script_repo_revision: 1d38626ba9686d119e489db538ce84f8f9854217 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-08-16 16:22:16.592776) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-08-16 16:22:16.593088) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-08-16 16:22:16.605632) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 53 secs) (at 2017-08-16 16:22:16.605970) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-Non-PGO'] 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=523ca41ca1e0623de333ad52000001bf-1502925520.224882-423439349 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 16:22:16 INFO - MultiFileLogger online at 20170816 16:22:16 in /builds/slave/test 16:22:16 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 16:22:16 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 16:22:16 INFO - {'append_to_log': False, 16:22:16 INFO - 'base_work_dir': '/builds/slave/test', 16:22:16 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 16:22:16 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 16:22:16 INFO - 'branch': 'Firefox-Non-PGO', 16:22:16 INFO - 'buildbot_json_path': 'buildprops.json', 16:22:16 INFO - 'code_coverage': False, 16:22:16 INFO - 'config_files': ('talos/linux_config.py',), 16:22:16 INFO - 'default_actions': ('clobber', 16:22:16 INFO - 'read-buildbot-config', 16:22:16 INFO - 'download-and-extract', 16:22:16 INFO - 'populate-webroot', 16:22:16 INFO - 'create-virtualenv', 16:22:16 INFO - 'install', 16:22:16 INFO - 'setup-mitmproxy', 16:22:16 INFO - 'run-tests'), 16:22:16 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 16:22:16 INFO - 'disable_ccov_upload': False, 16:22:16 INFO - 'download_minidump_stackwalk': True, 16:22:16 INFO - 'download_symbols': 'ondemand', 16:22:16 INFO - 'enable_stylo': False, 16:22:16 INFO - 'enable_webrender': False, 16:22:16 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 16:22:16 INFO - 'tooltool.py': '/tools/tooltool.py', 16:22:16 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 16:22:16 INFO - '/tools/misc-python/virtualenv.py')}, 16:22:16 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 16:22:16 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 16:22:16 INFO - 'gecko_profile': False, 16:22:16 INFO - 'gecko_profile_interval': 0, 16:22:16 INFO - 'installer_path': 'installer.exe', 16:22:16 INFO - 'log_level': 'info', 16:22:16 INFO - 'log_name': 'talos', 16:22:16 INFO - 'log_to_console': True, 16:22:16 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 16:22:16 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 16:22:16 INFO - 'opt_config_files': (), 16:22:16 INFO - 'pip_index': False, 16:22:16 INFO - 'suite': 'dromaeojs-e10s', 16:22:16 INFO - 'system_bits': '32', 16:22:16 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 16:22:16 INFO - 'title': 'talos-linux64-ix-065', 16:22:16 INFO - 'tooltool_cache': '/builds/tooltool_cache', 16:22:16 INFO - 'use_talos_json': True, 16:22:16 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 16:22:16 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 16:22:16 INFO - 'work_dir': 'build'} 16:22:16 INFO - [mozharness: 2017-08-16 23:22:16.797068Z] Running clobber step. 16:22:16 INFO - Running pre-action listener: _resource_record_pre_action 16:22:16 INFO - Running main action method: clobber 16:22:16 INFO - rmtree: /builds/slave/test/build 16:22:16 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 16:22:18 INFO - Running post-action listener: _resource_record_post_action 16:22:18 INFO - [mozharness: 2017-08-16 23:22:18.352268Z] Finished clobber step (success) 16:22:18 INFO - [mozharness: 2017-08-16 23:22:18.352370Z] Running read-buildbot-config step. 16:22:18 INFO - Running pre-action listener: _resource_record_pre_action 16:22:18 INFO - Running main action method: read_buildbot_config 16:22:18 INFO - Using buildbot properties: 16:22:18 INFO - { 16:22:18 INFO - "project": "", 16:22:18 INFO - "product": "firefox", 16:22:18 INFO - "who": "kwierso@gmail.com", 16:22:18 INFO - "installer_path": "public/build/target.tar.bz2", 16:22:18 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 16:22:18 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 16:22:18 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-e10s", 16:22:18 INFO - "stage_platform": "linux64", 16:22:18 INFO - "basedir": "/builds/slave/test", 16:22:18 INFO - "buildnumber": 1081, 16:22:18 INFO - "platform": "ubuntu64_hw", 16:22:18 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 16:22:18 INFO - "slavebuilddir": "test", 16:22:18 INFO - "taskId": "HU1bmvHCQ_SDOUS3EYrnnw", 16:22:18 INFO - "branch": "mozilla-central", 16:22:18 INFO - "script_repo_revision": "production", 16:22:18 INFO - "revision": "1d38626ba9686d119e489db538ce84f8f9854217", 16:22:18 INFO - "slavename": "talos-linux64-ix-065", 16:22:18 INFO - "repo_path": "mozilla-central" 16:22:18 INFO - } 16:22:18 INFO - Finding installer, test and symbols from parent task. 16:22:18 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/HU1bmvHCQ_SDOUS3EYrnnw'}, attempt #1 16:22:18 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/HU1bmvHCQ_SDOUS3EYrnnw'}, attempt #1 16:22:19 INFO - Task dependencies: MwNIxikqQeW7ZnNry6c34A 16:22:19 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/MwNIxikqQeW7ZnNry6c34A'}, attempt #1 16:22:19 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/MwNIxikqQeW7ZnNry6c34A/artifacts/public/build/target.tar.bz2 16:22:19 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/MwNIxikqQeW7ZnNry6c34A/artifacts/public/build/target.test_packages.json 16:22:19 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/MwNIxikqQeW7ZnNry6c34A/artifacts/public/build/target.crashreporter-symbols.zip 16:22:19 INFO - Running post-action listener: _resource_record_post_action 16:22:19 INFO - [mozharness: 2017-08-16 23:22:19.707156Z] Finished read-buildbot-config step (success) 16:22:19 INFO - [mozharness: 2017-08-16 23:22:19.707378Z] Running download-and-extract step. 16:22:19 INFO - Running pre-action listener: _resource_record_pre_action 16:22:19 INFO - Running main action method: download_and_extract 16:22:19 INFO - mkdir: /builds/slave/test/build/tests 16:22:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:22:19 INFO - trying https://queue.taskcluster.net/v1/task/MwNIxikqQeW7ZnNry6c34A/artifacts/public/build/target.test_packages.json 16:22:19 INFO - Downloading https://queue.taskcluster.net/v1/task/MwNIxikqQeW7ZnNry6c34A/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 16:22:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/MwNIxikqQeW7ZnNry6c34A/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 16:22:20 INFO - Downloaded 989 bytes. 16:22:20 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 16:22:20 INFO - Using the following test package requirements: 16:22:20 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 16:22:20 INFO - u'common': [u'target.common.tests.zip'], 16:22:20 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 16:22:20 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 16:22:20 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 16:22:20 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 16:22:20 INFO - u'mozbase': [u'target.common.tests.zip'], 16:22:20 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 16:22:20 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 16:22:20 INFO - u'web-platform': [u'target.common.tests.zip', 16:22:20 INFO - u'target.web-platform.tests.tar.gz'], 16:22:20 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 16:22:20 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 16:22:20 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/MwNIxikqQeW7ZnNry6c34A/artifacts/public/build/target.common.tests.zip 16:22:20 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/MwNIxikqQeW7ZnNry6c34A/artifacts/public/build/target.common.tests.zip'}, attempt #1 16:22:20 INFO - Fetch https://queue.taskcluster.net/v1/task/MwNIxikqQeW7ZnNry6c34A/artifacts/public/build/target.common.tests.zip into memory 16:22:21 INFO - Content-Length response header: 54004033 16:22:21 INFO - Bytes received: 54004033 16:22:32 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 16:22:32 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/MwNIxikqQeW7ZnNry6c34A/artifacts/public/build/target.common.tests.zip 16:22:32 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/MwNIxikqQeW7ZnNry6c34A/artifacts/public/build/target.common.tests.zip'}, attempt #1 16:22:32 INFO - Fetch https://queue.taskcluster.net/v1/task/MwNIxikqQeW7ZnNry6c34A/artifacts/public/build/target.common.tests.zip into memory 16:22:33 INFO - Content-Length response header: 54004033 16:22:33 INFO - Bytes received: 54004033 16:22:45 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/MwNIxikqQeW7ZnNry6c34A/artifacts/public/build/target.talos.tests.zip 16:22:45 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/MwNIxikqQeW7ZnNry6c34A/artifacts/public/build/target.talos.tests.zip'}, attempt #1 16:22:45 INFO - Fetch https://queue.taskcluster.net/v1/task/MwNIxikqQeW7ZnNry6c34A/artifacts/public/build/target.talos.tests.zip into memory 16:22:45 INFO - Content-Length response header: 14496050 16:22:45 INFO - Bytes received: 14496050 16:22:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:22:46 INFO - trying https://queue.taskcluster.net/v1/task/MwNIxikqQeW7ZnNry6c34A/artifacts/public/build/target.tar.bz2 16:22:46 INFO - Downloading https://queue.taskcluster.net/v1/task/MwNIxikqQeW7ZnNry6c34A/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 16:22:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/MwNIxikqQeW7ZnNry6c34A/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 16:22:47 INFO - Downloaded 61751858 bytes. 16:22:47 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/MwNIxikqQeW7ZnNry6c34A/artifacts/public/build/target.tar.bz2 16:22:47 INFO - mkdir: /builds/slave/test/properties 16:22:47 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 16:22:47 INFO - Writing to file /builds/slave/test/properties/build_url 16:22:47 INFO - Contents: 16:22:47 INFO - build_url:https://queue.taskcluster.net/v1/task/MwNIxikqQeW7ZnNry6c34A/artifacts/public/build/target.tar.bz2 16:22:47 INFO - Running post-action listener: _resource_record_post_action 16:22:47 INFO - Running post-action listener: set_extra_try_arguments 16:22:47 INFO - [mozharness: 2017-08-16 23:22:47.267005Z] Finished download-and-extract step (success) 16:22:47 INFO - [mozharness: 2017-08-16 23:22:47.267103Z] Running populate-webroot step. 16:22:47 INFO - Running pre-action listener: _resource_record_pre_action 16:22:47 INFO - Running main action method: populate_webroot 16:22:47 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 16:22:47 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 16:22:47 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 16:22:47 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:22:47 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 16:22:47 INFO - 'tests': ['damp', 'tps']}, 16:22:47 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 16:22:47 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 16:22:47 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 16:22:47 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 16:22:47 INFO - 'other-e10s': {'tests': ['a11yr', 16:22:47 INFO - 'ts_paint', 16:22:47 INFO - 'tpaint', 16:22:47 INFO - 'sessionrestore', 16:22:47 INFO - 'sessionrestore_many_windows', 16:22:47 INFO - 'sessionrestore_no_auto_restore', 16:22:47 INFO - 'tabpaint']}, 16:22:47 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 16:22:47 INFO - 'perf-reftest-singletons-e10s': {'tests': ['bloom_basic_singleton']}, 16:22:47 INFO - 'svgr-e10s': {'tests': ['tsvgx', 16:22:47 INFO - 'tsvgr_opacity', 16:22:47 INFO - 'tart', 16:22:47 INFO - 'tscrollx', 16:22:47 INFO - 'tsvg_static']}, 16:22:47 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 16:22:47 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 16:22:47 INFO - 'talos_options': ['--mitmproxy', 16:22:47 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 16:22:47 INFO - '--firstNonBlankPaint'], 16:22:47 INFO - 'tests': ['tp6_google', 16:22:47 INFO - 'tp6_youtube', 16:22:47 INFO - 'tp6_amazon', 16:22:47 INFO - 'tp6_facebook']}, 16:22:47 INFO - 'tp6-stylo-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 16:22:47 INFO - 'talos_options': ['--stylo', 16:22:47 INFO - '--mitmproxy', 16:22:47 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 16:22:47 INFO - '--firstNonBlankPaint'], 16:22:47 INFO - 'tests': ['tp6_google', 16:22:47 INFO - 'tp6_youtube', 16:22:47 INFO - 'tp6_amazon', 16:22:47 INFO - 'tp6_facebook']}, 16:22:47 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 16:22:47 INFO - 'talos_options': ['--stylo', 16:22:47 INFO - '--stylo-threads=1', 16:22:47 INFO - '--mitmproxy', 16:22:47 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 16:22:47 INFO - '--firstNonBlankPaint'], 16:22:47 INFO - 'tests': ['tp6_google', 16:22:47 INFO - 'tp6_youtube', 16:22:47 INFO - 'tp6_amazon', 16:22:47 INFO - 'tp6_facebook']}, 16:22:47 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 16:22:47 INFO - 'talos_options': ['--xperf_path', 16:22:47 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:22:47 INFO - 'tests': ['tp5n']}}} 16:22:47 INFO - Running post-action listener: _resource_record_post_action 16:22:47 INFO - [mozharness: 2017-08-16 23:22:47.275631Z] Finished populate-webroot step (success) 16:22:47 INFO - [mozharness: 2017-08-16 23:22:47.275721Z] Running create-virtualenv step. 16:22:47 INFO - Running pre-action listener: _resource_record_pre_action 16:22:47 INFO - Running main action method: create_virtualenv 16:22:47 INFO - Creating virtualenv /builds/slave/test/build/venv 16:22:47 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 16:22:47 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 16:22:47 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 16:22:47 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 16:22:47 INFO - Using real prefix '/usr' 16:22:47 INFO - New python executable in /builds/slave/test/build/venv/bin/python 16:22:47 INFO - Installing distribute.............................................................................................................................................................................................done. 16:22:49 INFO - Installing pip.................done. 16:22:49 INFO - Return code: 0 16:22:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 16:22:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 16:22:50 INFO - Reading from file tmpfile_stdout 16:22:50 INFO - Output received: 16:22:50 INFO - pip 1.5.5 from /builds/slave/test/build/venv/local/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 16:22:50 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 16:22: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:22:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:22: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:22:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:22: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25141f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x261aa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27bda10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27babb0>, '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 0x27bbab0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27bbf40>, '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': '523ca41ca1e0623de333ad52000001bf-1502925520.224882-423439349', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 16:22: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', 'pip>=1.5'] in /builds/slave/test/build 16:22: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 pip>=1.5 16:22:50 INFO - Using env: {'DISPLAY': ':0', 16:22:50 INFO - 'HOME': '/home/cltbld', 16:22:50 INFO - 'LANG': 'en_US.UTF-8', 16:22:50 INFO - 'LANGUAGE': 'en_US:en', 16:22:50 INFO - 'LOGNAME': 'cltbld', 16:22:50 INFO - 'MAIL': '/var/mail/cltbld', 16:22:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:22:50 INFO - 'MOZ_NO_REMOTE': '1', 16:22:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:22:50 INFO - 'NO_EM_RESTART': '1', 16:22:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:22:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:22:50 INFO - 'PWD': '/builds/slave/test', 16:22:50 INFO - 'SHELL': '/bin/bash', 16:22:50 INFO - 'SHLVL': '1', 16:22:50 INFO - 'TERM': 'linux', 16:22:50 INFO - 'TMOUT': '86400', 16:22:50 INFO - 'USER': 'cltbld', 16:22:50 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1502925520.224882-423439349', 16:22:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:22:50 INFO - '_': '/tools/buildbot/bin/python'} 16:22:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:22:50 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 16:22:50 INFO - Cleaning up... 16:22:50 INFO - Return code: 0 16:22:50 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 16:22: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:22:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:22: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:22:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:22: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', '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 0x25141f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x261aa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27bda10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27babb0>, '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 0x27bbab0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27bbf40>, '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': '523ca41ca1e0623de333ad52000001bf-1502925520.224882-423439349', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 16:22: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', 'psutil>=3.1.1'] in /builds/slave/test/build 16:22: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 psutil>=3.1.1 16:22:50 INFO - Using env: {'DISPLAY': ':0', 16:22:50 INFO - 'HOME': '/home/cltbld', 16:22:50 INFO - 'LANG': 'en_US.UTF-8', 16:22:50 INFO - 'LANGUAGE': 'en_US:en', 16:22:50 INFO - 'LOGNAME': 'cltbld', 16:22:50 INFO - 'MAIL': '/var/mail/cltbld', 16:22:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:22:50 INFO - 'MOZ_NO_REMOTE': '1', 16:22:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:22:50 INFO - 'NO_EM_RESTART': '1', 16:22:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:22:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:22:50 INFO - 'PWD': '/builds/slave/test', 16:22:50 INFO - 'SHELL': '/bin/bash', 16:22:50 INFO - 'SHLVL': '1', 16:22:50 INFO - 'TERM': 'linux', 16:22:50 INFO - 'TMOUT': '86400', 16:22:50 INFO - 'USER': 'cltbld', 16:22:50 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1502925520.224882-423439349', 16:22:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:22:50 INFO - '_': '/tools/buildbot/bin/python'} 16:22:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:22:50 INFO - Downloading/unpacking psutil>=3.1.1 16:22:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:22:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:22:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:22:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:22:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 16:22:51 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:22:51 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:22:51 INFO - Installing collected packages: psutil 16:22:51 INFO - Running setup.py install for psutil 16:22:51 INFO - building 'psutil._psutil_linux' extension 16:22:51 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 16:22:52 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 16:22:52 INFO - building 'psutil._psutil_posix' extension 16:22:52 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 16:22:52 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 16:22:52 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:22:52 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:22:52 INFO - Successfully installed psutil 16:22:52 INFO - Cleaning up... 16:22:52 INFO - Return code: 0 16:22:52 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 16:22:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:22:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:22:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:22:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:22:52 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25141f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x261aa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27bda10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27babb0>, '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 0x27bbab0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27bbf40>, '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': '523ca41ca1e0623de333ad52000001bf-1502925520.224882-423439349', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 16:22:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 16:22:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 16:22:52 INFO - Using env: {'DISPLAY': ':0', 16:22:52 INFO - 'HOME': '/home/cltbld', 16:22:52 INFO - 'LANG': 'en_US.UTF-8', 16:22:52 INFO - 'LANGUAGE': 'en_US:en', 16:22:52 INFO - 'LOGNAME': 'cltbld', 16:22:52 INFO - 'MAIL': '/var/mail/cltbld', 16:22:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:22:52 INFO - 'MOZ_NO_REMOTE': '1', 16:22:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:22:52 INFO - 'NO_EM_RESTART': '1', 16:22:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:22:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:22:52 INFO - 'PWD': '/builds/slave/test', 16:22:52 INFO - 'SHELL': '/bin/bash', 16:22:52 INFO - 'SHLVL': '1', 16:22:52 INFO - 'TERM': 'linux', 16:22:52 INFO - 'TMOUT': '86400', 16:22:52 INFO - 'USER': 'cltbld', 16:22:52 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1502925520.224882-423439349', 16:22:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:22:52 INFO - '_': '/tools/buildbot/bin/python'} 16:22:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:22:52 INFO - Downloading/unpacking mozsystemmonitor==0.3 16:22:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:22:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:22:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:22:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:22:53 INFO - Downloading mozsystemmonitor-0.3.tar.gz 16:22:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 16:22:53 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 16:22:53 INFO - Installing collected packages: mozsystemmonitor 16:22:53 INFO - Running setup.py install for mozsystemmonitor 16:22:53 INFO - Successfully installed mozsystemmonitor 16:22:53 INFO - Cleaning up... 16:22:53 INFO - Return code: 0 16:22:53 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 16:22:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:22:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:22:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:22:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:22:53 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x25141f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x261aa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27bda10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27babb0>, '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 0x27bbab0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27bbf40>, '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': '523ca41ca1e0623de333ad52000001bf-1502925520.224882-423439349', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 16:22:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 16:22:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 16:22:53 INFO - Using env: {'DISPLAY': ':0', 16:22:53 INFO - 'HOME': '/home/cltbld', 16:22:53 INFO - 'LANG': 'en_US.UTF-8', 16:22:53 INFO - 'LANGUAGE': 'en_US:en', 16:22:53 INFO - 'LOGNAME': 'cltbld', 16:22:53 INFO - 'MAIL': '/var/mail/cltbld', 16:22:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:22:53 INFO - 'MOZ_NO_REMOTE': '1', 16:22:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:22:53 INFO - 'NO_EM_RESTART': '1', 16:22:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:22:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:22:53 INFO - 'PWD': '/builds/slave/test', 16:22:53 INFO - 'SHELL': '/bin/bash', 16:22:53 INFO - 'SHLVL': '1', 16:22:53 INFO - 'TERM': 'linux', 16:22:53 INFO - 'TMOUT': '86400', 16:22:53 INFO - 'USER': 'cltbld', 16:22:53 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1502925520.224882-423439349', 16:22:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:22:53 INFO - '_': '/tools/buildbot/bin/python'} 16:22:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:22:54 INFO - Downloading/unpacking jsonschema==2.5.1 16:22:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:22:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:22:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:22:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:22:55 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 16:22:55 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 16:22:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:22:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:22:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:22:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:22:55 INFO - Downloading functools32-3.2.3-2.tar.gz 16:22:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 16:22:55 INFO - warning: no files found matching '*.txt' 16:22:55 INFO - no previously-included directories found matching 'build' 16:22:55 INFO - no previously-included directories found matching 'dist' 16:22:55 INFO - no previously-included directories found matching '.git*' 16:22:55 INFO - Installing collected packages: jsonschema, functools32 16:22:55 INFO - Running setup.py install for functools32 16:22:55 INFO - warning: no files found matching '*.txt' 16:22:55 INFO - no previously-included directories found matching 'build' 16:22:55 INFO - no previously-included directories found matching 'dist' 16:22:55 INFO - no previously-included directories found matching '.git*' 16:22:55 INFO - Successfully installed jsonschema functools32 16:22:55 INFO - Cleaning up... 16:22:55 INFO - Return code: 0 16:22:55 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 16:22:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:22:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:22:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:22:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:22:55 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x25141f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x261aa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27bda10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27babb0>, '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 0x27bbab0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27bbf40>, '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': '523ca41ca1e0623de333ad52000001bf-1502925520.224882-423439349', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 16:22:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 16:22:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 16:22:55 INFO - Using env: {'DISPLAY': ':0', 16:22:55 INFO - 'HOME': '/home/cltbld', 16:22:55 INFO - 'LANG': 'en_US.UTF-8', 16:22:55 INFO - 'LANGUAGE': 'en_US:en', 16:22:55 INFO - 'LOGNAME': 'cltbld', 16:22:55 INFO - 'MAIL': '/var/mail/cltbld', 16:22:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:22:55 INFO - 'MOZ_NO_REMOTE': '1', 16:22:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:22:55 INFO - 'NO_EM_RESTART': '1', 16:22:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:22:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:22:55 INFO - 'PWD': '/builds/slave/test', 16:22:55 INFO - 'SHELL': '/bin/bash', 16:22:55 INFO - 'SHLVL': '1', 16:22:55 INFO - 'TERM': 'linux', 16:22:55 INFO - 'TMOUT': '86400', 16:22:55 INFO - 'USER': 'cltbld', 16:22:55 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1502925520.224882-423439349', 16:22:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:22:55 INFO - '_': '/tools/buildbot/bin/python'} 16:22:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:22:55 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 16:22:55 INFO - Cleaning up... 16:22:55 INFO - Return code: 0 16:22:55 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 16:22:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:22:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:22:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:22:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:22:55 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x25141f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x261aa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27bda10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27babb0>, '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 0x27bbab0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27bbf40>, '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': '523ca41ca1e0623de333ad52000001bf-1502925520.224882-423439349', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 16:22:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 16:22:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 16:22:55 INFO - Using env: {'DISPLAY': ':0', 16:22:55 INFO - 'HOME': '/home/cltbld', 16:22:55 INFO - 'LANG': 'en_US.UTF-8', 16:22:55 INFO - 'LANGUAGE': 'en_US:en', 16:22:55 INFO - 'LOGNAME': 'cltbld', 16:22:55 INFO - 'MAIL': '/var/mail/cltbld', 16:22:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:22:55 INFO - 'MOZ_NO_REMOTE': '1', 16:22:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:22:55 INFO - 'NO_EM_RESTART': '1', 16:22:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:22:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:22:55 INFO - 'PWD': '/builds/slave/test', 16:22:55 INFO - 'SHELL': '/bin/bash', 16:22:55 INFO - 'SHLVL': '1', 16:22:55 INFO - 'TERM': 'linux', 16:22:55 INFO - 'TMOUT': '86400', 16:22:55 INFO - 'USER': 'cltbld', 16:22:55 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1502925520.224882-423439349', 16:22:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:22:55 INFO - '_': '/tools/buildbot/bin/python'} 16:22:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:22:56 INFO - Downloading/unpacking blobuploader==1.2.4 16:22:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:22:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:22:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:22:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:22:57 INFO - Downloading blobuploader-1.2.4.tar.gz 16:22:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 16:22:57 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 16:22:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:22:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:22:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:22:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:22:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 16:22:57 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 16:22:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:22:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:22:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:22:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:22:57 INFO - Downloading docopt-0.6.1.tar.gz 16:22:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 16:22:57 INFO - Installing collected packages: blobuploader, requests, docopt 16:22:57 INFO - Running setup.py install for blobuploader 16:22:57 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 16:22:57 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 16:22:57 INFO - Running setup.py install for requests 16:22:58 INFO - Running setup.py install for docopt 16:22:58 INFO - Successfully installed blobuploader requests docopt 16:22:58 INFO - Cleaning up... 16:22:58 INFO - Return code: 0 16:22:58 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:22:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:22:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:22:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:22:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:22:58 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--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 0x25141f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x261aa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27bda10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27babb0>, '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 0x27bbab0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27bbf40>, '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': '523ca41ca1e0623de333ad52000001bf-1502925520.224882-423439349', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 16:22:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--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:22:58 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:22:58 INFO - Using env: {'DISPLAY': ':0', 16:22:58 INFO - 'HOME': '/home/cltbld', 16:22:58 INFO - 'LANG': 'en_US.UTF-8', 16:22:58 INFO - 'LANGUAGE': 'en_US:en', 16:22:58 INFO - 'LOGNAME': 'cltbld', 16:22:58 INFO - 'MAIL': '/var/mail/cltbld', 16:22:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:22:58 INFO - 'MOZ_NO_REMOTE': '1', 16:22:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:22:58 INFO - 'NO_EM_RESTART': '1', 16:22:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:22:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:22:58 INFO - 'PWD': '/builds/slave/test', 16:22:58 INFO - 'SHELL': '/bin/bash', 16:22:58 INFO - 'SHLVL': '1', 16:22:58 INFO - 'TERM': 'linux', 16:22:58 INFO - 'TMOUT': '86400', 16:22:58 INFO - 'USER': 'cltbld', 16:22:58 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1502925520.224882-423439349', 16:22:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:22:58 INFO - '_': '/tools/buildbot/bin/python'} 16:22:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:22:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:22:58 INFO - Running setup.py (path:/tmp/pip-UHZIQJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:22:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:22:58 INFO - Running setup.py (path:/tmp/pip-ZkhA1l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:22:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:22:58 INFO - Running setup.py (path:/tmp/pip-CMrgHn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:22:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:22:58 INFO - Running setup.py (path:/tmp/pip-rwo_hO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:22:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:22:58 INFO - Running setup.py (path:/tmp/pip-0kh2bo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:22:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:22:58 INFO - Running setup.py (path:/tmp/pip-LNuAGF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:22:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:22:58 INFO - Running setup.py (path:/tmp/pip-WL8l7y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:22:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:22:59 INFO - Running setup.py (path:/tmp/pip-Cg203W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:22:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:22:59 INFO - Running setup.py (path:/tmp/pip-yBRAqb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:22:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:22:59 INFO - Running setup.py (path:/tmp/pip-LNuBly-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:22:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:22:59 INFO - Running setup.py (path:/tmp/pip-pN3zyg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:22:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:22:59 INFO - Running setup.py (path:/tmp/pip-Qb4SW4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:22:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:22:59 INFO - Running setup.py (path:/tmp/pip-WMoHDM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:22:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:22:59 INFO - Running setup.py (path:/tmp/pip-w1X1WI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:22:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:22:59 INFO - Running setup.py (path:/tmp/pip-qbsYJ9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:22:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:22:59 INFO - Running setup.py (path:/tmp/pip-JzufL4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:22:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:22:59 INFO - Running setup.py (path:/tmp/pip-7L7lV_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:22:59 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 16:22:59 INFO - Running setup.py install for manifestparser 16:22:59 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 16:22:59 INFO - Running setup.py install for mozcrash 16:22:59 INFO - Running setup.py install for mozdebug 16:23:00 INFO - Running setup.py install for mozdevice 16:23:00 INFO - Installing dm script to /builds/slave/test/build/venv/bin 16:23:00 INFO - Running setup.py install for mozfile 16:23:00 INFO - Running setup.py install for mozhttpd 16:23:00 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 16:23:00 INFO - Running setup.py install for mozinfo 16:23:00 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 16:23:00 INFO - Running setup.py install for mozInstall 16:23:00 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 16:23:00 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 16:23:00 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 16:23:00 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 16:23:00 INFO - Running setup.py install for mozleak 16:23:00 INFO - Running setup.py install for mozlog 16:23:00 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 16:23:00 INFO - Running setup.py install for moznetwork 16:23:00 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 16:23:00 INFO - Running setup.py install for mozprocess 16:23:00 INFO - Running setup.py install for mozprofile 16:23:01 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 16:23:01 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 16:23:01 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 16:23:01 INFO - Running setup.py install for mozrunner 16:23:01 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 16:23:01 INFO - Running setup.py install for mozscreenshot 16:23:01 INFO - Running setup.py install for moztest 16:23:01 INFO - Running setup.py install for mozversion 16:23:01 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 16:23:01 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 16:23:01 INFO - Cleaning up... 16:23:01 INFO - Return code: 0 16:23:01 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:23:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:23:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:23:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:23:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:23:01 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--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 0x25141f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x261aa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27bda10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27babb0>, '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 0x27bbab0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27bbf40>, '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': '523ca41ca1e0623de333ad52000001bf-1502925520.224882-423439349', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 16:23:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 16:23:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 16:23:01 INFO - Using env: {'DISPLAY': ':0', 16:23:01 INFO - 'HOME': '/home/cltbld', 16:23:01 INFO - 'LANG': 'en_US.UTF-8', 16:23:01 INFO - 'LANGUAGE': 'en_US:en', 16:23:01 INFO - 'LOGNAME': 'cltbld', 16:23:01 INFO - 'MAIL': '/var/mail/cltbld', 16:23:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:23:01 INFO - 'MOZ_NO_REMOTE': '1', 16:23:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:23:01 INFO - 'NO_EM_RESTART': '1', 16:23:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:23:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:23:01 INFO - 'PWD': '/builds/slave/test', 16:23:01 INFO - 'SHELL': '/bin/bash', 16:23:01 INFO - 'SHLVL': '1', 16:23:01 INFO - 'TERM': 'linux', 16:23:01 INFO - 'TMOUT': '86400', 16:23:01 INFO - 'USER': 'cltbld', 16:23:01 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1502925520.224882-423439349', 16:23:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:23:01 INFO - '_': '/tools/buildbot/bin/python'} 16:23:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:23:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:23:01 INFO - Running setup.py (path:/tmp/pip-QnpvQX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:23:01 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 16:23:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:23:01 INFO - Running setup.py (path:/tmp/pip-tgpfBE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:23:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 16:23:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:23:01 INFO - Running setup.py (path:/tmp/pip-BGRUYW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:23:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 16:23:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:23:01 INFO - Running setup.py (path:/tmp/pip-8j3Ovd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:23:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.51 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 16:23:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:23:02 INFO - Running setup.py (path:/tmp/pip-_80S3s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:23:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 16:23:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:23:02 INFO - Running setup.py (path:/tmp/pip-SPru6x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:23:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 16:23:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:23:02 INFO - Running setup.py (path:/tmp/pip-9YfkKZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:23:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.10 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 16:23:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:23:02 INFO - Running setup.py (path:/tmp/pip-oyXi9u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:23:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.13 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 16:23:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:23:02 INFO - Running setup.py (path:/tmp/pip-YxTlcM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:23:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 16:23:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:23:02 INFO - Running setup.py (path:/tmp/pip-cCvS6O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:23:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.5 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 16:23:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:23:02 INFO - Running setup.py (path:/tmp/pip-3T5HLl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:23:02 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 16:23:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:23:02 INFO - Running setup.py (path:/tmp/pip-sOIeky-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:23:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 16:23:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:23:02 INFO - Running setup.py (path:/tmp/pip-UW6l3V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:23:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 16:23:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:23:02 INFO - Running setup.py (path:/tmp/pip-ZJ1ZSw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:23:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 16:23:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:23:02 INFO - Running setup.py (path:/tmp/pip-SWPdo0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:23:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 16:23:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:23:02 INFO - Running setup.py (path:/tmp/pip-wEOk2l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:23:02 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 16:23:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:23:02 INFO - Running setup.py (path:/tmp/pip-YMQasx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:23:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 16:23:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 16:23:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 16:23:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 16:23:02 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.51->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 16:23:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.51->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 16:23:02 INFO - Requirement already satisfied (use --upgrade to upgrade): requests in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozInstall==1.13->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 16:23:03 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 16:23:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:23:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:23:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:23:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:23:04 INFO - Downloading blessings-1.6.tar.gz 16:23:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 16:23:04 INFO - Installing collected packages: blessings 16:23:04 INFO - Running setup.py install for blessings 16:23:04 INFO - Successfully installed blessings 16:23:04 INFO - Cleaning up... 16:23:04 INFO - Return code: 0 16:23:04 INFO - Done creating virtualenv /builds/slave/test/build/venv. 16:23:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:23:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:23:04 INFO - Reading from file tmpfile_stdout 16:23:04 INFO - Current package versions: 16:23:04 INFO - argparse == 1.2.1 16:23:04 INFO - blessings == 1.6 16:23:04 INFO - blobuploader == 1.2.4 16:23:04 INFO - docopt == 0.6.1 16:23:04 INFO - functools32 == 3.2.3-2 16:23:04 INFO - jsonschema == 2.5.1 16:23:04 INFO - manifestparser == 1.1 16:23:04 INFO - mozInstall == 1.13 16:23:04 INFO - mozcrash == 1.0 16:23:04 INFO - mozdebug == 0.1 16:23:04 INFO - mozdevice == 0.51 16:23:04 INFO - mozfile == 1.2 16:23:04 INFO - mozhttpd == 0.7 16:23:04 INFO - mozinfo == 0.10 16:23:04 INFO - mozleak == 0.1 16:23:04 INFO - mozlog == 3.5 16:23:04 INFO - moznetwork == 0.27 16:23:04 INFO - mozprocess == 0.25 16:23:04 INFO - mozprofile == 0.28 16:23:04 INFO - mozrunner == 6.13 16:23:04 INFO - mozscreenshot == 0.1 16:23:04 INFO - mozsystemmonitor == 0.3 16:23:04 INFO - moztest == 0.8 16:23:04 INFO - mozversion == 1.4 16:23:04 INFO - psutil == 3.1.1 16:23:04 INFO - requests == 1.2.3 16:23:04 INFO - wsgiref == 0.1.2 16:23:04 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:23:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:23:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:23:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:23:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:23:04 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/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 0x25141f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x261aa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27bda10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27babb0>, '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 0x27bbab0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27bbf40>, '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': '523ca41ca1e0623de333ad52000001bf-1502925520.224882-423439349', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 16:23:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 16:23:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 16:23:04 INFO - Using env: {'DISPLAY': ':0', 16:23:04 INFO - 'HOME': '/home/cltbld', 16:23:04 INFO - 'LANG': 'en_US.UTF-8', 16:23:04 INFO - 'LANGUAGE': 'en_US:en', 16:23:04 INFO - 'LOGNAME': 'cltbld', 16:23:04 INFO - 'MAIL': '/var/mail/cltbld', 16:23:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:23:04 INFO - 'MOZ_NO_REMOTE': '1', 16:23:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:23:04 INFO - 'NO_EM_RESTART': '1', 16:23:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:23:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:23:04 INFO - 'PWD': '/builds/slave/test', 16:23:04 INFO - 'SHELL': '/bin/bash', 16:23:04 INFO - 'SHLVL': '1', 16:23:04 INFO - 'TERM': 'linux', 16:23:04 INFO - 'TMOUT': '86400', 16:23:04 INFO - 'USER': 'cltbld', 16:23:04 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1502925520.224882-423439349', 16:23:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:23:04 INFO - '_': '/tools/buildbot/bin/python'} 16:23:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:23:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 16:23:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 16:23:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 16:23:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 16:23:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 16:23:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 16:23:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 16:23:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 16:23:04 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 16:23:04 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 16:23:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:23:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:23:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:23:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:23:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 16:23:05 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 16:23:05 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 16:23:05 INFO - Installing collected packages: simplejson 16:23:05 INFO - Running setup.py install for simplejson 16:23:06 INFO - building 'simplejson._speedups' extension 16:23:06 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c simplejson/_speedups.c -o build/temp.linux-x86_64-2.7/simplejson/_speedups.o 16:23:06 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/simplejson/_speedups.o -o build/lib.linux-x86_64-2.7/simplejson/_speedups.so 16:23:06 INFO - Successfully installed simplejson 16:23:06 INFO - Cleaning up... 16:23:06 INFO - Return code: 0 16:23:06 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 16:23:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:23:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:23:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:23:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:23:07 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--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 0x25141f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x261aa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27bda10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27babb0>, '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 0x27bbab0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27bbf40>, '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': '523ca41ca1e0623de333ad52000001bf-1502925520.224882-423439349', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 16:23:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 16:23:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 16:23:07 INFO - Using env: {'DISPLAY': ':0', 16:23:07 INFO - 'HOME': '/home/cltbld', 16:23:07 INFO - 'LANG': 'en_US.UTF-8', 16:23:07 INFO - 'LANGUAGE': 'en_US:en', 16:23:07 INFO - 'LOGNAME': 'cltbld', 16:23:07 INFO - 'MAIL': '/var/mail/cltbld', 16:23:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:23:07 INFO - 'MOZ_NO_REMOTE': '1', 16:23:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:23:07 INFO - 'NO_EM_RESTART': '1', 16:23:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:23:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:23:07 INFO - 'PWD': '/builds/slave/test', 16:23:07 INFO - 'SHELL': '/bin/bash', 16:23:07 INFO - 'SHLVL': '1', 16:23:07 INFO - 'TERM': 'linux', 16:23:07 INFO - 'TMOUT': '86400', 16:23:07 INFO - 'USER': 'cltbld', 16:23:07 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1502925520.224882-423439349', 16:23:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:23:07 INFO - '_': '/tools/buildbot/bin/python'} 16:23:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:23:07 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 16:23:07 INFO - Cleaning up... 16:23:07 INFO - Return code: 0 16:23:07 INFO - Running post-action listener: _resource_record_post_action 16:23:07 INFO - Running post-action listener: _start_resource_monitoring 16:23:07 INFO - Starting resource monitoring. 16:23:07 INFO - [mozharness: 2017-08-16 23:23:07.313264Z] Finished create-virtualenv step (success) 16:23:07 INFO - [mozharness: 2017-08-16 23:23:07.313853Z] Running install step. 16:23:07 INFO - Running pre-action listener: _resource_record_pre_action 16:23:07 INFO - Running main action method: install 16:23:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:23:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:23:07 INFO - Reading from file tmpfile_stdout 16:23:07 INFO - Detecting whether we're running mozinstall >=1.0... 16:23:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 16:23:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 16:23:07 INFO - Reading from file tmpfile_stdout 16:23:07 INFO - Output received: 16:23:07 INFO - Usage: mozinstall [options] installer 16:23:07 INFO - Options: 16:23:07 INFO - -h, --help show this help message and exit 16:23:07 INFO - -d DEST, --destination=DEST 16:23:07 INFO - Directory to install application into. [default: 16:23:07 INFO - "/builds/slave/test"] 16:23:07 INFO - --app=APP Application being installed. [default: firefox] 16:23:07 INFO - mkdir: /builds/slave/test/build/application 16:23:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/target.tar.bz2', '--destination', '/builds/slave/test/build/application'] 16:23:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 16:23:25 INFO - Reading from file tmpfile_stdout 16:23:25 INFO - Output received: 16:23:25 INFO - /builds/slave/test/build/application/firefox/firefox 16:23:25 INFO - Running post-action listener: _resource_record_post_action 16:23:25 INFO - [mozharness: 2017-08-16 23:23:25.612758Z] Finished install step (success) 16:23:25 INFO - [mozharness: 2017-08-16 23:23:25.612973Z] Running setup-mitmproxy step. 16:23:25 INFO - Running pre-action listener: _resource_record_pre_action 16:23:25 INFO - Running main action method: setup_mitmproxy 16:23:25 INFO - Skipping: mitmproxy is not required 16:23:25 INFO - Running post-action listener: _resource_record_post_action 16:23:25 INFO - [mozharness: 2017-08-16 23:23:25.613793Z] Finished setup-mitmproxy step (success) 16:23:25 INFO - [mozharness: 2017-08-16 23:23:25.614012Z] Running run-tests step. 16:23:25 INFO - Running pre-action listener: _resource_record_pre_action 16:23:25 INFO - Running pre-action listener: _set_gcov_prefix 16:23:25 INFO - Running main action method: run_tests 16:23:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 16:23:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 16:23:25 INFO - Python 2.7.3 16:23:25 INFO - Return code: 0 16:23:25 INFO - grabbing minidump binary from tooltool 16:23:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:23:25 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 0x27babb0>, '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 0x27bbab0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27bbf40>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 16:23:25 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 16:23:25 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 16:23:25 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 16:23:25 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 16:23:25 INFO - Return code: 0 16:23:25 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 16:23:25 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 16:23:25 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 16:23:25 INFO - ENV: RUST_BACKTRACE is now full 16:23:25 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 16:23:25 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 16:23:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/MwNIxikqQeW7ZnNry6c34A/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-065', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 16:23:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/MwNIxikqQeW7ZnNry6c34A/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-065 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 16:23:25 INFO - Using env: {'DISPLAY': ':0', 16:23:25 INFO - 'HOME': '/home/cltbld', 16:23:25 INFO - 'LANG': 'en_US.UTF-8', 16:23:25 INFO - 'LANGUAGE': 'en_US:en', 16:23:25 INFO - 'LOGNAME': 'cltbld', 16:23:25 INFO - 'MAIL': '/var/mail/cltbld', 16:23:25 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 16:23:25 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 16:23:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:23:25 INFO - 'MOZ_NO_REMOTE': '1', 16:23:25 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 16:23:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:23:25 INFO - 'NO_EM_RESTART': '1', 16:23:25 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:23:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:23:25 INFO - 'PWD': '/builds/slave/test', 16:23:25 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 16:23:25 INFO - 'RUST_BACKTRACE': 'full', 16:23:25 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 16:23:25 INFO - 'SHELL': '/bin/bash', 16:23:25 INFO - 'SHLVL': '1', 16:23:25 INFO - 'TERM': 'linux', 16:23:25 INFO - 'TMOUT': '86400', 16:23:25 INFO - 'USER': 'cltbld', 16:23:25 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1502925520.224882-423439349', 16:23:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:23:25 INFO - '_': '/tools/buildbot/bin/python'} 16:23:25 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/MwNIxikqQeW7ZnNry6c34A/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-065', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 16:23:25 INFO - mozversion application_buildid: 20170816223054 16:23:25 INFO - mozversion application_changeset: 1d38626ba9686d119e489db538ce84f8f9854217 16:23:25 INFO - mozversion application_display_name: Nightly 16:23:25 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 16:23:25 INFO - mozversion application_name: Firefox 16:23:25 INFO - mozversion application_remotingname: firefox 16:23:25 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 16:23:25 INFO - mozversion application_vendor: Mozilla 16:23:25 INFO - mozversion application_version: 57.0a1 16:23:25 INFO - mozversion platform_buildid: 20170816223054 16:23:25 INFO - mozversion platform_changeset: 1d38626ba9686d119e489db538ce84f8f9854217 16:23:25 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 16:23:25 INFO - mozversion platform_version: 57.0a1 16:23:25 INFO - using testdate: 1502925805 16:23:25 INFO - actual date: 1502925805 16:23:25 INFO - starting webserver on 'localhost:48901' 16:23:25 INFO - SUITE-START | Running 2 tests 16:23:25 INFO - TEST-START | dromaeo_css 16:23:25 INFO - Initialising browser for dromaeo_css test... 16:23:25 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:48901/getInfo.html -profile /tmp/tmpi5Soa7/profile 16:23:25 INFO - TEST-INFO | started process 24310 (/builds/slave/test/build/application/firefox/firefox http://localhost:48901/getInfo.html) 16:23:31 INFO - TEST-INFO | 24310: exit 0 16:23:32 INFO - Browser initialized. 16:23:32 INFO - Running cycle 1/1 for dromaeo_css test... 16:23:32 INFO - TEST-INFO | started process 24522 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpi5Soa7/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 16:23:33 INFO - PID 24522 | 16:23:33 INFO - PID 24522 | (/builds/slave/test/build/application/firefox/firefox:24570): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 16:23:33 INFO - PID 24522 | 16:23:43 INFO - PID 24522 | RSS: Main: 164368384 16:23:43 INFO - PID 24522 | 16:26:42 INFO - PID 24522 | Cycle 1(1): loaded http://localhost:48901/tests/dromaeo/cssquery-dojo.html (next: http://localhost:48901/tests/dromaeo/cssquery-ext.html) 16:26:43 INFO - PID 24522 | RSS: Main: 171937792 16:26:43 INFO - PID 24522 | 16:29:45 INFO - PID 24522 | Cycle 1(1): loaded http://localhost:48901/tests/dromaeo/cssquery-ext.html (next: http://localhost:48901/tests/dromaeo/cssquery-jquery.html) 16:29:46 INFO - PID 24522 | RSS: Main: 169123840 16:29:46 INFO - PID 24522 | 16:32:47 INFO - PID 24522 | Cycle 1(1): loaded http://localhost:48901/tests/dromaeo/cssquery-jquery.html (next: http://localhost:48901/tests/dromaeo/cssquery-mootools.html) 16:32:48 INFO - PID 24522 | RSS: Main: 171073536 16:32:48 INFO - PID 24522 | 16:35:49 INFO - PID 24522 | Cycle 1(1): loaded http://localhost:48901/tests/dromaeo/cssquery-mootools.html (next: http://localhost:48901/tests/dromaeo/cssquery-prototype.html) 16:35:50 INFO - PID 24522 | RSS: Main: 169259008 16:35:50 INFO - PID 24522 | 16:38:54 INFO - PID 24522 | Cycle 1(1): loaded http://localhost:48901/tests/dromaeo/cssquery-prototype.html (next: http://localhost:48901/tests/dromaeo/cssquery-yui.html) 16:38:55 INFO - PID 24522 | RSS: Main: 170872832 16:38:55 INFO - PID 24522 | 16:41:56 INFO - PID 24522 | Cycle 1(1): loaded http://localhost:48901/tests/dromaeo/cssquery-yui.html (next: http://localhost:48901/tests/dromaeo/cssquery-dojo.html) 16:41:56 INFO - PID 24522 | RSS: Main: 173637632 16:41:56 INFO - PID 24522 | 16:41:56 INFO - PID 24522 | __start_tp_report 16:41:56 INFO - PID 24522 | _x_x_mozilla_page_load 16:41:56 INFO - PID 24522 | _x_x_mozilla_page_load_details 16:41:56 INFO - PID 24522 | |i|pagename|runs| 16:41:56 INFO - PID 24522 | |0;dojo.html;3169.065125787893;3176.3170918252586;3181.7295529879966;3192.9042128736132;3221.693939075787;6186.195794546703;6244.313125556191;6280.96364099923;6291.937080629198;6308.337624549425;6019.5485338599565;6085.665288409135;6205.22434695663;6233.033879748635;6275.309715931244;5647.632903861236;5653.378128405872;5664.631798933076;5674.2623458950275;5724.7996320128805;5731.627444216134;5732.79935202268;5750.281214848144;5766.365699773021;5833.941660583403;828.83934433589;5591.9720401398135;5706.001449746299;5736.024875771108;5784;5222.8694282642855;5622.212890195376;5714.285714285715;5714.285714285715;5733.569982251348;5600.087083877625;5602.327720673505;5681.147827825818;5688.516476099537;5710.8001219957105;6117.908231376488;6134.141220229171;6161.815145545641;6248.812535623939;6258.499320054385;6622.602062859128;6639.834004149935;6707.899381509281;6717.462602991798;6730.259671436138;6575.506836987197;6660.433863121641;6698.698558564876;6732.528722989393;6816.250212476623;6270.87458250837;6275.623462592304;6288.779892703779;6289.811305660837;6301.779437719658;6907.033015377851;6920.930790692129;7011;7020.5787652741;7024.367806897404;6545.149130613085;6560.901586476207;6599;6668.799936001928;6669.799906002828;6535.281119076898;6575.112359831457;6635.568688035262;6647.401733843977;6678.53250272486;6610.900836487456;6611.570247933869;6616.1399018128295;6628.8674226515195;6642.501812364092;6672;6730;6746.932530674729;6762.256151823295;6778.2205046420295;5339.41266460689;5438.265834112423;5498.147787093007;5514.862128446821;5520.199571062173;4643.4660014098135;4668.8132474701315;4680.789364478606;4715.24556071027;4731.597814185764;5802.129680547867;5872.412758724094;5873.030949893306;5875.882482350329;5908.822735317947;6611.702473388709;6711.597304161766;6726.260111387744;6757.662116894136;6857.519973601899;5778;5821;5821.446962538552;5822.534197264209;5822.534197264209;5984.910226346608;5991.850203744854;6002.789902353396;6006;6033;6504.1869766279215;6577.506686998398;6586.934130658632;6598.43913267368;6604.075429439882;6730.0914376560495;6734.528582999339;6735.49483788708;6745.055692203194;6838.589684618939;6372.6495042773095;6469.28837827848;6477.417032466912;6491.285958544462;6492.31830657793;6539.869202616016;6620.337966203341;6622.8344291393105;6624.403803657501;6631.933680663132;6734.595924244561;6742.528023038536;6823.351781580742;6824.829379265558;6842.7605033823575;6570.11303474044;6586.2755096940255;6600.372964568358;6601.966990165019;6602.471802255712;6511.902321465087;6534.281229064894;6626.966865165643;6631.734730610914;6635.369639884397;6343.080253363144;6438.356164383524;6442.838929026624;6446.258680251831;6541.476681865344;6514.51141164424;6587.571807832475;6669.399754022162;6689.49828762835;6699.162604674416;6407.519436042222;6425.228972523327;6440.420362167428;6512.283648798723;6525.967370163119 16:41:56 INFO - PID 24522 | |1;ext.html;753.3746989998302;812.8171161488664;823.5429336718121;828.4490813608954;1148.6496618531344;31309;31851.52222716661;41715.582844171586;42528.57471425285;42662.36006459906;42092.57907420925;42317.15365692692;42469.57530424695;42857.14285714284;43047.569524304745;7227.241139680336;7655.157932627407;7819.296263336299;7820.960895195516;7824.843503129934;7596.202398748134;7740.612969351538;7745.070591529025;7745.1867553906595;7753.767386978399;7718.035245594301;7734.226577342249;7814.882776758353;7825.765227043169;7827.1390147083775;7745.225477452266;7775.98912141418;7777.844443111135;7779.066512018538;7779.144294127642;7645.732399366051;7696.769096927102;7710.383169346439;7713.305802477747;7742.109657389416;38613.806930965446;38816;38820.61179388198;38900.416493752615;38965.415518767244;3507.438809790421;3529.100079479742;3533.452314891196;3546.6098729139776;3551.5738111426795;31523.684763152534;31534.36931261362;31547.36905261882;31552.52671209911;31598.210044748834;4960.90078198434;4963.4292056413615;4981.72600506972;5015.6238282128625;5020.924686129711;188027;189261;190183;190435;190539;48060.27909581359;48231;48497.272540911916;48498.272525912136;48734.51265487371;50975.235371469455;50985.49014509882;51051.74474127606;51144.744276279125;51154.97690046253;16154.1115238663;16407.1796410179;16448;16453.83546164523;16464.4237451691;10320.638777642747;10443.164546836235;13400;13432.462701492026;13637;14252.857471425361;14312.570622881121;14342.139471631526;14375.28123593816;14411.279436028157;5709.430756159744;5762.9135562966585;5806.071028635482;5830.446107619854;5858.179854820329;1020.3826684855555;1020.6121673763922;1035.8290882004385;1042.7966546523508;1043.9582416703247;22890.542189156124;23403.297901062997;23753;30769.538456923165;31139.221519462193;1105.4251789069638;1107.379867274329;1110.9944450277696;1122.5846436818429;1136.8465257190173;12684.80972785409;12779.808302875465;12883.420246088948;12898.613041608767;12901;250896;253068;253083;253435;253702;55214;55216.44783552193;55350.16974745382;55402.72298638481;55590.72204638951;1504.9097054176566;1508.3363320139104;1532.8999270998581;1545.4050190676671;1550.07770376628;23253.651195231745;23319.183828565918;23497.530049399258;23606.409839754142;23747.64378534358;39349.60650393459;39424.802875985435;39613.40579891246;39623.60376396315;39626.801865990485;207193;207220;207359;207466;209374;36380.81809590935;36406;37924.24151517009;38101.61898380981;38264.2347153061;46191.53808462007;47371;47753.761231193625;47974;48083.519164807905;35066;35128.29743405066;35271.11822204466;35474.290514190085;35700.46449303211;34140.487892681136;34636.82681586677;34719.82640086783;35201.82399087988;35254.11864703403;37484.625153749206;37941.81029094837;37994.62005379911;38053.61946380501;38339.6166038336;33173.66826331706;33713.3257334847;34180.82909585436;34273.14317142092;34301.48547771835;24588.87705561461;24821.379465513506;25110;25131.623025654266;25459.36351591225 16:41:56 INFO - PID 24522 | |2;jquery.html;555.837790993037;562.3898070593406;566.2101368590813;578.6961845031359;585.7715490958526;22106.22628208011;22874.31377058687;22922;22957.655635165487;22960.88519557402;24905.37736556587;27284.181474555746;27330.726692733067;27367.178984630493;27412.314692132706;6539.673016349176;6701.229358623772;6719.0593316935665;6720.5295629305965;6721.563098398588;6232.750689972396;6513.967430162867;6516.152900123001;6620.238672552646;6670.199576050881;6441.645709485976;6476.902846457307;6481.189851268591;6495.382938620824;6500.512461565378;6426.839329016789;6440.291567927524;6441.516886233504;6448;6451.322611125858;6001.579889407743;6042.425969532887;6042.788502402439;6044.637321760709;6055.364186760371;28148.577771333446;29980.70019299801;30291.545626815616;30854.69145308563;31221.37557248842;1941.2332128809041;1977.9208831646717;1980.2771988224338;1981.5442448236843;1983.2860170338668;19641.41075767729;19983.700244496344;19987.20051197965;20001.299954501523;20023.399298021082;2409.7831195192516;2434.257551446808;2471.8269721119527;2479.6280557916275;2494.052260141153;131338;139636;143987.28006360005;144120.2793986034;144235;14727;15424.768628470581;15428.845711542965;15485.148316842457;15491.767623485657;23977.640335394983;23986;23994.28017159488;23997.16009939644;24018.919148638353;9699.418034917928;9837.803243935225;9895.307328486937;9992.25058120644;10064.144547713526;7637.5035622684345;9012.324075694349;9061.68284110053;9119.498427586546;9147.95426022879;8135.633896474673;9105.681301154427;9143.63425462974;9151.496667683341;9232.446053236827;2641.867906604662;2686.693779784909;2718.9320266993086;2750.149790293605;2893.348996475776;961.4808003677936;985.6451677396132;986.7631768375538;999.6051559633904;1001.0740065439439;19733.309334173235;20189.32487449133;20677.379678609665;20908;20989.37031889046;1037.071820720451;1042.5673345561506;1042.8227201375785;1050.837120246363;1059.5073290919606;11300.773984520263;11353.489092990836;11479.655610331703;11483.311001339946;11597.594084207012;547319;554552;564971;567682;574203;115664;116446;117448;122646;124519;1241.4103300931986;1263.943122559487;1292.3150730113243;1293.3856418201278;1295.9092863499463;20729.68905466389;21023.264185753425;21145.788542115;21278.574428511653;21495.46261343479;56589.71705141448;57838.7108064457;59037.409625903194;59110.704446477495;60607.696961514914;67917.3208267911;69095.3090469089;69486.65256673684;69559;70209;14969.850301496846;15281.235938203268;15317;15320.540383788504;15322.233888305318;23640.88179559091;23952.28143155708;24101.638475423235;24390.51218975646;24520;19309.903450482656;19543.120559575138;19626.803731962496;19627.509312267306;19744.605107897474;17144.314227431263;17438.564035899202;17545.736813947547;17817.376391826223;18198.5450363742;19118;19911.502212444226;19984.50038749043;20011.699824502353;20030.79815211092;14800.851991479947;15045;15171.165585892883;15178.544643660707;15232.466863659718;18660.2535898568;19076.809231907504;19120.713189301892;19179.136938838066;19212.519687007938 16:41:56 INFO - PID 24522 | |3;mootools.html;1355.2546099645192;1402.193738600305;1410.478123094455;1416.7237388709207;1417.893657975652;13581.253031083286;14647.633809154777;14668.559943201695;14673.92663036686;14682.119072855636;14981.850181498181;15185.240737963086;15245.237738113077;15261;15280.541583752478;2696.298962269804;2748.9725102749017;2751.9587206191923;2752.981396883146;2754.848483333416;2566.2814411964678;2599.8440093594445;2602.687677478705;2606.153000274918;2630.539655560279;2590.4042070323835;2602.08926875593;2618.253797667665;2624.8293860899075;2631.1317265302405;2516.48412075525;2534.0244006057615;2536.441982763789;2543.3133054075297;2543.8600876951855;2504.5742223821994;2505.498900219963;2511.3972646564694;2515.622656601506;2522.3567990162574;14100.365483553265;14320.785188222186;14372.49696260626;14384.928075359556;14428.639284017878;7445.106587209515;7741.148473667892;7776.688932442752;7792.493487923323;7810.882836757453;4977.278294647292;5062.0888240116765;5120.385553733576;5235.712035838027;5245.527902488794;1806.5393324702247;1812.682780513418;1820.1354356680604;1852.8147185281364;1871.3824437935448;24217.273481795575;25137.24588262355;25148.11981580636;25221.36946576332;25253.62119568208;6437.678116094176;6442.130312407765;6474.482041436674;6568.967155164193;6660.333966603398;16639.41762038323;16754.246058927132;16784.916075419544;16792.496225113267;16818.411355602497;7473.626318684044;7604.505707129129;7605.961970190225;7610.695572177162;7615.124260709978;6890.345417185359;6903.309669033057;7029.5430796998035;7056.294370562902;7069.8939515907305;5105.463926287761;5263.605229607795;5282.6302158849285;5295.867603309948;5325.547328477122;1548.8451154884422;1552.037736603313;1553.9456119035779;1557.5093845438878;1578.7552929295978;882.3470631732472;900.9278958039912;902.4585248850638;904.9547522623842;917.000469488261;7330.193678695339;7360.374368178657;7377.3360397564475;7418.925810741932;7450.143233528105;690.5166383531548;693.2478261086677;695.2838576266454;702.0382076555152;712.807541963667;5070.3155074064525;5142.922856157161;5161.81933632321;5258;5421.295231619864;19769.209231630863;20752.792472075085;20877.060532276086;20959.580808383747;20977.265795697076;19960.20159193645;20367;20534.383968480968;20555.8972205138;20703.792962070187;9822.901770982198;10233.539490722935;11011.779764404828;11088.889111108785;11286.830697539543;8551.57242137903;8639.740807775777;8660.566971651266;8702.173293537104;8769.298456123623;17710.380136695152;17813.910930445265;17925.551861203054;18217.817821821613;18303.72544411808;17971;18276.45170644883;18284.908575457037;18344.357947471774;18392.816071839112;10832.891671083189;10940.39827809478;10944.726381840517;10945.726356841144;10953.123750099814;13459.798103028266;13599.456021759019;13720.65698357549;13733.313334333043;13753.587392378246;10817.945910270399;10838.13294936419;10921.726956825825;10981.61564345244;11298.887011129784;10590.629327973484;10693.3049351795;10759.784804304027;10785.730356741144;10792.676219713421;9332.39339442934;9502.904970950201;9545.331826772059;9548.331616786758;9570.56932438028;6879.0025446309;6956.826079347854;7051.365377115879;7066.576005439484;7073.787786366417;7013.684384202825;7166.53417527859;7221.747238846615;7278.381337586365;7280.235575264521 16:41:56 INFO - PID 24522 | |4;prototype.html;500.5670095367506;504.7734006364535;521.8538809133443;526.0951163997922;532;6277.901367260728;6335.334789847069;6362.741226864466;6372.362763723625;6460.41856232939;6106.5725399221965;6166.506679465643;6175.845603859906;6188.164597779299;6219.284782250043;4943.703377797326;5034.09386310464;5046.116929537335;5067.467915868836;5081.009203205376;4848.248521479177;4985.227289770091;5063.949360506403;5066.695998240118;5078.669886457387;4926.5566099051075;4964.578010869081;4970.782158371186;4998.10034193845;5025;4902.607791376681;4974.830914735035;5001.44984051754;5011.1163848017895;5048.6465947383695;4469.128519938613;4496.55034496551;4510.391097201868;4513.1425029244665;4527.117212143633;6041.275046994345;6053.606515576474;6065;6077.118817771398;6099.84750381244;5737.598368114233;5763.337216220147;5816.934988079213;5816.941830581683;5818.359980402152;6368.5481089780305;6512.967435162841;6522.380373864476;6524.902126468107;6555.213374395055;4887.242477416006;4888.73111978841;4913.926291105637;4942.283368911488;4970.676906001098;6910.758123465705;6930.643581182422;7076.752313668997;7091.21343093415;7099.36105750485;5006.299118123466;5015.24771284303;5031.974840125776;5059.974700126476;5063.493650634907;5124.974375128175;5133.307003554547;5143.305653736697;5152.407473140637;5171.198464238049;5763.94236057634;5789.913151302734;5797.884042319214;5799;5807.373935298123;6546.967265163644;6568.704408301638;6618.63597502142;6680.96659516709;6701.195856497154;1682.2261759590726;1708.6070203853183;1714.5340733672779;1725.3271224222563;1794.8653850960968;1232.896557580978;1246.956356527517;1248.7877060899668;1266.9429875655617;1269.3335998600808;5695.373508914016;5704.657720536781;5712.485876271073;5721.942780572141;5728.398518155534;6597.340265973365;6646.335366463411;6657.703092433103;6689.799306020827;6705.731770729214;5661.716914154358;5666.461686139893;5666.97166514173;5667.914981275284;5680.857978550569;3485.5643044619424;3489.4068008438626;3534.770239934396;3591.425371940477;3592;6010.308814486302;6403.886717383252;6431.356864313625;6443.742250309935;6496.7726129585235;6680.3987641112535;6767.323267673193;6787.457003439713;6793.728250870009;6852.623105729133;6408.166938297992;6446.226452825504;6446.7421303148285;6450.6774661266745;6507.772227972093;6683.231428385603;6688.3646053624825;6695.4308883745425;6706.128203333536;6707.5975441473665;6624.15161480568;6657.367550082734;6659.367360100783;6681.599104053772;6709.396154346132;6487.675616219264;6503.642299673564;6506.642134682448;6525.2822189558165;6531.771388001397;5067.949320506896;5086.18621020635;5088.2876397305145;5099.643024988215;5112.821051263188;6642.047981451029;6677.29888361715;6678.766243181465;6710.4631629470505;6726.159230096238;6483.157189565326;6509.446697030806;6523.282438931618;6528.771492997722;6558.475321974326;6454.419102280817;6465.288818229897;6465.321141280097;6486.189226346707;6495.512836537184;6401.327860574759;6442.935570644234;6474.384933431316;6485.319041500575;6495.253045899593;6493.22081350241;6568.80293591193;6570.5729127608465;6572.4084832365315;6589.670516474253;6155.815325540241;6175.44421002094;6330.49356051524;6350.079238510482;6419.2296924369375 16:41:56 INFO - PID 24522 | |5;yui.html;928.9581968811402;929.0848514213499;937.0488953711979;939.4504215034204;941.2422999485414;19127.808721912777;19745.506362340948;19829.10769015394;19970.50073748155;21590.568188636258;20667.379978600668;22365.44086397841;22369.217077402292;22395.664065039036;22441.55116897661;1036.7719101797593;1078.9730256743567;1081.1729027294127;1081.8593582834221;1082.3343643659132;1077.2243984331308;1079.6275285026693;1082.5345101606306;1083.4149559238;1085.2837127495816;1138.4535422996967;1140.3556990300494;1140.6863112644048;1140.8916152965455;1142.497301187479;1124.9493772780245;1127.808272593661;1127.9041281491084;1128.311729844794;1128.740389710367;825.5872063968015;826.6486743134204;826.7147833997261;827.3587969323762;828.4780588229437;20018.199272029102;20136.79863201364;20351.084201210982;20875.5824883503;20895.895520522452;21699.891500542555;22170.11319547216;22266.220682276205;22339.106435742713;22406.551868962528;16722.16389180536;16906.40827571029;16956.660866782597;17123.31506739729;17140.914295428443;3659.14010207601;3667.651573100551;3677.8161091945562;3687.1335236219466;3687.985803903921;128696;129595;129790;130212;131539.34230328884;17006;17139.1303481993;17340.65318693619;17380;17540.473785786446;30748.231294217378;30761.384772304427;31793.205169870937;31924;32125.357492850013;7589.316961473494;8516.148385161558;8615.526146062026;8670.479771213748;9289.953550232205;4201.390798334285;4327.459067616548;4333.566643335641;4337.804798784062;4337.956620433818;5079.517445842639;5157.226416037624;5163.612729045337;5165.535101840853;5181.248718935733;1013.9290249682451;1034.6895931220604;1035.502958579886;1044.4882007816268;1045.8012977534397;690.2372877969771;699.800556841308;708.125465050662;710.6979533698261;711.7686751805684;11448.54205831774;12200.206986545845;12215.633530994084;13002.479900803863;13204;678.396227357652;681.2200030964617;683.8666460040245;691.339770519163;699.1121275979477;5728.656280623176;5860.501857342174;5862.941370586324;5882.117682347682;5976.043832986701;110496.4475177619;112879.4356028231;113349;114521;116352.41823790997;98357.50821245847;99441.50279248557;99448;100036.99963000277;104276.47861760795;85079.14920850836;85822;85996.57001715076;86498;89523.55238223898;10640.616719826374;10744.83882741775;10790.504356166522;10852.348859068481;11020.724481888017;40277.79861100676;40774.1845163101;40816.79591602023;41054.79472602618;41274.58725412707;52688;52769.47230527799;53026.469735302155;54001.72999134979;54045.72977135247;15461.226938653248;15531.145786981824;15726;15767.132807695687;15808.446704365291;17337;20044.498887527927;21103;21240.78759212388;21359.14563417508;17409.216585253947;17664.205110769788;17675.469735907944;17696.91151544234;17783;18867.245310187438;18956.43130706081;19052.809471905104;19081.42755717331;19125.808741912402;18147.364842230458;18163.727544086585;18475.16861741198;18582.349617763313;18718.906405467886;13835.100718453268;13854.445822167001;13895.513657021957;13950.720985580434;13956.720865582429;14395;14426.990110692152;14460.421583136978;14478.203698796246;14481.710365792414 16:41:56 INFO - PID 24522 | __end_tp_report 16:41:56 INFO - PID 24522 | __start_cc_report 16:41:56 INFO - PID 24522 | _x_x_mozilla_cycle_collect,386 16:41:56 INFO - PID 24522 | __end_cc_report 16:41:56 INFO - PID 24522 | __startTimestamp1502926916968__endTimestamp 16:41:56 INFO - PID 24522 | 16:41:56 INFO - PID 24522 | ------- Summary: start ------- 16:41:56 INFO - PID 24522 | Number of tests: 6 16:41:56 INFO - PID 24522 | 16:41:56 INFO - PID 24522 | [#0] dojo.html Cycles:165 Average:6149.21 Median:6469.29 stddev:840.30 (13.0%) stddev-sans-first:809.71 16:41:56 INFO - PID 24522 | Values: 3169.1 3176.3 3181.7 3192.9 3221.7 6186.2 6244.3 6281.0 6291.9 6308.3 6019.5 6085.7 6205.2 6233.0 6275.3 5647.6 5653.4 5664.6 5674.3 5724.8 5731.6 5732.8 5750.3 5766.4 5833.9 828.8 5592.0 5706.0 5736.0 5784.0 5222.9 5622.2 5714.3 5714.3 5733.6 5600.1 5602.3 5681.1 5688.5 5710.8 6117.9 6134.1 6161.8 6248.8 6258.5 6622.6 6639.8 6707.9 6717.5 6730.3 6575.5 6660.4 6698.7 6732.5 6816.3 6270.9 6275.6 6288.8 6289.8 6301.8 6907.0 6920.9 7011.0 7020.6 7024.4 6545.1 6560.9 6599.0 6668.8 6669.8 6535.3 6575.1 6635.6 6647.4 6678.5 6610.9 6611.6 6616.1 6628.9 6642.5 6672.0 6730.0 6746.9 6762.3 6778.2 5339.4 5438.3 5498.1 5514.9 5520.2 4643.5 4668.8 4680.8 4715.2 4731.6 5802.1 5872.4 5873.0 5875.9 5908.8 6611.7 6711.6 6726.3 6757.7 6857.5 5778.0 5821.0 5821.4 5822.5 5822.5 5984.9 5991.9 6002.8 6006.0 6033.0 6504.2 6577.5 6586.9 6598.4 6604.1 6730.1 6734.5 6735.5 6745.1 6838.6 6372.6 6469.3 6477.4 6491.3 6492.3 6539.9 6620.3 6622.8 6624.4 6631.9 6734.6 6742.5 6823.4 6824.8 6842.8 6570.1 6586.3 6600.4 6602.0 6602.5 6511.9 6534.3 6627.0 6631.7 6635.4 6343.1 6438.4 6442.8 6446.3 6541.5 6514.5 6587.6 6669.4 6689.5 6699.2 6407.5 6425.2 6440.4 6512.3 6526.0 16:41:56 INFO - PID 24522 | 16:41:56 INFO - PID 24522 | [#1] ext.html Cycles:180 Average:39184.73 Median:19512.93 stddev:56654.36 (290.3%) stddev-sans-first:56739.80 16:41:56 INFO - PID 24522 | Values: 753.4 812.8 823.5 828.4 1148.6 31309.0 31851.5 41715.6 42528.6 42662.4 42092.6 42317.2 42469.6 42857.1 43047.6 7227.2 7655.2 7819.3 7821.0 7824.8 7596.2 7740.6 7745.1 7745.2 7753.8 7718.0 7734.2 7814.9 7825.8 7827.1 7745.2 7776.0 7777.8 7779.1 7779.1 7645.7 7696.8 7710.4 7713.3 7742.1 38613.8 38816.0 38820.6 38900.4 38965.4 3507.4 3529.1 3533.5 3546.6 3551.6 31523.7 31534.4 31547.4 31552.5 31598.2 4960.9 4963.4 4981.7 5015.6 5020.9 188027.0 189261.0 190183.0 190435.0 190539.0 48060.3 48231.0 48497.3 48498.3 48734.5 50975.2 50985.5 51051.7 51144.7 51155.0 16154.1 16407.2 16448.0 16453.8 16464.4 10320.6 10443.2 13400.0 13432.5 13637.0 14252.9 14312.6 14342.1 14375.3 14411.3 5709.4 5762.9 5806.1 5830.4 5858.2 1020.4 1020.6 1035.8 1042.8 1044.0 22890.5 23403.3 23753.0 30769.5 31139.2 1105.4 1107.4 1111.0 1122.6 1136.8 12684.8 12779.8 12883.4 12898.6 12901.0 250896.0 253068.0 253083.0 253435.0 253702.0 55214.0 55216.4 55350.2 55402.7 55590.7 1504.9 1508.3 1532.9 1545.4 1550.1 23253.7 23319.2 23497.5 23606.4 23747.6 39349.6 39424.8 39613.4 39623.6 39626.8 207193.0 207220.0 207359.0 207466.0 209374.0 36380.8 36406.0 37924.2 38101.6 38264.2 46191.5 47371.0 47753.8 47974.0 48083.5 35066.0 35128.3 35271.1 35474.3 35700.5 34140.5 34636.8 34719.8 35201.8 35254.1 37484.6 37941.8 37994.6 38053.6 38339.6 33173.7 33713.3 34180.8 34273.1 34301.5 24588.9 24821.4 25110.0 25131.6 25459.4 16:41:56 INFO - PID 24522 | 16:41:56 INFO - PID 24522 | [#2] jquery.html Cycles:180 Average:37306.48 Median:23990.14 stddev:93828.98 (391.1%) stddev-sans-first:94051.62 16:41:56 INFO - PID 24522 | Values: 555.8 562.4 566.2 578.7 585.8 22106.2 22874.3 22922.0 22957.7 22960.9 24905.4 27284.2 27330.7 27367.2 27412.3 6539.7 6701.2 6719.1 6720.5 6721.6 6232.8 6514.0 6516.2 6620.2 6670.2 6441.6 6476.9 6481.2 6495.4 6500.5 6426.8 6440.3 6441.5 6448.0 6451.3 6001.6 6042.4 6042.8 6044.6 6055.4 28148.6 29980.7 30291.5 30854.7 31221.4 1941.2 1977.9 1980.3 1981.5 1983.3 19641.4 19983.7 19987.2 20001.3 20023.4 2409.8 2434.3 2471.8 2479.6 2494.1 131338.0 139636.0 143987.3 144120.3 144235.0 14727.0 15424.8 15428.8 15485.1 15491.8 23977.6 23986.0 23994.3 23997.2 24018.9 9699.4 9837.8 9895.3 9992.3 10064.1 7637.5 9012.3 9061.7 9119.5 9148.0 8135.6 9105.7 9143.6 9151.5 9232.4 2641.9 2686.7 2718.9 2750.1 2893.3 961.5 985.6 986.8 999.6 1001.1 19733.3 20189.3 20677.4 20908.0 20989.4 1037.1 1042.6 1042.8 1050.8 1059.5 11300.8 11353.5 11479.7 11483.3 11597.6 547319.0 554552.0 564971.0 567682.0 574203.0 115664.0 116446.0 117448.0 122646.0 124519.0 1241.4 1263.9 1292.3 1293.4 1295.9 20729.7 21023.3 21145.8 21278.6 21495.5 56589.7 57838.7 59037.4 59110.7 60607.7 67917.3 69095.3 69486.7 69559.0 70209.0 14969.9 15281.2 15317.0 15320.5 15322.2 23640.9 23952.3 24101.6 24390.5 24520.0 19309.9 19543.1 19626.8 19627.5 19744.6 17144.3 17438.6 17545.7 17817.4 18198.5 19118.0 19911.5 19984.5 20011.7 20030.8 14800.9 15045.0 15171.2 15178.5 15232.5 18660.3 19076.8 19120.7 19179.1 19212.5 16:41:56 INFO - PID 24522 | 16:41:56 INFO - PID 24522 | [#3] mootools.html Cycles:180 Average:8987.68 Median:2535.23 stddev:6370.91 (251.3%) stddev-sans-first:6362.98 16:41:56 INFO - PID 24522 | Values: 1355.3 1402.2 1410.5 1416.7 1417.9 13581.3 14647.6 14668.6 14673.9 14682.1 14981.9 15185.2 15245.2 15261.0 15280.5 2696.3 2749.0 2752.0 2753.0 2754.8 2566.3 2599.8 2602.7 2606.2 2630.5 2590.4 2602.1 2618.3 2624.8 2631.1 2516.5 2534.0 2536.4 2543.3 2543.9 2504.6 2505.5 2511.4 2515.6 2522.4 14100.4 14320.8 14372.5 14384.9 14428.6 7445.1 7741.1 7776.7 7792.5 7810.9 4977.3 5062.1 5120.4 5235.7 5245.5 1806.5 1812.7 1820.1 1852.8 1871.4 24217.3 25137.2 25148.1 25221.4 25253.6 6437.7 6442.1 6474.5 6569.0 6660.3 16639.4 16754.2 16784.9 16792.5 16818.4 7473.6 7604.5 7606.0 7610.7 7615.1 6890.3 6903.3 7029.5 7056.3 7069.9 5105.5 5263.6 5282.6 5295.9 5325.5 1548.8 1552.0 1553.9 1557.5 1578.8 882.3 900.9 902.5 905.0 917.0 7330.2 7360.4 7377.3 7418.9 7450.1 690.5 693.2 695.3 702.0 712.8 5070.3 5142.9 5161.8 5258.0 5421.3 19769.2 20752.8 20877.1 20959.6 20977.3 19960.2 20367.0 20534.4 20555.9 20703.8 9822.9 10233.5 11011.8 11088.9 11286.8 8551.6 8639.7 8660.6 8702.2 8769.3 17710.4 17813.9 17925.6 18217.8 18303.7 17971.0 18276.5 18284.9 18344.4 18392.8 10832.9 10940.4 10944.7 10945.7 10953.1 13459.8 13599.5 13720.7 13733.3 13753.6 10817.9 10838.1 10921.7 10981.6 11298.9 10590.6 10693.3 10759.8 10785.7 10792.7 9332.4 9502.9 9545.3 9548.3 9570.6 6879.0 6956.8 7051.4 7066.6 7073.8 7013.7 7166.5 7221.7 7278.4 7280.2 16:41:56 INFO - PID 24522 | 16:41:56 INFO - PID 24522 | [#4] prototype.html Cycles:180 Average:5515.19 Median:6103.21 stddev:1538.13 (25.2%) stddev-sans-first:1495.68 16:41:56 INFO - PID 24522 | Values: 500.6 504.8 521.9 526.1 532.0 6277.9 6335.3 6362.7 6372.4 6460.4 6106.6 6166.5 6175.8 6188.2 6219.3 4943.7 5034.1 5046.1 5067.5 5081.0 4848.2 4985.2 5063.9 5066.7 5078.7 4926.6 4964.6 4970.8 4998.1 5025.0 4902.6 4974.8 5001.4 5011.1 5048.6 4469.1 4496.6 4510.4 4513.1 4527.1 6041.3 6053.6 6065.0 6077.1 6099.8 5737.6 5763.3 5816.9 5816.9 5818.4 6368.5 6513.0 6522.4 6524.9 6555.2 4887.2 4888.7 4913.9 4942.3 4970.7 6910.8 6930.6 7076.8 7091.2 7099.4 5006.3 5015.2 5032.0 5060.0 5063.5 5125.0 5133.3 5143.3 5152.4 5171.2 5763.9 5789.9 5797.9 5799.0 5807.4 6547.0 6568.7 6618.6 6681.0 6701.2 1682.2 1708.6 1714.5 1725.3 1794.9 1232.9 1247.0 1248.8 1266.9 1269.3 5695.4 5704.7 5712.5 5721.9 5728.4 6597.3 6646.3 6657.7 6689.8 6705.7 5661.7 5666.5 5667.0 5667.9 5680.9 3485.6 3489.4 3534.8 3591.4 3592.0 6010.3 6403.9 6431.4 6443.7 6496.8 6680.4 6767.3 6787.5 6793.7 6852.6 6408.2 6446.2 6446.7 6450.7 6507.8 6683.2 6688.4 6695.4 6706.1 6707.6 6624.2 6657.4 6659.4 6681.6 6709.4 6487.7 6503.6 6506.6 6525.3 6531.8 5067.9 5086.2 5088.3 5099.6 5112.8 6642.0 6677.3 6678.8 6710.5 6726.2 6483.2 6509.4 6523.3 6528.8 6558.5 6454.4 6465.3 6465.3 6486.2 6495.5 6401.3 6442.9 6474.4 6485.3 6495.3 6493.2 6568.8 6570.6 6572.4 6589.7 6155.8 6175.4 6330.5 6350.1 6419.2 16:41:56 INFO - PID 24522 | 16:41:56 INFO - PID 24522 | [#5] yui.html Cycles:180 Average:23712.50 Median:19899.80 stddev:32369.13 (162.7%) stddev-sans-first:32414.73 16:41:56 INFO - PID 24522 | Values: 929.0 929.1 937.0 939.5 941.2 19127.8 19745.5 19829.1 19970.5 21590.6 20667.4 22365.4 22369.2 22395.7 22441.6 1036.8 1079.0 1081.2 1081.9 1082.3 1077.2 1079.6 1082.5 1083.4 1085.3 1138.5 1140.4 1140.7 1140.9 1142.5 1124.9 1127.8 1127.9 1128.3 1128.7 825.6 826.6 826.7 827.4 828.5 20018.2 20136.8 20351.1 20875.6 20895.9 21699.9 22170.1 22266.2 22339.1 22406.6 16722.2 16906.4 16956.7 17123.3 17140.9 3659.1 3667.7 3677.8 3687.1 3688.0 128696.0 129595.0 129790.0 130212.0 131539.3 17006.0 17139.1 17340.7 17380.0 17540.5 30748.2 30761.4 31793.2 31924.0 32125.4 7589.3 8516.1 8615.5 8670.5 9290.0 4201.4 4327.5 4333.6 4337.8 4338.0 5079.5 5157.2 5163.6 5165.5 5181.2 1013.9 1034.7 1035.5 1044.5 1045.8 690.2 699.8 708.1 710.7 711.8 11448.5 12200.2 12215.6 13002.5 13204.0 678.4 681.2 683.9 691.3 699.1 5728.7 5860.5 5862.9 5882.1 5976.0 110496.4 112879.4 113349.0 114521.0 116352.4 98357.5 99441.5 99448.0 100037.0 104276.5 85079.1 85822.0 85996.6 86498.0 89523.6 10640.6 10744.8 10790.5 10852.3 11020.7 40277.8 40774.2 40816.8 41054.8 41274.6 52688.0 52769.5 53026.5 54001.7 54045.7 15461.2 15531.1 15726.0 15767.1 15808.4 17337.0 20044.5 21103.0 21240.8 21359.1 17409.2 17664.2 17675.5 17696.9 17783.0 18867.2 18956.4 19052.8 19081.4 19125.8 18147.4 18163.7 18475.2 18582.3 18718.9 13835.1 13854.4 13895.5 13950.7 13956.7 14395.0 14427.0 14460.4 14478.2 14481.7 16:41:56 INFO - PID 24522 | -------- Summary: end -------- 16:41:56 INFO - PID 24522 | 16:41:57 INFO - TEST-INFO | 24522: exit 0 16:41:57 INFO - TEST-OK | dromaeo_css | took 1111709ms 16:41:57 INFO - TEST-START | kraken 16:41:57 INFO - Initialising browser for kraken test... 16:41:57 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:48901/getInfo.html -profile /tmp/tmpo3qU5Z/profile 16:41:57 INFO - TEST-INFO | started process 24893 (/builds/slave/test/build/application/firefox/firefox http://localhost:48901/getInfo.html) 16:42:03 INFO - TEST-INFO | 24893: exit 0 16:42:03 INFO - Browser initialized. 16:42:03 INFO - Running cycle 1/1 for kraken test... 16:42:03 INFO - TEST-INFO | started process 25104 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpo3qU5Z/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 16:42:04 INFO - PID 25104 | 16:42:04 INFO - PID 25104 | (/builds/slave/test/build/application/firefox/firefox:25152): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 16:42:04 INFO - PID 25104 | 16:42:14 INFO - PID 25104 | RSS: Main: 164769792 16:42:14 INFO - PID 25104 | 16:42:17 INFO - PID 25104 | Cycle 1(1): loaded http://localhost:48901/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:48901/tests/kraken/driver.html?testName=audio-beat-detection) 16:42:18 INFO - PID 25104 | RSS: Main: 171421696 16:42:18 INFO - PID 25104 | 16:42:20 INFO - PID 25104 | Cycle 1(1): loaded http://localhost:48901/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:48901/tests/kraken/driver.html?testName=audio-dft) 16:42:21 INFO - PID 25104 | RSS: Main: 174989312 16:42:21 INFO - PID 25104 | 16:42:24 INFO - PID 25104 | Cycle 1(1): loaded http://localhost:48901/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:48901/tests/kraken/driver.html?testName=audio-fft) 16:42:25 INFO - PID 25104 | RSS: Main: 168296448 16:42:25 INFO - PID 25104 | 16:42:27 INFO - PID 25104 | Cycle 1(1): loaded http://localhost:48901/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:48901/tests/kraken/driver.html?testName=audio-oscillator) 16:42:27 INFO - PID 25104 | RSS: Main: 169984000 16:42:27 INFO - PID 25104 | 16:42:30 INFO - PID 25104 | Cycle 1(1): loaded http://localhost:48901/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:48901/tests/kraken/driver.html?testName=imaging-gaussian-blur) 16:42:30 INFO - PID 25104 | RSS: Main: 169697280 16:42:30 INFO - PID 25104 | 16:42:33 INFO - PID 25104 | Cycle 1(1): loaded http://localhost:48901/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:48901/tests/kraken/driver.html?testName=imaging-darkroom) 16:42:34 INFO - PID 25104 | RSS: Main: 170659840 16:42:34 INFO - PID 25104 | 16:42:37 INFO - PID 25104 | Cycle 1(1): loaded http://localhost:48901/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:48901/tests/kraken/driver.html?testName=imaging-desaturate) 16:42:38 INFO - PID 25104 | RSS: Main: 171319296 16:42:38 INFO - PID 25104 | 16:42:41 INFO - PID 25104 | Cycle 1(1): loaded http://localhost:48901/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:48901/tests/kraken/driver.html?testName=json-parse-financial) 16:42:42 INFO - PID 25104 | RSS: Main: 171110400 16:42:42 INFO - PID 25104 | 16:42:43 INFO - PID 25104 | Cycle 1(1): loaded http://localhost:48901/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:48901/tests/kraken/driver.html?testName=json-stringify-tinderbox) 16:42:44 INFO - PID 25104 | RSS: Main: 170954752 16:42:44 INFO - PID 25104 | 16:42:46 INFO - PID 25104 | Cycle 1(1): loaded http://localhost:48901/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:48901/tests/kraken/driver.html?testName=stanford-crypto-aes) 16:42:46 INFO - PID 25104 | RSS: Main: 170946560 16:42:46 INFO - PID 25104 | 16:42:48 INFO - PID 25104 | Cycle 1(1): loaded http://localhost:48901/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:48901/tests/kraken/driver.html?testName=stanford-crypto-ccm) 16:42:49 INFO - PID 25104 | RSS: Main: 170795008 16:42:49 INFO - PID 25104 | 16:42:51 INFO - PID 25104 | Cycle 1(1): loaded http://localhost:48901/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:48901/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 16:42:52 INFO - PID 25104 | RSS: Main: 170881024 16:42:52 INFO - PID 25104 | 16:42:55 INFO - PID 25104 | Cycle 1(1): loaded http://localhost:48901/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:48901/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 16:42:56 INFO - PID 25104 | RSS: Main: 171094016 16:42:56 INFO - PID 25104 | 16:42:58 INFO - PID 25104 | Cycle 1(1): loaded http://localhost:48901/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:48901/tests/kraken/driver.html?testName=ai-astar) 16:42:58 INFO - PID 25104 | RSS: Main: 172552192 16:42:58 INFO - PID 25104 | 16:42:58 INFO - PID 25104 | __start_tp_report 16:42:58 INFO - PID 25104 | _x_x_mozilla_page_load 16:42:58 INFO - PID 25104 | _x_x_mozilla_page_load_details 16:42:58 INFO - PID 25104 | |i|pagename|runs| 16:42:58 INFO - PID 25104 | |0;ai-astar;98;110;101;109;109;120;111;100;108;107 16:42:58 INFO - PID 25104 | |1;audio-beat-detection;149;115;150;171;117;143;150;119;171;119 16:42:58 INFO - PID 25104 | |2;audio-dft;163;163;163;163;162;166;164;168;172;165 16:42:58 INFO - PID 25104 | |3;audio-fft;76;77;79;133;75;75;74;86;95;75 16:42:58 INFO - PID 25104 | |4;audio-oscillator;79;78;126;79;79;78;124;83;80;138 16:42:58 INFO - PID 25104 | |5;imaging-gaussian-blur;114;114;114;117;115;114;113;118;113;114 16:42:58 INFO - PID 25104 | |6;imaging-darkroom;150;151;151;151;150;149;150;150;153;150 16:42:58 INFO - PID 25104 | |7;imaging-desaturate;95;94;94;93;95;95;94;94;94;94 16:42:58 INFO - PID 25104 | |8;json-parse-financial;54;53;52;53;53;53;54;52;52;54 16:42:58 INFO - PID 25104 | |9;json-stringify-tinderbox;54;54;55;55;55;55;54;55;55;54 16:42:58 INFO - PID 25104 | |10;stanford-crypto-aes;76;76;76;76;76;77;75;77;74;76 16:42:58 INFO - PID 25104 | |11;stanford-crypto-ccm;123;122;121;129;121;122;127;119;125;156 16:42:58 INFO - PID 25104 | |12;stanford-crypto-pbkdf2;173;194;178;173;171;171;174;179;180;174 16:42:58 INFO - PID 25104 | |13;stanford-crypto-sha256-iterative;73;67;74;72;66;66;68;69;67;68 16:42:58 INFO - PID 25104 | __end_tp_report 16:42:58 INFO - PID 25104 | __start_cc_report 16:42:58 INFO - PID 25104 | _x_x_mozilla_cycle_collect,969 16:42:58 INFO - PID 25104 | __end_cc_report 16:42:58 INFO - PID 25104 | __startTimestamp1502926978386__endTimestamp 16:42:58 INFO - PID 25104 | 16:42:58 INFO - PID 25104 | ------- Summary: start ------- 16:42:58 INFO - PID 25104 | Number of tests: 14 16:42:58 INFO - PID 25104 | 16:42:58 INFO - PID 25104 | [#0] ai-astar Cycles:10 Average:107.30 Median:109.50 stddev:6.40 (5.8%) stddev-sans-first:5.83 16:42:58 INFO - PID 25104 | Values: 98.0 110.0 101.0 109.0 109.0 120.0 111.0 100.0 108.0 107.0 16:42:58 INFO - PID 25104 | 16:42:58 INFO - PID 25104 | [#1] audio-beat-detection Cycles:10 Average:140.40 Median:149.50 stddev:21.72 (14.5%) stddev-sans-first:22.82 16:42:58 INFO - PID 25104 | Values: 149.0 115.0 150.0 171.0 117.0 143.0 150.0 119.0 171.0 119.0 16:42:58 INFO - PID 25104 | 16:42:58 INFO - PID 25104 | [#2] audio-dft Cycles:10 Average:164.90 Median:164.50 stddev:3.07 (1.9%) stddev-sans-first:3.18 16:42:58 INFO - PID 25104 | Values: 163.0 163.0 163.0 163.0 162.0 166.0 164.0 168.0 172.0 165.0 16:42:58 INFO - PID 25104 | 16:42:58 INFO - PID 25104 | [#3] audio-fft Cycles:10 Average:84.50 Median:76.50 stddev:18.27 (23.9%) stddev-sans-first:19.12 16:42:58 INFO - PID 25104 | Values: 76.0 77.0 79.0 133.0 75.0 75.0 74.0 86.0 95.0 75.0 16:42:58 INFO - PID 25104 | 16:42:58 INFO - PID 25104 | [#4] audio-oscillator Cycles:10 Average:94.40 Median:79.00 stddev:24.41 (30.9%) stddev-sans-first:25.25 16:42:58 INFO - PID 25104 | Values: 79.0 78.0 126.0 79.0 79.0 78.0 124.0 83.0 80.0 138.0 16:42:58 INFO - PID 25104 | 16:42:58 INFO - PID 25104 | [#5] imaging-gaussian-blur Cycles:10 Average:114.60 Median:114.00 stddev:1.65 (1.4%) stddev-sans-first:1.73 16:42:58 INFO - PID 25104 | Values: 114.0 114.0 114.0 117.0 115.0 114.0 113.0 118.0 113.0 114.0 16:42:58 INFO - PID 25104 | 16:42:58 INFO - PID 25104 | [#6] imaging-darkroom Cycles:10 Average:150.50 Median:150.50 stddev:1.08 (0.7%) stddev-sans-first:1.13 16:42:58 INFO - PID 25104 | Values: 150.0 151.0 151.0 151.0 150.0 149.0 150.0 150.0 153.0 150.0 16:42:58 INFO - PID 25104 | 16:42:58 INFO - PID 25104 | [#7] imaging-desaturate Cycles:10 Average:94.20 Median:94.00 stddev:0.63 (0.7%) stddev-sans-first:0.60 16:42:58 INFO - PID 25104 | Values: 95.0 94.0 94.0 93.0 95.0 95.0 94.0 94.0 94.0 94.0 16:42:58 INFO - PID 25104 | 16:42:58 INFO - PID 25104 | [#8] json-parse-financial Cycles:10 Average:53.00 Median:53.00 stddev:0.82 (1.5%) stddev-sans-first:0.78 16:42:58 INFO - PID 25104 | Values: 54.0 53.0 52.0 53.0 53.0 53.0 54.0 52.0 52.0 54.0 16:42:58 INFO - PID 25104 | 16:42:58 INFO - PID 25104 | [#9] json-stringify-tinderbox Cycles:10 Average:54.60 Median:55.00 stddev:0.52 (0.9%) stddev-sans-first:0.50 16:42:58 INFO - PID 25104 | Values: 54.0 54.0 55.0 55.0 55.0 55.0 54.0 55.0 55.0 54.0 16:42:58 INFO - PID 25104 | 16:42:58 INFO - PID 25104 | [#10] stanford-crypto-aes Cycles:10 Average:75.90 Median:76.00 stddev:0.88 (1.2%) stddev-sans-first:0.93 16:42:58 INFO - PID 25104 | Values: 76.0 76.0 76.0 76.0 76.0 77.0 75.0 77.0 74.0 76.0 16:42:58 INFO - PID 25104 | 16:42:58 INFO - PID 25104 | [#11] stanford-crypto-ccm Cycles:10 Average:126.50 Median:124.00 stddev:10.79 (8.7%) stddev-sans-first:11.37 16:42:58 INFO - PID 25104 | Values: 123.0 122.0 121.0 129.0 121.0 122.0 127.0 119.0 125.0 156.0 16:42:58 INFO - PID 25104 | 16:42:58 INFO - PID 25104 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:176.70 Median:176.00 stddev:6.86 (3.9%) stddev-sans-first:7.15 16:42:58 INFO - PID 25104 | Values: 173.0 194.0 178.0 173.0 171.0 171.0 174.0 179.0 180.0 174.0 16:42:58 INFO - PID 25104 | 16:42:58 INFO - PID 25104 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.00 Median:68.50 stddev:2.94 (4.3%) stddev-sans-first:2.74 16:42:58 INFO - PID 25104 | Values: 73.0 67.0 74.0 72.0 66.0 66.0 68.0 69.0 67.0 68.0 16:42:58 INFO - PID 25104 | -------- Summary: end -------- 16:42:58 INFO - PID 25104 | 16:42:58 INFO - PID 25104 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 16:42:59 INFO - TEST-INFO | 25104: exit 0 16:42:59 INFO - TEST-OK | kraken | took 61376ms 16:42:59 INFO - SUITE-END | took 1173s 16:42:59 INFO - Completed test suite (00:19:33) 16:42:59 INFO - javascript benchmark 16:42:59 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8573.350002343079, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3169.065125787893, 3176.3170918252586, 3181.7295529879966, 3192.9042128736132, 3221.693939075787, 6186.195794546703, 6244.313125556191, 6280.96364099923, 6291.937080629198, 6308.337624549425, 6019.5485338599565, 6085.665288409135, 6205.22434695663, 6233.033879748635, 6275.309715931244, 5647.632903861236, 5653.378128405872, 5664.631798933076, 5674.2623458950275, 5724.7996320128805, 5731.627444216134, 5732.79935202268, 5750.281214848144, 5766.365699773021, 5833.941660583403, 828.83934433589, 5591.9720401398135, 5706.001449746299, 5736.024875771108, 5784.0, 5222.8694282642855, 5622.212890195376, 5714.285714285715, 5714.285714285715, 5733.569982251348, 5600.087083877625, 5602.327720673505, 5681.147827825818, 5688.516476099537, 5710.8001219957105, 6117.908231376488, 6134.141220229171, 6161.815145545641, 6248.812535623939, 6258.499320054385, 6622.602062859128, 6639.834004149935, 6707.899381509281, 6717.462602991798, 6730.259671436138, 6575.506836987197, 6660.433863121641, 6698.698558564876, 6732.528722989393, 6816.250212476623, 6270.87458250837, 6275.623462592304, 6288.779892703779, 6289.811305660837, 6301.779437719658, 6907.033015377851, 6920.930790692129, 7011.0, 7020.5787652741, 7024.367806897404, 6545.149130613085, 6560.901586476207, 6599.0, 6668.799936001928, 6669.799906002828, 6535.281119076898, 6575.112359831457, 6635.568688035262, 6647.401733843977, 6678.53250272486, 6610.900836487456, 6611.570247933869, 6616.1399018128295, 6628.8674226515195, 6642.501812364092, 6672.0, 6730.0, 6746.932530674729, 6762.256151823295, 6778.2205046420295, 5339.41266460689, 5438.265834112423, 5498.147787093007, 5514.862128446821, 5520.199571062173, 4643.4660014098135, 4668.8132474701315, 4680.789364478606, 4715.24556071027, 4731.597814185764, 5802.129680547867, 5872.412758724094, 5873.030949893306, 5875.882482350329, 5908.822735317947, 6611.702473388709, 6711.597304161766, 6726.260111387744, 6757.662116894136, 6857.519973601899, 5778.0, 5821.0, 5821.446962538552, 5822.534197264209, 5822.534197264209, 5984.910226346608, 5991.850203744854, 6002.789902353396, 6006.0, 6033.0, 6504.1869766279215, 6577.506686998398, 6586.934130658632, 6598.43913267368, 6604.075429439882, 6730.0914376560495, 6734.528582999339, 6735.49483788708, 6745.055692203194, 6838.589684618939, 6372.6495042773095, 6469.28837827848, 6477.417032466912, 6491.285958544462, 6492.31830657793, 6539.869202616016, 6620.337966203341, 6622.8344291393105, 6624.403803657501, 6631.933680663132, 6734.595924244561, 6742.528023038536, 6823.351781580742, 6824.829379265558, 6842.7605033823575, 6570.11303474044, 6586.2755096940255, 6600.372964568358, 6601.966990165019, 6602.471802255712, 6511.902321465087, 6534.281229064894, 6626.966865165643, 6631.734730610914, 6635.369639884397, 6343.080253363144, 6438.356164383524, 6442.838929026624, 6446.258680251831, 6541.476681865344, 6514.51141164424, 6587.571807832475, 6669.399754022162, 6689.49828762835, 6699.162604674416, 6407.519436042222, 6425.228972523327, 6440.420362167428, 6512.283648798723, 6525.967370163119], "value": 6089.503843300696, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [753.3746989998302, 812.8171161488664, 823.5429336718121, 828.4490813608954, 1148.6496618531344, 31309.0, 31851.52222716661, 41715.582844171586, 42528.57471425285, 42662.36006459906, 42092.57907420925, 42317.15365692692, 42469.57530424695, 42857.14285714284, 43047.569524304745, 7227.241139680336, 7655.157932627407, 7819.296263336299, 7820.960895195516, 7824.843503129934, 7596.202398748134, 7740.612969351538, 7745.070591529025, 7745.1867553906595, 7753.767386978399, 7718.035245594301, 7734.226577342249, 7814.882776758353, 7825.765227043169, 7827.1390147083775, 7745.225477452266, 7775.98912141418, 7777.844443111135, 7779.066512018538, 7779.144294127642, 7645.732399366051, 7696.769096927102, 7710.383169346439, 7713.305802477747, 7742.109657389416, 38613.806930965446, 38816.0, 38820.61179388198, 38900.416493752615, 38965.415518767244, 3507.438809790421, 3529.100079479742, 3533.452314891196, 3546.6098729139776, 3551.5738111426795, 31523.684763152534, 31534.36931261362, 31547.36905261882, 31552.52671209911, 31598.210044748834, 4960.90078198434, 4963.4292056413615, 4981.72600506972, 5015.6238282128625, 5020.924686129711, 188027.0, 189261.0, 190183.0, 190435.0, 190539.0, 48060.27909581359, 48231.0, 48497.272540911916, 48498.272525912136, 48734.51265487371, 50975.235371469455, 50985.49014509882, 51051.74474127606, 51144.744276279125, 51154.97690046253, 16154.1115238663, 16407.1796410179, 16448.0, 16453.83546164523, 16464.4237451691, 10320.638777642747, 10443.164546836235, 13400.0, 13432.462701492026, 13637.0, 14252.857471425361, 14312.570622881121, 14342.139471631526, 14375.28123593816, 14411.279436028157, 5709.430756159744, 5762.9135562966585, 5806.071028635482, 5830.446107619854, 5858.179854820329, 1020.3826684855555, 1020.6121673763922, 1035.8290882004385, 1042.7966546523508, 1043.9582416703247, 22890.542189156124, 23403.297901062997, 23753.0, 30769.538456923165, 31139.221519462193, 1105.4251789069638, 1107.379867274329, 1110.9944450277696, 1122.5846436818429, 1136.8465257190173, 12684.80972785409, 12779.808302875465, 12883.420246088948, 12898.613041608767, 12901.0, 250896.0, 253068.0, 253083.0, 253435.0, 253702.0, 55214.0, 55216.44783552193, 55350.16974745382, 55402.72298638481, 55590.72204638951, 1504.9097054176566, 1508.3363320139104, 1532.8999270998581, 1545.4050190676671, 1550.07770376628, 23253.651195231745, 23319.183828565918, 23497.530049399258, 23606.409839754142, 23747.64378534358, 39349.60650393459, 39424.802875985435, 39613.40579891246, 39623.60376396315, 39626.801865990485, 207193.0, 207220.0, 207359.0, 207466.0, 209374.0, 36380.81809590935, 36406.0, 37924.24151517009, 38101.61898380981, 38264.2347153061, 46191.53808462007, 47371.0, 47753.761231193625, 47974.0, 48083.519164807905, 35066.0, 35128.29743405066, 35271.11822204466, 35474.290514190085, 35700.46449303211, 34140.487892681136, 34636.82681586677, 34719.82640086783, 35201.82399087988, 35254.11864703403, 37484.625153749206, 37941.81029094837, 37994.62005379911, 38053.61946380501, 38339.6166038336, 33173.66826331706, 33713.3257334847, 34180.82909585436, 34273.14317142092, 34301.48547771835, 24588.87705561461, 24821.379465513506, 25110.0, 25131.623025654266, 25459.36351591225], "value": 17639.73694097279, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [555.837790993037, 562.3898070593406, 566.2101368590813, 578.6961845031359, 585.7715490958526, 22106.22628208011, 22874.31377058687, 22922.0, 22957.655635165487, 22960.88519557402, 24905.37736556587, 27284.181474555746, 27330.726692733067, 27367.178984630493, 27412.314692132706, 6539.673016349176, 6701.229358623772, 6719.0593316935665, 6720.5295629305965, 6721.563098398588, 6232.750689972396, 6513.967430162867, 6516.152900123001, 6620.238672552646, 6670.199576050881, 6441.645709485976, 6476.902846457307, 6481.189851268591, 6495.382938620824, 6500.512461565378, 6426.839329016789, 6440.291567927524, 6441.516886233504, 6448.0, 6451.322611125858, 6001.579889407743, 6042.425969532887, 6042.788502402439, 6044.637321760709, 6055.364186760371, 28148.577771333446, 29980.70019299801, 30291.545626815616, 30854.69145308563, 31221.37557248842, 1941.2332128809041, 1977.9208831646717, 1980.2771988224338, 1981.5442448236843, 1983.2860170338668, 19641.41075767729, 19983.700244496344, 19987.20051197965, 20001.299954501523, 20023.399298021082, 2409.7831195192516, 2434.257551446808, 2471.8269721119527, 2479.6280557916275, 2494.052260141153, 131338.0, 139636.0, 143987.28006360005, 144120.2793986034, 144235.0, 14727.0, 15424.768628470581, 15428.845711542965, 15485.148316842457, 15491.767623485657, 23977.640335394983, 23986.0, 23994.28017159488, 23997.16009939644, 24018.919148638353, 9699.418034917928, 9837.803243935225, 9895.307328486937, 9992.25058120644, 10064.144547713526, 7637.5035622684345, 9012.324075694349, 9061.68284110053, 9119.498427586546, 9147.95426022879, 8135.633896474673, 9105.681301154427, 9143.63425462974, 9151.496667683341, 9232.446053236827, 2641.867906604662, 2686.693779784909, 2718.9320266993086, 2750.149790293605, 2893.348996475776, 961.4808003677936, 985.6451677396132, 986.7631768375538, 999.6051559633904, 1001.0740065439439, 19733.309334173235, 20189.32487449133, 20677.379678609665, 20908.0, 20989.37031889046, 1037.071820720451, 1042.5673345561506, 1042.8227201375785, 1050.837120246363, 1059.5073290919606, 11300.773984520263, 11353.489092990836, 11479.655610331703, 11483.311001339946, 11597.594084207012, 547319.0, 554552.0, 564971.0, 567682.0, 574203.0, 115664.0, 116446.0, 117448.0, 122646.0, 124519.0, 1241.4103300931986, 1263.943122559487, 1292.3150730113243, 1293.3856418201278, 1295.9092863499463, 20729.68905466389, 21023.264185753425, 21145.788542115, 21278.574428511653, 21495.46261343479, 56589.71705141448, 57838.7108064457, 59037.409625903194, 59110.704446477495, 60607.696961514914, 67917.3208267911, 69095.3090469089, 69486.65256673684, 69559.0, 70209.0, 14969.850301496846, 15281.235938203268, 15317.0, 15320.540383788504, 15322.233888305318, 23640.88179559091, 23952.28143155708, 24101.638475423235, 24390.51218975646, 24520.0, 19309.903450482656, 19543.120559575138, 19626.803731962496, 19627.509312267306, 19744.605107897474, 17144.314227431263, 17438.564035899202, 17545.736813947547, 17817.376391826223, 18198.5450363742, 19118.0, 19911.502212444226, 19984.50038749043, 20011.699824502353, 20030.79815211092, 14800.851991479947, 15045.0, 15171.165585892883, 15178.544643660707, 15232.466863659718, 18660.2535898568, 19076.809231907504, 19120.713189301892, 19179.136938838066, 19212.519687007938], "value": 12270.825462059624, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1355.2546099645192, 1402.193738600305, 1410.478123094455, 1416.7237388709207, 1417.893657975652, 13581.253031083286, 14647.633809154777, 14668.559943201695, 14673.92663036686, 14682.119072855636, 14981.850181498181, 15185.240737963086, 15245.237738113077, 15261.0, 15280.541583752478, 2696.298962269804, 2748.9725102749017, 2751.9587206191923, 2752.981396883146, 2754.848483333416, 2566.2814411964678, 2599.8440093594445, 2602.687677478705, 2606.153000274918, 2630.539655560279, 2590.4042070323835, 2602.08926875593, 2618.253797667665, 2624.8293860899075, 2631.1317265302405, 2516.48412075525, 2534.0244006057615, 2536.441982763789, 2543.3133054075297, 2543.8600876951855, 2504.5742223821994, 2505.498900219963, 2511.3972646564694, 2515.622656601506, 2522.3567990162574, 14100.365483553265, 14320.785188222186, 14372.49696260626, 14384.928075359556, 14428.639284017878, 7445.106587209515, 7741.148473667892, 7776.688932442752, 7792.493487923323, 7810.882836757453, 4977.278294647292, 5062.0888240116765, 5120.385553733576, 5235.712035838027, 5245.527902488794, 1806.5393324702247, 1812.682780513418, 1820.1354356680604, 1852.8147185281364, 1871.3824437935448, 24217.273481795575, 25137.24588262355, 25148.11981580636, 25221.36946576332, 25253.62119568208, 6437.678116094176, 6442.130312407765, 6474.482041436674, 6568.967155164193, 6660.333966603398, 16639.41762038323, 16754.246058927132, 16784.916075419544, 16792.496225113267, 16818.411355602497, 7473.626318684044, 7604.505707129129, 7605.961970190225, 7610.695572177162, 7615.124260709978, 6890.345417185359, 6903.309669033057, 7029.5430796998035, 7056.294370562902, 7069.8939515907305, 5105.463926287761, 5263.605229607795, 5282.6302158849285, 5295.867603309948, 5325.547328477122, 1548.8451154884422, 1552.037736603313, 1553.9456119035779, 1557.5093845438878, 1578.7552929295978, 882.3470631732472, 900.9278958039912, 902.4585248850638, 904.9547522623842, 917.000469488261, 7330.193678695339, 7360.374368178657, 7377.3360397564475, 7418.925810741932, 7450.143233528105, 690.5166383531548, 693.2478261086677, 695.2838576266454, 702.0382076555152, 712.807541963667, 5070.3155074064525, 5142.922856157161, 5161.81933632321, 5258.0, 5421.295231619864, 19769.209231630863, 20752.792472075085, 20877.060532276086, 20959.580808383747, 20977.265795697076, 19960.20159193645, 20367.0, 20534.383968480968, 20555.8972205138, 20703.792962070187, 9822.901770982198, 10233.539490722935, 11011.779764404828, 11088.889111108785, 11286.830697539543, 8551.57242137903, 8639.740807775777, 8660.566971651266, 8702.173293537104, 8769.298456123623, 17710.380136695152, 17813.910930445265, 17925.551861203054, 18217.817821821613, 18303.72544411808, 17971.0, 18276.45170644883, 18284.908575457037, 18344.357947471774, 18392.816071839112, 10832.891671083189, 10940.39827809478, 10944.726381840517, 10945.726356841144, 10953.123750099814, 13459.798103028266, 13599.456021759019, 13720.65698357549, 13733.313334333043, 13753.587392378246, 10817.945910270399, 10838.13294936419, 10921.726956825825, 10981.61564345244, 11298.887011129784, 10590.629327973484, 10693.3049351795, 10759.784804304027, 10785.730356741144, 10792.676219713421, 9332.39339442934, 9502.904970950201, 9545.331826772059, 9548.331616786758, 9570.56932438028, 6879.0025446309, 6956.826079347854, 7051.365377115879, 7066.576005439484, 7073.787786366417, 7013.684384202825, 7166.53417527859, 7221.747238846615, 7278.381337586365, 7280.235575264521], "value": 6419.843446527586, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [500.5670095367506, 504.7734006364535, 521.8538809133443, 526.0951163997922, 532.0, 6277.901367260728, 6335.334789847069, 6362.741226864466, 6372.362763723625, 6460.41856232939, 6106.5725399221965, 6166.506679465643, 6175.845603859906, 6188.164597779299, 6219.284782250043, 4943.703377797326, 5034.09386310464, 5046.116929537335, 5067.467915868836, 5081.009203205376, 4848.248521479177, 4985.227289770091, 5063.949360506403, 5066.695998240118, 5078.669886457387, 4926.5566099051075, 4964.578010869081, 4970.782158371186, 4998.10034193845, 5025.0, 4902.607791376681, 4974.830914735035, 5001.44984051754, 5011.1163848017895, 5048.6465947383695, 4469.128519938613, 4496.55034496551, 4510.391097201868, 4513.1425029244665, 4527.117212143633, 6041.275046994345, 6053.606515576474, 6065.0, 6077.118817771398, 6099.84750381244, 5737.598368114233, 5763.337216220147, 5816.934988079213, 5816.941830581683, 5818.359980402152, 6368.5481089780305, 6512.967435162841, 6522.380373864476, 6524.902126468107, 6555.213374395055, 4887.242477416006, 4888.73111978841, 4913.926291105637, 4942.283368911488, 4970.676906001098, 6910.758123465705, 6930.643581182422, 7076.752313668997, 7091.21343093415, 7099.36105750485, 5006.299118123466, 5015.24771284303, 5031.974840125776, 5059.974700126476, 5063.493650634907, 5124.974375128175, 5133.307003554547, 5143.305653736697, 5152.407473140637, 5171.198464238049, 5763.94236057634, 5789.913151302734, 5797.884042319214, 5799.0, 5807.373935298123, 6546.967265163644, 6568.704408301638, 6618.63597502142, 6680.96659516709, 6701.195856497154, 1682.2261759590726, 1708.6070203853183, 1714.5340733672779, 1725.3271224222563, 1794.8653850960968, 1232.896557580978, 1246.956356527517, 1248.7877060899668, 1266.9429875655617, 1269.3335998600808, 5695.373508914016, 5704.657720536781, 5712.485876271073, 5721.942780572141, 5728.398518155534, 6597.340265973365, 6646.335366463411, 6657.703092433103, 6689.799306020827, 6705.731770729214, 5661.716914154358, 5666.461686139893, 5666.97166514173, 5667.914981275284, 5680.857978550569, 3485.5643044619424, 3489.4068008438626, 3534.770239934396, 3591.425371940477, 3592.0, 6010.308814486302, 6403.886717383252, 6431.356864313625, 6443.742250309935, 6496.7726129585235, 6680.3987641112535, 6767.323267673193, 6787.457003439713, 6793.728250870009, 6852.623105729133, 6408.166938297992, 6446.226452825504, 6446.7421303148285, 6450.6774661266745, 6507.772227972093, 6683.231428385603, 6688.3646053624825, 6695.4308883745425, 6706.128203333536, 6707.5975441473665, 6624.15161480568, 6657.367550082734, 6659.367360100783, 6681.599104053772, 6709.396154346132, 6487.675616219264, 6503.642299673564, 6506.642134682448, 6525.2822189558165, 6531.771388001397, 5067.949320506896, 5086.18621020635, 5088.2876397305145, 5099.643024988215, 5112.821051263188, 6642.047981451029, 6677.29888361715, 6678.766243181465, 6710.4631629470505, 6726.159230096238, 6483.157189565326, 6509.446697030806, 6523.282438931618, 6528.771492997722, 6558.475321974326, 6454.419102280817, 6465.288818229897, 6465.321141280097, 6486.189226346707, 6495.512836537184, 6401.327860574759, 6442.935570644234, 6474.384933431316, 6485.319041500575, 6495.253045899593, 6493.22081350241, 6568.80293591193, 6570.5729127608465, 6572.4084832365315, 6589.670516474253, 6155.815325540241, 6175.44421002094, 6330.49356051524, 6350.079238510482, 6419.2296924369375], "value": 5063.46694970224, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [928.9581968811402, 929.0848514213499, 937.0488953711979, 939.4504215034204, 941.2422999485414, 19127.808721912777, 19745.506362340948, 19829.10769015394, 19970.50073748155, 21590.568188636258, 20667.379978600668, 22365.44086397841, 22369.217077402292, 22395.664065039036, 22441.55116897661, 1036.7719101797593, 1078.9730256743567, 1081.1729027294127, 1081.8593582834221, 1082.3343643659132, 1077.2243984331308, 1079.6275285026693, 1082.5345101606306, 1083.4149559238, 1085.2837127495816, 1138.4535422996967, 1140.3556990300494, 1140.6863112644048, 1140.8916152965455, 1142.497301187479, 1124.9493772780245, 1127.808272593661, 1127.9041281491084, 1128.311729844794, 1128.740389710367, 825.5872063968015, 826.6486743134204, 826.7147833997261, 827.3587969323762, 828.4780588229437, 20018.199272029102, 20136.79863201364, 20351.084201210982, 20875.5824883503, 20895.895520522452, 21699.891500542555, 22170.11319547216, 22266.220682276205, 22339.106435742713, 22406.551868962528, 16722.16389180536, 16906.40827571029, 16956.660866782597, 17123.31506739729, 17140.914295428443, 3659.14010207601, 3667.651573100551, 3677.8161091945562, 3687.1335236219466, 3687.985803903921, 128696.0, 129595.0, 129790.0, 130212.0, 131539.34230328884, 17006.0, 17139.1303481993, 17340.65318693619, 17380.0, 17540.473785786446, 30748.231294217378, 30761.384772304427, 31793.205169870937, 31924.0, 32125.357492850013, 7589.316961473494, 8516.148385161558, 8615.526146062026, 8670.479771213748, 9289.953550232205, 4201.390798334285, 4327.459067616548, 4333.566643335641, 4337.804798784062, 4337.956620433818, 5079.517445842639, 5157.226416037624, 5163.612729045337, 5165.535101840853, 5181.248718935733, 1013.9290249682451, 1034.6895931220604, 1035.502958579886, 1044.4882007816268, 1045.8012977534397, 690.2372877969771, 699.800556841308, 708.125465050662, 710.6979533698261, 711.7686751805684, 11448.54205831774, 12200.206986545845, 12215.633530994084, 13002.479900803863, 13204.0, 678.396227357652, 681.2200030964617, 683.8666460040245, 691.339770519163, 699.1121275979477, 5728.656280623176, 5860.501857342174, 5862.941370586324, 5882.117682347682, 5976.043832986701, 110496.4475177619, 112879.4356028231, 113349.0, 114521.0, 116352.41823790997, 98357.50821245847, 99441.50279248557, 99448.0, 100036.99963000277, 104276.47861760795, 85079.14920850836, 85822.0, 85996.57001715076, 86498.0, 89523.55238223898, 10640.616719826374, 10744.83882741775, 10790.504356166522, 10852.348859068481, 11020.724481888017, 40277.79861100676, 40774.1845163101, 40816.79591602023, 41054.79472602618, 41274.58725412707, 52688.0, 52769.47230527799, 53026.469735302155, 54001.72999134979, 54045.72977135247, 15461.226938653248, 15531.145786981824, 15726.0, 15767.132807695687, 15808.446704365291, 17337.0, 20044.498887527927, 21103.0, 21240.78759212388, 21359.14563417508, 17409.216585253947, 17664.205110769788, 17675.469735907944, 17696.91151544234, 17783.0, 18867.245310187438, 18956.43130706081, 19052.809471905104, 19081.42755717331, 19125.808741912402, 18147.364842230458, 18163.727544086585, 18475.16861741198, 18582.349617763313, 18718.906405467886, 13835.100718453268, 13854.445822167001, 13895.513657021957, 13950.720985580434, 13956.720865582429, 14395.0, 14426.990110692152, 14460.421583136978, 14478.203698796246, 14481.710365792414], "value": 9267.34745176017, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1506.5000000000002, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [98.0, 110.0, 101.0, 109.0, 109.0, 120.0, 111.0, 100.0, 108.0, 107.0], "value": 107.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 115.0, 150.0, 171.0, 117.0, 143.0, 150.0, 119.0, 171.0, 119.0], "value": 140.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 163.0, 163.0, 163.0, 162.0, 166.0, 164.0, 168.0, 172.0, 165.0], "value": 164.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 77.0, 79.0, 133.0, 75.0, 75.0, 74.0, 86.0, 95.0, 75.0], "value": 84.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 78.0, 126.0, 79.0, 79.0, 78.0, 124.0, 83.0, 80.0, 138.0], "value": 94.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 114.0, 114.0, 117.0, 115.0, 114.0, 113.0, 118.0, 113.0, 114.0], "value": 114.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 151.0, 151.0, 151.0, 150.0, 149.0, 150.0, 150.0, 153.0, 150.0], "value": 150.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 94.0, 94.0, 93.0, 95.0, 95.0, 94.0, 94.0, 94.0, 94.0], "value": 94.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 53.0, 52.0, 53.0, 53.0, 53.0, 54.0, 52.0, 52.0, 54.0], "value": 53.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 54.0, 55.0, 55.0, 55.0, 55.0, 54.0, 55.0, 55.0, 54.0], "value": 54.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 76.0, 76.0, 76.0, 77.0, 75.0, 77.0, 74.0, 76.0], "value": 75.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [123.0, 122.0, 121.0, 129.0, 121.0, 122.0, 127.0, 119.0, 125.0, 156.0], "value": 126.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [173.0, 194.0, 178.0, 173.0, 171.0, 171.0, 174.0, 179.0, 180.0, 174.0], "value": 176.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 67.0, 74.0, 72.0, 66.0, 66.0, 68.0, 69.0, 67.0, 68.0], "value": 69.0, "unit": "score"}]}]} 16:42:59 INFO - Return code: 0 16:42:59 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 16:42:59 INFO - # TBPL SUCCESS # 16:42:59 INFO - Running post-action listener: _package_coverage_data 16:42:59 INFO - Running post-action listener: _resource_record_post_action 16:42:59 INFO - [mozharness: 2017-08-16 23:42:59.644504Z] Finished run-tests step (success) 16:42:59 INFO - Running post-run listener: _resource_record_post_run 16:42:59 INFO - Total resource usage - Wall time: 1192s; CPU: 13.0%; Read bytes: 4096; Write bytes: 433725440; Read time: 12; Write time: 327392 16:42:59 INFO - TinderboxPrint: CPU usage
13.1% 16:42:59 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 16:42:59 INFO - TinderboxPrint: I/O write bytes / time
433,725,440 / 327,392 16:42:59 INFO - TinderboxPrint: CPU idle
8,259.5 (86.9%) 16:42:59 INFO - TinderboxPrint: CPU user
1,196.6 (12.6%) 16:42:59 INFO - TinderboxPrint: Swap in / out
0 / 0 16:42:59 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 106115072; Read time: 0; Write time: 95048 16:42:59 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 16:42:59 INFO - run-tests - Wall time: 1174s; CPU: 13.0%; Read bytes: 0; Write bytes: 327610368; Read time: 0; Write time: 232344 16:43:00 INFO - Running post-run listener: _upload_blobber_files 16:43:00 INFO - Blob upload gear active. 16:43:00 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 16:43:00 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 16:43:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 16:43:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 16:43:00 INFO - (blobuploader) - INFO - Open directory for files ... 16:43:00 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 16:43:00 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:43:00 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:43:01 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 16:43:01 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:43:01 INFO - (blobuploader) - INFO - Done attempting. 16:43:01 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 16:43:01 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:43:01 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:43:02 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 16:43:02 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:43:02 INFO - (blobuploader) - INFO - Done attempting. 16:43:02 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 16:43:02 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:43:02 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:43:03 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 16:43:03 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:43:03 INFO - (blobuploader) - INFO - Done attempting. 16:43:03 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 16:43:03 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:43:03 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:43:10 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 16:43:10 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:43:10 INFO - (blobuploader) - INFO - Done attempting. 16:43:10 INFO - (blobuploader) - INFO - Iteration through files over. 16:43:10 INFO - Return code: 0 16:43:10 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 16:43:10 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 16:43:10 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/a02585d20a18dc4c03a9b4378c8fe8d174dc820d150e13244563b3b28b29a697c2191d5d02d4fef5f8e4d3228ffc9d7f1061e6e8e3bc4402e238a300c6229196", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/25730b4b35d80843526626d1a942e6311813b732e5170d59beeefb78b23894a90e4e63218d4f33194080c8728286bb3bad2df1ddaa73603458078840471e5bb0", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/72c76380ba6078b249002c0f93f62ae316d90fa9846287068b4cb28da621181462cf85c4247a1d5589b74c0f98fb53571a90c4c2807f3a325b5e886b62dff141", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/0c6fc701915234c5a17db96dc4fbd6c2aa5f6c0d8aa288c1ae30f4245b3ec7dfe61c3406537408874ba9f099c611faf015d58bbb62be2a0278883d4e406e07b8"} 16:43:10 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 16:43:10 INFO - Writing to file /builds/slave/test/properties/blobber_files 16:43:10 INFO - Contents: 16:43:10 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/a02585d20a18dc4c03a9b4378c8fe8d174dc820d150e13244563b3b28b29a697c2191d5d02d4fef5f8e4d3228ffc9d7f1061e6e8e3bc4402e238a300c6229196", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/25730b4b35d80843526626d1a942e6311813b732e5170d59beeefb78b23894a90e4e63218d4f33194080c8728286bb3bad2df1ddaa73603458078840471e5bb0", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/72c76380ba6078b249002c0f93f62ae316d90fa9846287068b4cb28da621181462cf85c4247a1d5589b74c0f98fb53571a90c4c2807f3a325b5e886b62dff141", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/0c6fc701915234c5a17db96dc4fbd6c2aa5f6c0d8aa288c1ae30f4245b3ec7dfe61c3406537408874ba9f099c611faf015d58bbb62be2a0278883d4e406e07b8"} 16:43:10 INFO - Running post-run listener: copy_logs_to_upload_dir 16:43:10 INFO - Copying logs to upload dir... 16:43:10 INFO - mkdir: /builds/slave/test/build/upload/logs 16:43:10 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1253.894216 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 53 secs) (at 2017-08-16 16:43:10.529164) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-08-16 16:43:10.532993) ========= 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=523ca41ca1e0623de333ad52000001bf-1502925520.224882-423439349 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/a02585d20a18dc4c03a9b4378c8fe8d174dc820d150e13244563b3b28b29a697c2191d5d02d4fef5f8e4d3228ffc9d7f1061e6e8e3bc4402e238a300c6229196", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/25730b4b35d80843526626d1a942e6311813b732e5170d59beeefb78b23894a90e4e63218d4f33194080c8728286bb3bad2df1ddaa73603458078840471e5bb0", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/72c76380ba6078b249002c0f93f62ae316d90fa9846287068b4cb28da621181462cf85c4247a1d5589b74c0f98fb53571a90c4c2807f3a325b5e886b62dff141", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/0c6fc701915234c5a17db96dc4fbd6c2aa5f6c0d8aa288c1ae30f4245b3ec7dfe61c3406537408874ba9f099c611faf015d58bbb62be2a0278883d4e406e07b8"} build_url:https://queue.taskcluster.net/v1/task/MwNIxikqQeW7ZnNry6c34A/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011405 build_url: 'https://queue.taskcluster.net/v1/task/MwNIxikqQeW7ZnNry6c34A/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/a02585d20a18dc4c03a9b4378c8fe8d174dc820d150e13244563b3b28b29a697c2191d5d02d4fef5f8e4d3228ffc9d7f1061e6e8e3bc4402e238a300c6229196", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/25730b4b35d80843526626d1a942e6311813b732e5170d59beeefb78b23894a90e4e63218d4f33194080c8728286bb3bad2df1ddaa73603458078840471e5bb0", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/72c76380ba6078b249002c0f93f62ae316d90fa9846287068b4cb28da621181462cf85c4247a1d5589b74c0f98fb53571a90c4c2807f3a325b5e886b62dff141", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/0c6fc701915234c5a17db96dc4fbd6c2aa5f6c0d8aa288c1ae30f4245b3ec7dfe61c3406537408874ba9f099c611faf015d58bbb62be2a0278883d4e406e07b8"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-08-16 16:43:10.567027) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-08-16 16:43:10.567605) ========= 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=523ca41ca1e0623de333ad52000001bf-1502925520.224882-423439349 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004697 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-08-16 16:43:10.653308) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-08-16 16:43:10.653873) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-08-16 16:43:10.654450) ========= ========= Total master_lag: 0.21 =========